builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-014 starttime: 1452723394.09 results: success (0) buildid: 20160113113007 builduid: 94f0a886f0004049bf7187c264f4ba09 revision: eb7c34221195743f6e6e86b36d917d050f3f2b56 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 14:16:34.090355) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 14:16:34.090783) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 14:16:34.091173) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1452722873.394500-2134549360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006490 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 14:16:34.116358) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 14:16:34.116638) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 14:16:34.130132) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 14:16:34.130392) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1452722873.394500-2134549360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004683 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 14:16:34.179170) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 14:16:34.179435) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 14:16:34.179819) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 14:16:34.180130) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1452722873.394500-2134549360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 14:16:34-- 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% 33.7M=0s 2016-01-13 14:16:34 (33.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156492 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 14:16:34.348672) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 14:16:34.348958) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1452722873.394500-2134549360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022689 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 14:16:34.397909) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 14:16:34.398226) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev eb7c34221195743f6e6e86b36d917d050f3f2b56 --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 eb7c34221195743f6e6e86b36d917d050f3f2b56 --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=fa9c93d544b966bd2b8d485a000001c6-1452722873.394500-2134549360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 14:16:34,592 truncating revision to first 12 chars 2016-01-13 14:16:34,592 Setting DEBUG logging. 2016-01-13 14:16:34,592 attempt 1/10 2016-01-13 14:16:34,592 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/eb7c34221195?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 14:16:34,831 unpacking tar archive at: fx-team-eb7c34221195/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571113 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 14:16:34.982218) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 14:16:34.982524) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 14:16:34.993317) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 14:16:34.993596) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 14:16:34.994151) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-13 14:16:34.994462) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa9c93d544b966bd2b8d485a000001c6-1452722873.394500-2134549360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:16:35 INFO - MultiFileLogger online at 20160113 14:16:35 in /builds/slave/test-pgo 14:16:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:16:35 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:16:35 INFO - {'append_to_log': False, 14:16:35 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:16:35 INFO - 'blob_upload_branch': 'Fx-Team', 14:16:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:16:35 INFO - 'branch': 'Fx-Team', 14:16:35 INFO - 'buildbot_json_path': 'buildprops.json', 14:16:35 INFO - 'config_files': ('talos/linux_config.py',), 14:16:35 INFO - 'default_actions': ('clobber', 14:16:35 INFO - 'read-buildbot-config', 14:16:35 INFO - 'download-and-extract', 14:16:35 INFO - 'populate-webroot', 14:16:35 INFO - 'create-virtualenv', 14:16:35 INFO - 'install', 14:16:35 INFO - 'run-tests'), 14:16:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:16:35 INFO - 'download_minidump_stackwalk': True, 14:16:35 INFO - 'download_symbols': 'ondemand', 14:16:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:16:35 INFO - 'tooltool.py': '/tools/tooltool.py', 14:16:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:16:35 INFO - '/tools/misc-python/virtualenv.py')}, 14:16:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:16:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:16:35 INFO - 'installer_path': 'installer.exe', 14:16:35 INFO - 'log_level': 'info', 14:16:35 INFO - 'log_name': 'talos', 14:16:35 INFO - 'log_to_console': True, 14:16:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:16:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:16:35 INFO - 'opt_config_files': (), 14:16:35 INFO - 'pip_index': False, 14:16:35 INFO - 'sps_profile': False, 14:16:35 INFO - 'sps_profile_interval': 0, 14:16:35 INFO - 'suite': 'dromaeojs-e10s', 14:16:35 INFO - 'system_bits': '32', 14:16:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:16:35 INFO - 'title': 'talos-linux64-ix-014', 14:16:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:16:35 INFO - 'use_talos_json': True, 14:16:35 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:16:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:16:35 INFO - 'work_dir': 'build'} 14:16:35 INFO - ##### 14:16:35 INFO - ##### Running clobber step. 14:16:35 INFO - ##### 14:16:35 INFO - Running pre-action listener: _resource_record_pre_action 14:16:35 INFO - Running main action method: clobber 14:16:35 INFO - rmtree: /builds/slave/test-pgo/build 14:16:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:16:36 INFO - Running post-action listener: _resource_record_post_action 14:16:36 INFO - ##### 14:16:36 INFO - ##### Running read-buildbot-config step. 14:16:36 INFO - ##### 14:16:36 INFO - Running pre-action listener: _resource_record_pre_action 14:16:36 INFO - Running main action method: read_buildbot_config 14:16:36 INFO - Using buildbot properties: 14:16:36 INFO - { 14:16:36 INFO - "project": "", 14:16:36 INFO - "product": "firefox", 14:16:36 INFO - "script_repo_revision": "production", 14:16:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:16:36 INFO - "repository": "", 14:16:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:16:36 INFO - "buildid": "20160113113007", 14:16:36 INFO - "pgo_build": "True", 14:16:36 INFO - "basedir": "/builds/slave/test-pgo", 14:16:36 INFO - "buildnumber": 201, 14:16:36 INFO - "slavename": "talos-linux64-ix-014", 14:16:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:16:36 INFO - "platform": "ubuntu64_hw", 14:16:36 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:16:36 INFO - "branch": "fx-team", 14:16:36 INFO - "repo_path": "integration/fx-team", 14:16:36 INFO - "revision": "eb7c34221195743f6e6e86b36d917d050f3f2b56", 14:16:36 INFO - "stage_platform": "linux64-pgo", 14:16:36 INFO - "builduid": "94f0a886f0004049bf7187c264f4ba09", 14:16:36 INFO - "slavebuilddir": "test" 14:16:36 INFO - } 14:16:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/PjFhipT1RyOLTqkYSkX4MA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 14:16:36 INFO - Running post-action listener: _resource_record_post_action 14:16:36 INFO - ##### 14:16:36 INFO - ##### Running download-and-extract step. 14:16:36 INFO - ##### 14:16:36 INFO - Running pre-action listener: _resource_record_pre_action 14:16:36 INFO - Running main action method: download_and_extract 14:16:36 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:36 INFO - https://queue.taskcluster.net/v1/task/PjFhipT1RyOLTqkYSkX4MA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:16:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjFhipT1RyOLTqkYSkX4MA/artifacts/public/build/test_packages.json 14:16:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjFhipT1RyOLTqkYSkX4MA/artifacts/public/build/test_packages.json 14:16:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjFhipT1RyOLTqkYSkX4MA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:16:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjFhipT1RyOLTqkYSkX4MA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:16:37 INFO - Downloaded 1448 bytes. 14:16:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:16:37 INFO - Using the following test package requirements: 14:16:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:16:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:16:37 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:16:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:37 INFO - u'jsshell-linux-x86_64.zip'], 14:16:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:16:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:16:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:16:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:16:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:16:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:16:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:16:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:16:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:16: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')]} 14:16:37 INFO - https://queue.taskcluster.net/v1/task/PjFhipT1RyOLTqkYSkX4MA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:16:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjFhipT1RyOLTqkYSkX4MA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:16:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjFhipT1RyOLTqkYSkX4MA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:16:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjFhipT1RyOLTqkYSkX4MA/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 14:16:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjFhipT1RyOLTqkYSkX4MA/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 14:16:39 INFO - Downloaded 24030637 bytes. 14:16:39 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 14:16:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:16:39 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 14:16:40 INFO - Return code: 0 14:16:40 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 14:16:40 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')]} 14:16:40 INFO - https://queue.taskcluster.net/v1/task/PjFhipT1RyOLTqkYSkX4MA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:16:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjFhipT1RyOLTqkYSkX4MA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:16:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjFhipT1RyOLTqkYSkX4MA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:16:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjFhipT1RyOLTqkYSkX4MA/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 14:16:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjFhipT1RyOLTqkYSkX4MA/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 14:16:43 INFO - Downloaded 24030637 bytes. 14:16:43 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 14:16:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:16:43 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 14:16:44 INFO - Return code: 0 14:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:44 INFO - https://queue.taskcluster.net/v1/task/PjFhipT1RyOLTqkYSkX4MA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:16:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjFhipT1RyOLTqkYSkX4MA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:16:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjFhipT1RyOLTqkYSkX4MA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:16:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjFhipT1RyOLTqkYSkX4MA/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 14:16:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjFhipT1RyOLTqkYSkX4MA/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 14:16:46 INFO - Downloaded 11132279 bytes. 14:16:46 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 14:16:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:16:46 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 14:16:46 INFO - Return code: 0 14:16:46 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')]} 14:16:46 INFO - https://queue.taskcluster.net/v1/task/PjFhipT1RyOLTqkYSkX4MA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:16:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjFhipT1RyOLTqkYSkX4MA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:16:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjFhipT1RyOLTqkYSkX4MA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:16:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjFhipT1RyOLTqkYSkX4MA/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 14:16:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjFhipT1RyOLTqkYSkX4MA/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 14:16:53 INFO - Downloaded 55919789 bytes. 14:16:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PjFhipT1RyOLTqkYSkX4MA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:16:53 INFO - mkdir: /builds/slave/test-pgo/properties 14:16:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:16:53 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:16:53 INFO - Contents: 14:16:53 INFO - build_url:https://queue.taskcluster.net/v1/task/PjFhipT1RyOLTqkYSkX4MA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:16:53 INFO - Running post-action listener: _resource_record_post_action 14:16:53 INFO - Running post-action listener: set_extra_try_arguments 14:16:53 INFO - ##### 14:16:53 INFO - ##### Running populate-webroot step. 14:16:53 INFO - ##### 14:16:53 INFO - Running pre-action listener: _resource_record_pre_action 14:16:53 INFO - Running main action method: populate_webroot 14:16:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:16:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:16:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:16:53 INFO - '--tppagecycles', 14:16:53 INFO - '7'], 14:16:53 INFO - 'tests': ['tsvgm']}}, 14:16:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:16:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:16:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:16:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:16:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:16:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:16:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:16:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:53 INFO - 'talos_options': ['--e10s'], 14:16:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:16:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:53 INFO - 'tests': ['damp', 'tps']}, 14:16:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:53 INFO - 'talos_options': ['--e10s'], 14:16:53 INFO - 'tests': ['damp', 'tps']}, 14:16:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:16:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:16:53 INFO - 'other': {'tests': ['a11yr', 14:16:53 INFO - 'ts_paint', 14:16:53 INFO - 'tpaint', 14:16:53 INFO - 'sessionrestore', 14:16:53 INFO - 'sessionrestore_no_auto_restore']}, 14:16:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:16:53 INFO - 'tests': ['a11yr', 14:16:53 INFO - 'ts_paint', 14:16:53 INFO - 'tpaint', 14:16:53 INFO - 'sessionrestore', 14:16:53 INFO - 'sessionrestore_no_auto_restore']}, 14:16:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:16:53 INFO - 'tests': ['a11yr', 14:16:53 INFO - 'ts_paint', 14:16:53 INFO - 'tpaint', 14:16:53 INFO - 'sessionrestore', 14:16:53 INFO - 'sessionrestore_no_auto_restore']}, 14:16:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:16:53 INFO - 'tests': ['a11yr', 14:16:53 INFO - 'ts_paint', 14:16:53 INFO - 'tpaint', 14:16:53 INFO - 'sessionrestore', 14:16:53 INFO - 'sessionrestore_no_auto_restore']}, 14:16:53 INFO - 'other_l64': {'tests': ['a11yr', 14:16:53 INFO - 'ts_paint', 14:16:53 INFO - 'tpaint', 14:16:53 INFO - 'sessionrestore', 14:16:53 INFO - 'sessionrestore_no_auto_restore']}, 14:16:53 INFO - 'other_nol64': {'tests': ['a11yr', 14:16:53 INFO - 'ts_paint', 14:16:53 INFO - 'tpaint', 14:16:53 INFO - 'sessionrestore', 14:16:53 INFO - 'sessionrestore_no_auto_restore']}, 14:16:53 INFO - 'svgr': {'tests': ['tsvgx', 14:16:53 INFO - 'tsvgr_opacity', 14:16:53 INFO - 'tart', 14:16:53 INFO - 'tscrollx', 14:16:53 INFO - 'cart']}, 14:16:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:16:53 INFO - 'tests': ['tsvgx', 14:16:53 INFO - 'tsvgr_opacity', 14:16:53 INFO - 'tart', 14:16:53 INFO - 'tscrollx', 14:16:53 INFO - 'cart']}, 14:16:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:53 INFO - 'tests': ['tp5o']}, 14:16:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:53 INFO - 'talos_options': ['--e10s'], 14:16:53 INFO - 'tests': ['tp5o']}, 14:16:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:53 INFO - 'talos_options': ['--xperf_path', 14:16:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:16:53 INFO - 'tests': ['tp5n']}, 14:16:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:53 INFO - 'talos_options': ['--e10s', 14:16:53 INFO - '--xperf_path', 14:16:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:16:53 INFO - 'tests': ['tp5n']}}, 14:16:53 INFO - 'talos.zip': {'path': '', 14:16:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:16:53 INFO - Running post-action listener: _resource_record_post_action 14:16:53 INFO - ##### 14:16:53 INFO - ##### Running create-virtualenv step. 14:16:53 INFO - ##### 14:16:53 INFO - Running pre-action listener: _resource_record_pre_action 14:16:53 INFO - Running main action method: create_virtualenv 14:16:53 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:16:53 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 14:16:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:16:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:16:53 INFO - Using real prefix '/usr' 14:16:53 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:16:53 INFO - Installing distribute.............................................................................................................................................................................................done. 14:16:55 INFO - Installing pip.................done. 14:16:55 INFO - Return code: 0 14:16:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:16:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:55 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 0x7f799ced1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f840>, '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 0x1dbc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbcb60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452722873.394500-2134549360', '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 14:16:55 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 14:16:55 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 14:16:55 INFO - Using env: {'DISPLAY': ':0', 14:16:55 INFO - 'HOME': '/home/cltbld', 14:16:55 INFO - 'LANG': 'en_US.UTF-8', 14:16:55 INFO - 'LANGUAGE': 'en_US:en', 14:16:55 INFO - 'LOGNAME': 'cltbld', 14:16:55 INFO - 'MAIL': '/var/mail/cltbld', 14:16:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:55 INFO - 'MOZ_NO_REMOTE': '1', 14:16:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:55 INFO - 'NO_EM_RESTART': '1', 14:16:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:16:55 INFO - 'PWD': '/builds/slave/test-pgo', 14:16:55 INFO - 'SHELL': '/bin/bash', 14:16:55 INFO - 'SHLVL': '1', 14:16:55 INFO - 'TERM': 'linux', 14:16:55 INFO - 'TMOUT': '86400', 14:16:55 INFO - 'USER': 'cltbld', 14:16:55 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452722873.394500-2134549360', 14:16:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:55 INFO - '_': '/tools/buildbot/bin/python'} 14:16:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:56 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 14:16:56 INFO - Cleaning up... 14:16:56 INFO - Return code: 0 14:16:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f799ced1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f840>, '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 0x1dbc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbcb60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452722873.394500-2134549360', '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 14:16:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 14:16:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:16:56 INFO - Using env: {'DISPLAY': ':0', 14:16:56 INFO - 'HOME': '/home/cltbld', 14:16:56 INFO - 'LANG': 'en_US.UTF-8', 14:16:56 INFO - 'LANGUAGE': 'en_US:en', 14:16:56 INFO - 'LOGNAME': 'cltbld', 14:16:56 INFO - 'MAIL': '/var/mail/cltbld', 14:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:56 INFO - 'MOZ_NO_REMOTE': '1', 14:16:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:56 INFO - 'NO_EM_RESTART': '1', 14:16:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:16:56 INFO - 'PWD': '/builds/slave/test-pgo', 14:16:56 INFO - 'SHELL': '/bin/bash', 14:16:56 INFO - 'SHLVL': '1', 14:16:56 INFO - 'TERM': 'linux', 14:16:56 INFO - 'TMOUT': '86400', 14:16:56 INFO - 'USER': 'cltbld', 14:16:56 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452722873.394500-2134549360', 14:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:56 INFO - '_': '/tools/buildbot/bin/python'} 14:16:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:56 INFO - Downloading/unpacking psutil>=0.7.1 14:16:56 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 14:16:56 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 14:16:56 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 14:16:56 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 14:16:56 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 14:16:56 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 14:16:58 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 14:16:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:16:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:16:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:16:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:16:59 INFO - Installing collected packages: psutil 14:16:59 INFO - Running setup.py install for psutil 14:16:59 INFO - building 'psutil._psutil_linux' extension 14:16:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:16:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:16:59 INFO - building 'psutil._psutil_posix' extension 14:16:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:16:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:16:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:16:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:16:59 INFO - Successfully installed psutil 14:16:59 INFO - Cleaning up... 14:16:59 INFO - Return code: 0 14:16:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f799ced1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f840>, '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 0x1dbc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbcb60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452722873.394500-2134549360', '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 14:16:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 14:16:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:16:59 INFO - Using env: {'DISPLAY': ':0', 14:16:59 INFO - 'HOME': '/home/cltbld', 14:16:59 INFO - 'LANG': 'en_US.UTF-8', 14:16:59 INFO - 'LANGUAGE': 'en_US:en', 14:16:59 INFO - 'LOGNAME': 'cltbld', 14:16:59 INFO - 'MAIL': '/var/mail/cltbld', 14:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:59 INFO - 'MOZ_NO_REMOTE': '1', 14:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:16:59 INFO - 'NO_EM_RESTART': '1', 14:16:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:16:59 INFO - 'PWD': '/builds/slave/test-pgo', 14:16:59 INFO - 'SHELL': '/bin/bash', 14:16:59 INFO - 'SHLVL': '1', 14:16:59 INFO - 'TERM': 'linux', 14:16:59 INFO - 'TMOUT': '86400', 14:16:59 INFO - 'USER': 'cltbld', 14:16:59 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452722873.394500-2134549360', 14:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:59 INFO - '_': '/tools/buildbot/bin/python'} 14:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:16:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:16:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:17:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:17:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:17:01 INFO - Installing collected packages: mozsystemmonitor 14:17:01 INFO - Running setup.py install for mozsystemmonitor 14:17:01 INFO - Successfully installed mozsystemmonitor 14:17:01 INFO - Cleaning up... 14:17:01 INFO - Return code: 0 14:17:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f799ced1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f840>, '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 0x1dbc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbcb60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452722873.394500-2134549360', '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 14:17:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 14:17:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:17:01 INFO - Using env: {'DISPLAY': ':0', 14:17:01 INFO - 'HOME': '/home/cltbld', 14:17:01 INFO - 'LANG': 'en_US.UTF-8', 14:17:01 INFO - 'LANGUAGE': 'en_US:en', 14:17:01 INFO - 'LOGNAME': 'cltbld', 14:17:01 INFO - 'MAIL': '/var/mail/cltbld', 14:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:01 INFO - 'MOZ_NO_REMOTE': '1', 14:17:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:01 INFO - 'NO_EM_RESTART': '1', 14:17:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:01 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:01 INFO - 'SHELL': '/bin/bash', 14:17:01 INFO - 'SHLVL': '1', 14:17:01 INFO - 'TERM': 'linux', 14:17:01 INFO - 'TMOUT': '86400', 14:17:01 INFO - 'USER': 'cltbld', 14:17:01 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452722873.394500-2134549360', 14:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:01 INFO - '_': '/tools/buildbot/bin/python'} 14:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:01 INFO - Downloading/unpacking blobuploader==1.2.4 14:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:03 INFO - Downloading blobuploader-1.2.4.tar.gz 14:17:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:17:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:17:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:17:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:17:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:04 INFO - Downloading docopt-0.6.1.tar.gz 14:17:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:17:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:17:04 INFO - Installing collected packages: blobuploader, requests, docopt 14:17:04 INFO - Running setup.py install for blobuploader 14:17:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:17:04 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:17:04 INFO - Running setup.py install for requests 14:17:04 INFO - Running setup.py install for docopt 14:17:04 INFO - Successfully installed blobuploader requests docopt 14:17:04 INFO - Cleaning up... 14:17:05 INFO - Return code: 0 14:17:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f799ced1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f840>, '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 0x1dbc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbcb60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452722873.394500-2134549360', '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 14:17:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:17:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:17:05 INFO - Using env: {'DISPLAY': ':0', 14:17:05 INFO - 'HOME': '/home/cltbld', 14:17:05 INFO - 'LANG': 'en_US.UTF-8', 14:17:05 INFO - 'LANGUAGE': 'en_US:en', 14:17:05 INFO - 'LOGNAME': 'cltbld', 14:17:05 INFO - 'MAIL': '/var/mail/cltbld', 14:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:05 INFO - 'MOZ_NO_REMOTE': '1', 14:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:05 INFO - 'NO_EM_RESTART': '1', 14:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:05 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:05 INFO - 'SHELL': '/bin/bash', 14:17:05 INFO - 'SHLVL': '1', 14:17:05 INFO - 'TERM': 'linux', 14:17:05 INFO - 'TMOUT': '86400', 14:17:05 INFO - 'USER': 'cltbld', 14:17:05 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452722873.394500-2134549360', 14:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:05 INFO - '_': '/tools/buildbot/bin/python'} 14:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:17:05 INFO - Running setup.py (path:/tmp/pip-j0LqNv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:17:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:17:05 INFO - Running setup.py (path:/tmp/pip-rOEknO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:17:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:17:05 INFO - Running setup.py (path:/tmp/pip-Ms62n1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:17:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:17:05 INFO - Running setup.py (path:/tmp/pip-z8Nufy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:17:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:17:05 INFO - Running setup.py (path:/tmp/pip-p4euob-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:17:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:17:05 INFO - Running setup.py (path:/tmp/pip-cfIpu_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:17:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:17:05 INFO - Running setup.py (path:/tmp/pip-nDK_cc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:17:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:17:05 INFO - Running setup.py (path:/tmp/pip-HueRTi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:17:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:17:05 INFO - Running setup.py (path:/tmp/pip-cuyVUf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:17:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:17:05 INFO - Running setup.py (path:/tmp/pip-aX4kob-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:17:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:17:05 INFO - Running setup.py (path:/tmp/pip-LgbUMd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:17:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:17:06 INFO - Running setup.py (path:/tmp/pip-aQxhU6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:17:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:17:06 INFO - Running setup.py (path:/tmp/pip-Ct4uRa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:17:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:17:06 INFO - Running setup.py (path:/tmp/pip-aMN38R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:17:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:17:06 INFO - Running setup.py (path:/tmp/pip-B2GP6i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:17:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:17:06 INFO - Running setup.py (path:/tmp/pip-69wmZ_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:17:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:17:06 INFO - Running setup.py (path:/tmp/pip-fKvK8G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:17:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:17:06 INFO - Running setup.py install for manifestparser 14:17:06 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:17:06 INFO - Running setup.py install for mozcrash 14:17:06 INFO - Running setup.py install for mozdebug 14:17:06 INFO - Running setup.py install for mozdevice 14:17:06 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:17:06 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:17:06 INFO - Running setup.py install for mozfile 14:17:06 INFO - Running setup.py install for mozhttpd 14:17:07 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:17:07 INFO - Running setup.py install for mozinfo 14:17:07 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:17:07 INFO - Running setup.py install for mozInstall 14:17:07 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:17:07 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:17:07 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:17:07 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:17:07 INFO - Running setup.py install for mozleak 14:17:07 INFO - Running setup.py install for mozlog 14:17:07 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:17:07 INFO - Running setup.py install for moznetwork 14:17:07 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:17:07 INFO - Running setup.py install for mozprocess 14:17:07 INFO - Running setup.py install for mozprofile 14:17:07 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:17:07 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:17:07 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:17:07 INFO - Running setup.py install for mozrunner 14:17:07 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:17:07 INFO - Running setup.py install for mozscreenshot 14:17:08 INFO - Running setup.py install for moztest 14:17:08 INFO - Running setup.py install for mozversion 14:17:08 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:17:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:17:08 INFO - Cleaning up... 14:17:08 INFO - Return code: 0 14:17:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f799ced1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f840>, '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 0x1dbc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbcb60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452722873.394500-2134549360', '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 14:17:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:17:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:17:08 INFO - Using env: {'DISPLAY': ':0', 14:17:08 INFO - 'HOME': '/home/cltbld', 14:17:08 INFO - 'LANG': 'en_US.UTF-8', 14:17:08 INFO - 'LANGUAGE': 'en_US:en', 14:17:08 INFO - 'LOGNAME': 'cltbld', 14:17:08 INFO - 'MAIL': '/var/mail/cltbld', 14:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:08 INFO - 'MOZ_NO_REMOTE': '1', 14:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:08 INFO - 'NO_EM_RESTART': '1', 14:17:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:08 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:08 INFO - 'SHELL': '/bin/bash', 14:17:08 INFO - 'SHLVL': '1', 14:17:08 INFO - 'TERM': 'linux', 14:17:08 INFO - 'TMOUT': '86400', 14:17:08 INFO - 'USER': 'cltbld', 14:17:08 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452722873.394500-2134549360', 14:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:08 INFO - '_': '/tools/buildbot/bin/python'} 14:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:17:08 INFO - Running setup.py (path:/tmp/pip-8OHIpt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:17:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 14:17:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:17:08 INFO - Running setup.py (path:/tmp/pip-p2cATA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:17:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:17:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:17:08 INFO - Running setup.py (path:/tmp/pip-9n9Fej-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:17:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 14:17:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:17:08 INFO - Running setup.py (path:/tmp/pip-GDnMtY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:17:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:17:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:17:08 INFO - Running setup.py (path:/tmp/pip-ihYI8L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:17:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 14:17:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:17:08 INFO - Running setup.py (path:/tmp/pip-BG7e1m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:17:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 14:17:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:17:08 INFO - Running setup.py (path:/tmp/pip-mEeBGm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:17:08 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)) 14:17:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:17:08 INFO - Running setup.py (path:/tmp/pip-31J_Bz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:17:09 INFO - Running setup.py (path:/tmp/pip-mdW4UE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:17:09 INFO - Running setup.py (path:/tmp/pip-vM_0ZO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:17:09 INFO - Running setup.py (path:/tmp/pip-FEcyrr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:17:09 INFO - Running setup.py (path:/tmp/pip-S6dz9d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:17:09 INFO - Running setup.py (path:/tmp/pip-UWuNl0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:17:09 INFO - Running setup.py (path:/tmp/pip-csUuiR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:17:09 INFO - Running setup.py (path:/tmp/pip-UifE_C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:17:09 INFO - Running setup.py (path:/tmp/pip-03PoN1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:17:09 INFO - Running setup.py (path:/tmp/pip-Zgpzd3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 14:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 14:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:17:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:17:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:11 INFO - Downloading blessings-1.5.1.tar.gz 14:17:11 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 14:17:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:17:11 INFO - Installing collected packages: blessings 14:17:11 INFO - Running setup.py install for blessings 14:17:11 INFO - Successfully installed blessings 14:17:11 INFO - Cleaning up... 14:17:11 INFO - Return code: 0 14:17:11 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:17:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:17:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:17:11 INFO - Reading from file tmpfile_stdout 14:17:11 INFO - Current package versions: 14:17:11 INFO - argparse == 1.2.1 14:17:11 INFO - blessings == 1.5.1 14:17:11 INFO - blobuploader == 1.2.4 14:17:11 INFO - docopt == 0.6.1 14:17:11 INFO - manifestparser == 1.1 14:17:11 INFO - mozInstall == 1.12 14:17:11 INFO - mozcrash == 0.16 14:17:11 INFO - mozdebug == 0.1 14:17:11 INFO - mozdevice == 0.48 14:17:11 INFO - mozfile == 1.2 14:17:11 INFO - mozhttpd == 0.7 14:17:11 INFO - mozinfo == 0.9 14:17:11 INFO - mozleak == 0.1 14:17:11 INFO - mozlog == 3.1 14:17:11 INFO - moznetwork == 0.27 14:17:11 INFO - mozprocess == 0.22 14:17:11 INFO - mozprofile == 0.28 14:17:11 INFO - mozrunner == 6.11 14:17:11 INFO - mozscreenshot == 0.1 14:17:11 INFO - mozsystemmonitor == 0.0 14:17:11 INFO - moztest == 0.7 14:17:11 INFO - mozversion == 1.4 14:17:11 INFO - psutil == 3.1.1 14:17:11 INFO - requests == 1.2.3 14:17:11 INFO - wsgiref == 0.1.2 14:17:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:17:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f799ced1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f840>, '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 0x1dbc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbcb60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452722873.394500-2134549360', '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 14:17:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 14:17:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:17:11 INFO - Using env: {'DISPLAY': ':0', 14:17:11 INFO - 'HOME': '/home/cltbld', 14:17:11 INFO - 'LANG': 'en_US.UTF-8', 14:17:11 INFO - 'LANGUAGE': 'en_US:en', 14:17:11 INFO - 'LOGNAME': 'cltbld', 14:17:11 INFO - 'MAIL': '/var/mail/cltbld', 14:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:11 INFO - 'MOZ_NO_REMOTE': '1', 14:17:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:11 INFO - 'NO_EM_RESTART': '1', 14:17:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:11 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:11 INFO - 'SHELL': '/bin/bash', 14:17:11 INFO - 'SHLVL': '1', 14:17:11 INFO - 'TERM': 'linux', 14:17:11 INFO - 'TMOUT': '86400', 14:17:11 INFO - 'USER': 'cltbld', 14:17:11 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452722873.394500-2134549360', 14:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:11 INFO - '_': '/tools/buildbot/bin/python'} 14:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 14:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 14:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 14:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 14:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 14:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 14:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 14:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 14:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 14:17:12 INFO - Cleaning up... 14:17:12 INFO - Return code: 0 14:17:12 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f799ced1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f840>, '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 0x1dbc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbcb60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452722873.394500-2134549360', '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 14:17:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 14:17:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:17:12 INFO - Using env: {'DISPLAY': ':0', 14:17:12 INFO - 'HOME': '/home/cltbld', 14:17:12 INFO - 'LANG': 'en_US.UTF-8', 14:17:12 INFO - 'LANGUAGE': 'en_US:en', 14:17:12 INFO - 'LOGNAME': 'cltbld', 14:17:12 INFO - 'MAIL': '/var/mail/cltbld', 14:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:12 INFO - 'MOZ_NO_REMOTE': '1', 14:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:12 INFO - 'NO_EM_RESTART': '1', 14:17:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:12 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:12 INFO - 'SHELL': '/bin/bash', 14:17:12 INFO - 'SHLVL': '1', 14:17:12 INFO - 'TERM': 'linux', 14:17:12 INFO - 'TMOUT': '86400', 14:17:12 INFO - 'USER': 'cltbld', 14:17:12 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452722873.394500-2134549360', 14:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:12 INFO - '_': '/tools/buildbot/bin/python'} 14:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:12 INFO - Downloading/unpacking jsonschema 14:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:17:14 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 14:17:14 INFO - Downloading/unpacking functools32 (from jsonschema) 14:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:14 INFO - Downloading functools32-3.2.3-2.tar.gz 14:17:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:17:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:17:14 INFO - warning: no files found matching '*.txt' 14:17:14 INFO - no previously-included directories found matching 'build' 14:17:14 INFO - no previously-included directories found matching 'dist' 14:17:14 INFO - no previously-included directories found matching '.git*' 14:17:14 INFO - Installing collected packages: jsonschema, functools32 14:17:14 INFO - Running setup.py install for functools32 14:17:14 INFO - warning: no files found matching '*.txt' 14:17:14 INFO - no previously-included directories found matching 'build' 14:17:14 INFO - no previously-included directories found matching 'dist' 14:17:14 INFO - no previously-included directories found matching '.git*' 14:17:14 INFO - Successfully installed jsonschema functools32 14:17:14 INFO - Cleaning up... 14:17:14 INFO - Return code: 0 14:17:14 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:17:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f799ced1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbe630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f840>, '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 0x1dbc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbcb60>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1452722873.394500-2134549360', '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 14:17:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 14:17:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:17:14 INFO - Using env: {'DISPLAY': ':0', 14:17:14 INFO - 'HOME': '/home/cltbld', 14:17:14 INFO - 'LANG': 'en_US.UTF-8', 14:17:14 INFO - 'LANGUAGE': 'en_US:en', 14:17:14 INFO - 'LOGNAME': 'cltbld', 14:17:14 INFO - 'MAIL': '/var/mail/cltbld', 14:17:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:14 INFO - 'MOZ_NO_REMOTE': '1', 14:17:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:14 INFO - 'NO_EM_RESTART': '1', 14:17:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:14 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:14 INFO - 'SHELL': '/bin/bash', 14:17:14 INFO - 'SHLVL': '1', 14:17:14 INFO - 'TERM': 'linux', 14:17:14 INFO - 'TMOUT': '86400', 14:17:14 INFO - 'USER': 'cltbld', 14:17:14 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452722873.394500-2134549360', 14:17:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:14 INFO - '_': '/tools/buildbot/bin/python'} 14:17:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:14 INFO - Downloading/unpacking flake8 14:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:17:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 14:17:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:17:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 14:17:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 14:17:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:17:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:17:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:17:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:17:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:17:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:17:17 INFO - no previously-included directories found matching 'docs/_build' 14:17:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:17:17 INFO - Running setup.py install for pep8 14:17:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:17:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:17:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:17:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:17:17 INFO - no previously-included directories found matching 'docs/_build' 14:17:17 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:17:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:17:17 INFO - Cleaning up... 14:17:17 INFO - Return code: 0 14:17:17 INFO - Running post-action listener: _resource_record_post_action 14:17:17 INFO - Running post-action listener: _start_resource_monitoring 14:17:17 INFO - Starting resource monitoring. 14:17:17 INFO - ##### 14:17:17 INFO - ##### Running install step. 14:17:17 INFO - ##### 14:17:17 INFO - Running pre-action listener: _resource_record_pre_action 14:17:17 INFO - Running main action method: install 14:17:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:17:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:17:17 INFO - Reading from file tmpfile_stdout 14:17:17 INFO - Detecting whether we're running mozinstall >=1.0... 14:17:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:17:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:17:17 INFO - Reading from file tmpfile_stdout 14:17:17 INFO - Output received: 14:17:17 INFO - Usage: mozinstall [options] installer 14:17:17 INFO - Options: 14:17:17 INFO - -h, --help show this help message and exit 14:17:17 INFO - -d DEST, --destination=DEST 14:17:17 INFO - Directory to install application into. [default: 14:17:17 INFO - "/builds/slave/test-pgo"] 14:17:17 INFO - --app=APP Application being installed. [default: firefox] 14:17:17 INFO - mkdir: /builds/slave/test-pgo/build/application 14:17:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 14:17:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 14:17:33 INFO - Reading from file tmpfile_stdout 14:17:33 INFO - Output received: 14:17:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:17:33 INFO - Running post-action listener: _resource_record_post_action 14:17:33 INFO - ##### 14:17:33 INFO - ##### Running run-tests step. 14:17:33 INFO - ##### 14:17:33 INFO - Running pre-action listener: _resource_record_pre_action 14:17:33 INFO - Running main action method: run_tests 14:17:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:17:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:17:33 INFO - Python 2.7.3 14:17:33 INFO - Return code: 0 14:17:33 INFO - grabbing minidump binary from tooltool 14:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:33 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e4f840>, '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 0x1dbc6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbcb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:17:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 14:17:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:17:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:17:33 INFO - Return code: 0 14:17:33 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:17:33 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:17:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:17:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:17:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:17:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:17:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:17:34 INFO - Return code: 0 14:17:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PjFhipT1RyOLTqkYSkX4MA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-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 14:17:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PjFhipT1RyOLTqkYSkX4MA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:17:34 INFO - Using env: {'DISPLAY': ':0', 14:17:34 INFO - 'HOME': '/home/cltbld', 14:17:34 INFO - 'LANG': 'en_US.UTF-8', 14:17:34 INFO - 'LANGUAGE': 'en_US:en', 14:17:34 INFO - 'LOGNAME': 'cltbld', 14:17:34 INFO - 'MAIL': '/var/mail/cltbld', 14:17:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:17:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:34 INFO - 'MOZ_NO_REMOTE': '1', 14:17:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:34 INFO - 'NO_EM_RESTART': '1', 14:17:34 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:34 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:34 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:17:34 INFO - 'SHELL': '/bin/bash', 14:17:34 INFO - 'SHLVL': '1', 14:17:34 INFO - 'TERM': 'linux', 14:17:34 INFO - 'TMOUT': '86400', 14:17:34 INFO - 'USER': 'cltbld', 14:17:34 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1452722873.394500-2134549360', 14:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:34 INFO - '_': '/tools/buildbot/bin/python'} 14:17:34 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PjFhipT1RyOLTqkYSkX4MA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-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 14:17:34 INFO - mozversion application_buildid: 20160113113007 14:17:34 INFO - mozversion application_changeset: eb7c34221195743f6e6e86b36d917d050f3f2b56 14:17:34 INFO - mozversion application_display_name: Nightly 14:17:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:17:34 INFO - mozversion application_name: Firefox 14:17:34 INFO - mozversion application_remotingname: firefox 14:17:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:17:34 INFO - mozversion application_vendor: Mozilla 14:17:34 INFO - mozversion application_version: 46.0a1 14:17:34 INFO - mozversion platform_buildid: 20160113113007 14:17:34 INFO - mozversion platform_changeset: eb7c34221195743f6e6e86b36d917d050f3f2b56 14:17:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:17:34 INFO - mozversion platform_version: 46.0a1 14:17:34 INFO - using testdate: 1452723454 14:17:34 INFO - actual date: 1452723454 14:17:35 INFO - starting webserver on 'localhost:33997' 14:17:35 INFO - SUITE-START | Running 3 tests 14:17:35 INFO - TEST-START | dromaeo_css 14:17:35 INFO - operating with platform_type : linux_ 14:17:35 INFO - Initialising browser for dromaeo_css test... 14:17:35 INFO - TEST-INFO | started process 8268 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPw15xG/profile http://localhost:33997/getInfo.html) 14:17:38 INFO - PROCESS | 8268 | 14:17:38 INFO - PROCESS | 8268 | (process:8353): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:17:39 INFO - PROCESS | 8268 | __metrics Screen width/height:1600/1200 14:17:39 INFO - PROCESS | 8268 | colorDepth:24 14:17:39 INFO - PROCESS | 8268 | Browser inner width/height: 1024/697 14:17:39 INFO - PROCESS | 8268 | __metrics 14:17:39 INFO - PROCESS | 8268 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:17:40 INFO - TEST-INFO | 8268: exit 0 14:17:40 INFO - Browser initialized. 14:17:40 INFO - Running cycle 1/1 for dromaeo_css test... 14:17:40 INFO - TEST-INFO | started process 8402 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPw15xG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:17:41 INFO - PROCESS | 8402 | 14:17:41 INFO - PROCESS | 8402 | (process:8461): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:17:52 INFO - PROCESS | 8402 | RSS: Main: 150114304 14:17:52 INFO - PROCESS | 8402 | 14:18:41 INFO - PROCESS | 8402 | 1452723521900 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:20:50 INFO - PROCESS | 8402 | Cycle 1(1): loaded http://localhost:33997/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33997/tests/dromaeo/cssquery-ext.html) 14:20:52 INFO - PROCESS | 8402 | RSS: Main: 156921856 14:20:52 INFO - PROCESS | 8402 | 14:23:54 INFO - PROCESS | 8402 | Cycle 1(1): loaded http://localhost:33997/tests/dromaeo/cssquery-ext.html (next: http://localhost:33997/tests/dromaeo/cssquery-jquery.html) 14:23:54 INFO - PROCESS | 8402 | RSS: Main: 152039424 14:23:54 INFO - PROCESS | 8402 | 14:26:56 INFO - PROCESS | 8402 | Cycle 1(1): loaded http://localhost:33997/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33997/tests/dromaeo/cssquery-mootools.html) 14:26:57 INFO - PROCESS | 8402 | RSS: Main: 152494080 14:26:57 INFO - PROCESS | 8402 | 14:29:58 INFO - PROCESS | 8402 | Cycle 1(1): loaded http://localhost:33997/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33997/tests/dromaeo/cssquery-prototype.html) 14:29:59 INFO - PROCESS | 8402 | RSS: Main: 150405120 14:29:59 INFO - PROCESS | 8402 | 14:33:01 INFO - PROCESS | 8402 | Cycle 1(1): loaded http://localhost:33997/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33997/tests/dromaeo/cssquery-yui.html) 14:33:02 INFO - PROCESS | 8402 | RSS: Main: 149856256 14:33:02 INFO - PROCESS | 8402 | 14:36:04 INFO - PROCESS | 8402 | Cycle 1(1): loaded http://localhost:33997/tests/dromaeo/cssquery-yui.html (next: http://localhost:33997/tests/dromaeo/cssquery-dojo.html) 14:36:05 INFO - PROCESS | 8402 | RSS: Main: 153935872 14:36:05 INFO - PROCESS | 8402 | 14:36:05 INFO - PROCESS | 8402 | __start_tp_report 14:36:05 INFO - PROCESS | 8402 | _x_x_mozilla_page_load 14:36:05 INFO - PROCESS | 8402 | _x_x_mozilla_page_load_details 14:36:05 INFO - PROCESS | 8402 | |i|pagename|runs| 14:36:05 INFO - PROCESS | 8402 | |0;dojo.html;3227.451333273343;3259.250372414343;3291.1936575539;3301.042697617691;3303.12467196193;5145.81989630363;5283.999999999995;5341.2789273448125;5347.331583552056;5355.571554275658;5262.2632831403635;5275.208718692198;5377.11277639189;5414;5441.83674489765;4892.77982490787;4929.926051109236;4972.577330926875;5014.398272207341;5017.84946451607;4913.213885778277;4957.628177886655;4958.057968985881;4994.850154495371;5029.195328747401;4798.448178459487;4869.9269510957365;4877.073356062337;4926.285688575154;4962.206047032476;4906.337644417994;4908.803647854082;4913.975430122862;4929.309896614477;4929.6302777291485;4837.467878533358;4853.830115945925;4896.632752543538;4917.975410122962;4920.114379411704;4975.328330675348;5093.541581257705;5151;5157.9941911327305;5212.035773381898;5609.046462101412;5771.307443106812;5823.359430462646;5849.239598852165;5856.32652244993;5801.361850196475;5825;5825.650460972355;5829.621074630136;5830.737616807254;5287.4448182941005;5359;5376.220448035052;5376.542993845528;5397.055515284809;5825.097109947965;5922.851928701817;5926.851828704317;5940.34656187819;6004;5657.4908258256955;5674.602777805514;5683.204351390726;5686.943130568724;5704;5569.164625306155;5655.3779084300695;5688.260526131577;5744.569157313218;5747.252857128547;5734.340550836624;5756.222909907109;5768.567357448124;5776.364599894008;5810.82567522975;5637.46444087811;5673.31920169574;5698.458646428583;5718.285214348207;5734.369219385864;4322.113966636832;4341.544137865541;4389.18800021997;4404.625606823456;4429.867103986886;3985.740926839746;3999.6200360965663;4011.8796436106963;4021.5174179098694;4026.57720939303;5405.918911216335;5412.972935135299;5422.376426710979;5460.6177567570685;5467.152591348347;5590.18942253371;5685.573581981368;5707.229524014205;5782.653040817564;5814.418558144236;5288.338957630296;5295;5313.548348390353;5314.096603577401;5367.946320536823;4793.281007848851;4801.9039619208115;4802.6638135330195;4811.735354555533;4858.659893807399;5773.711314434261;5819.563532735062;5915.733791979371;5992.730327135202;6058.485028772604;5695.345035320825;5716.085426331767;5720.8569785754025;5725.484706376446;5726.685032323262;5915.704214789157;5947.405259474018;5963.940360596339;5966.791162309299;5987.730552125077;5532.723363831873;5626.634268772516;5631.521320687787;5692.829215123553;5740.540756739534;5701.800436984686;5755.453231942959;5762.078067509178;5763.279590051244;5768.625039372428;5441.619086663895;5546.750396232099;5595.188697638901;5621.887562248814;5637.43625637433;5524.944750552443;5541.889162216814;5558.416366281644;5603.271574695264;5667.1782591524825;5564.749586268708;5575.916361254665;5578.748956296895;5601.915971260353;5614.04561224601;5507.834764957058;5677.630953987978;5681.261436013458;5699.544036477155;5704.743286552032;5439.184122381675;5480.260164877691;5510.641808282448;5516.613837031369;5559.916601251065 14:36:05 INFO - PROCESS | 8402 | |1;ext.html;526.0531044120582;529.1586377659521;531.5216305325207;549.672944597964;551.5532418740819;35815.64184358156;36129;36202;36243.637563624354;36255.9123226303;40238.195236095264;40689.593104068954;40947.795261023726;41038.38442423366;41410.792946035224;8365.58172091396;8557.914420855805;8562.700305489278;8578.270846977983;8601.827963440728;8306.210909963544;8496.575171241444;8535.57322133894;8660.480371177719;8733.432326898763;8405.117462666423;8447.662093516252;8459.280961118282;8503.787405314886;8506.914930850706;8645.351598630097;8676.8698469523;8694.043655197924;8737.7815554611;8759.956200218958;8556.315494760403;8741.606627701769;8764.649414023432;8764.956175219148;8765.517896515688;39511.8024409879;39746.20507589861;39939.8003009986;40111.7994410029;40134.19731605351;3423.4522476403904;3490.2147016921244;3515.701165400944;3548.627394123606;3865.2269546090615;29390.118296450928;30272.54591181134;30346.241343966358;30376.544351834742;30385.088447346614;3549.4675798630155;3796.0699628591174;3807.3717836556934;3918.2444190696438;4078.6940979426663;209966;210366;211390;211590;211818;51004.48995510072;52138.73930630323;59765;59887.70056149692;60376.39623603708;66247.68133115415;66555.66722166358;66824;67019.66490167615;67356;14547.3453694584;14713.779293310396;14731.263436828116;14739.55781326562;14762.704745905237;11173.994340509393;11270.94364528172;11274.661760147208;11295.717607059889;11316.264442811356;20027.399178024683;20555.8972205141;20673.379798605765;20697.793022069887;20720.58558828845;7251.746188883364;7449.255074492507;7484.925150748423;7513.2111128331835;7566.368143291251;898.2230370729272;957.5738796235747;986.8865080515689;1005.0853723111933;1064.7551063255494;24182.87908560481;24216.7578324218;24463.26610201697;25028.624570631455;26353.604695929578;961.9951900240454;985.9112679858847;1009.1825621246813;1015.3095894791466;1016.5577973581368;13191.868081319257;13284.269365184815;13438.260895650834;13540.322983850769;13541.59375218745;322459;324208;325174;326233;326913;51462.74268628633;51610.74194629003;51976;52059.73970130201;52093;1299.7205600795874;1345.549241004255;1366.1598117158076;1366.41244264967;1366.5558693424678;25140.497190055732;26102.73897261079;26109.73890261073;26355.341116472242;26560.468790624465;40665;41524.169516610105;41742.582574173866;42249.78875105605;42254;319046;321523;321560;323684;324213;31522.68477315289;31768.682313176574;32047;32102.357952840346;32170.839145804122;42987;43315.56684433115;43475.78262108669;44178.33732493951;44317.33523997207;36858.44712329371;37000.81499592485;37252.44121338128;38187.42718859164;38416.423753644274;37796.811015944746;37927.81036094802;37971.43042854304;38189.4271585932;38773.2245355097;36012.81993590015;36354;36834.26331473302;36854.8157259212;36975.81512092422;33003.504947425325;33250.33499329951;34393.140171495914;34440.483392748625;34886.476702849985;25905.74094259033;26331.868340658173;26901;27195.86402068056;27302 14:36:05 INFO - PROCESS | 8402 | |2;jquery.html;363.7526481992246;365.89023293012093;367.17569057465994;367.641549489248;369.0478565301522;13448.798268025963;14255.429782808702;15651.373945042198;17108;18268.81731182688;16010.59973500663;16108.11405372704;16940.576485587837;17078.743818842726;17107.91446042768;5112.182050871861;5457.727113644321;5491.780328786844;5524.1989911462815;5525.696086715229;5241.606879484035;5424.593155513333;5470.589705772063;5478.616496845222;5488.368837583689;5438.211459338394;5447.12845944649;5468.398476167618;5483.2049352843815;5486.396496385394;5297.867553311159;5438.102713052342;5440.292761940942;5442.91835622466;5458.563314934816;4695.530446955311;4802.06359759847;4821.059893320804;4837.371141751585;4873.244647079673;19652.11565479557;19859.602807943906;19861;19996.700049499268;20110.69833952492;1860.4139695995852;2191.4521369657587;2271.6024695678357;2281.4410469435093;2290.358699564125;6800.659967001679;11744.766799486102;12798.744025119446;13112;13599.32003399836;1766.7349897515346;1768.7346897965278;1798.2267624921278;1821.5355084453379;1883.6044430669576;54647.45352546503;56411.435885641025;57748.42251577473;57854.42145578533;58095.709521452125;9774.853377199348;10073.748156296151;10100.242481813893;10109.747256318651;10141.087302142843;12668;13081.934590326988;13087.476500940045;13121.868781312256;13156.736865262641;7112.146542414944;7360.116785985609;7367.8894816577795;7398.926010739824;7412.036435263489;7065.258147894397;7090.078289822393;7090.503664743522;7134.928650713427;7136.750213742494;4315.136972605492;4327.199468098412;4348.260795664682;4367.497737760134;4376.803043863034;1799.8830076045015;1888.4429093417475;1931.3926199630387;1936.2932529626867;1957.843372530194;953.0088707743869;976.1312431935582;980.3921568627496;1004.8844382895915;1022.7903279827617;15786.052836829827;16168.514944551682;16282.267297971619;16651.833481665028;16660.6667866642;834.3617132893341;900.2123142250531;929.8372784762639;964.6961207219704;965.4496936745987;8776.561171941377;9004.684836030707;9057;9057.77355566116;9315.254779617615;517794;522378;535236;558993;563878;73587;75308;76344.61827690937;77456.61271693606;79349;1127.2053202492223;1148.0700632487712;1157.716359491913;1157.8263260510823;1160.4197901049474;14258.144511329354;14356.712865742835;14421.351039203471;14425.567232983027;14616.123032618078;30053.398932021675;31527.21181970469;32293.677063230007;32894.67105329012;33416.498752518244;34717.65282347144;40397.39403908885;41305.58694413018;41314.58685413228;41475;6911.5853048817235;7171.247019062923;7202.927970720435;7252.419806415369;7479.214682458263;10704;10862.293950893167;11175.105991520497;11293.830592540955;11350.94324528372;8695.434796738191;8971.237444817263;9001.054889236797;9156.771080723036;9569.760755980878;9289.961525008799;9377.156055954996;9745.561449734638;9877.851832222379;9951.353162044445;9488.95255523718;9542.952285238529;9828;9846.310758246855;10002;7011.088558487364;7017.649117544001;7072.045273887959;7356.926430735838;7393.334599886036;9246.676366327147;9479.72023776809;9607.711768646952;9690.660826871308;9770.902290977283 14:36:05 INFO - PROCESS | 8402 | |3;mootools.html;1461.181738226593;1471.8307394649614;1657.9088150151745;1779.644071185763;1813.1296977450831;7940.602969851506;8010.439269251155;8067.798305042377;8115.8782618260775;8192.91807081929;8172.346212303001;8233.259006689397;8294.70968516102;8304.169583041692;8307.75076747697;2407.4101845047944;2421.152596591188;2436.415260337524;2442.511497700458;2442.7190873049562;2460.790832779216;2462.9261122166363;2484.0808900706766;2492.2024952015363;2494.8128890333296;2378.15575470708;2424.9272521824373;2428.3079322393123;2442.6702395176603;2456.3245107595376;2326.941826454335;2374.050379848057;2411.8432301900407;2411.927642170729;2433.221369161869;2399.8320117591775;2401.6877805885124;2423.8303318767694;2423.854568725882;2430.769076937688;7746.380289576877;7828.647710853025;7847.450678452511;7895.644695988694;7901.96049019757;4924.162892308316;4951.480094590052;4979.975100124476;5016.147254966664;5052.671576347562;3171.540126681641;3232.046546268856;3242.2866969266724;3266.477363621833;3309.0900002499507;1020.9183265338755;1021.0912288063629;1040.849076883855;1057.2968975631195;1060.188955449082;11281.774364512747;11436.027937625311;11436.142289328334;11438.25651332669;11495.080393568494;4469.374287599739;4473.217186992263;4607.14767767964;4728.763561821896;4730.337752714623;9802.460864652512;9813.558389872473;9857.408555486694;9863.01369863008;9878;4982.526659967298;5002.474740152305;5008.724520151354;5031.0441016206805;5031.6729412588065;4506.076254367847;4524.185646583646;4531.524189960072;4542.159700455426;4569.543045695404;3759.342115129841;3815.5993620669983;3822.197338558878;3826.8086595670106;3847.0574709196426;1164.2025212729307;1222.1628184693514;1226.3010084251891;1229.3361584744316;1235.6293112066344;1032.8863824979246;1064.5369264370024;1076.0315715855793;1235.2588446931768;1374.5601407549489;7385;7563.73526926566;7617.923820761832;7628.160902300742;7677.117131529834;1046.795874804406;1083.7344850511674;1142.9142814288962;1143.6912033750841;1151.1884121694186;5903.114532820111;5966.85082872923;5983.880322393527;5998.700064996733;5999.610025348338;9299.860502092473;9496.382735122195;9497;9585.089416505421;9642.276829237835;9347.298952578583;9469.810603787886;9485.241180705527;9495.90504094964;9511.239100872051;7050.506464547535;7166.8208294792;7181.281871812777;7265.600391978492;7553.093628764584;7440.962795185989;7449.366803821736;7497.550146991198;7542.811429714301;7573.772786816405;8658.134186581292;8862.77843053903;8875.423097498642;9010;9018;8657.047724750399;8971.147740964598;9007.63969441215;9058.094190580889;9100.271978241857;7260.165081015751;7335.486515943832;7353.926460735324;7363.889541656987;7382.52013619113;7656.119546252252;7703.38372930153;7706.807329816799;7712.768616941501;7752.26353496417;7193.820154496179;7376.557406555624;7441.888371674321;7460.776176714708;7552.6223688816435;7085.2560481150795;7143.321384468467;7228.927710722825;7309.853802924018;7378.852422951403;7154.463415243774;7174.282571742784;7180.856382872418;7184.748533801292;7244.384227340735;6585.308542603149;6626.734930602722;6666.566673166229;6676.198856137295;6704.597724136567;6769.356911093439;6830.93169068303;6838.316168383122;6921.031055652112;6966.268541803038 14:36:05 INFO - PROCESS | 8402 | |4;prototype.html;329.1048348492101;339.4060394309957;351.38858386407657;351.5974209530087;355.11753293066727;6125.693715314239;6263.248410190778;6283.371662833714;6286.2456505219325;6313.842153946148;6093;6216.813495595128;6226.3462336454695;6243.282022567395;6256.874862502747;4742.834000809972;4751.809927602892;4752.287156926454;4762.809487620491;4766.165920963817;4744;4764.094821983829;4768.308595253686;4772.498887616803;4776.092542416947;4667.346571479996;4729.78715957781;4775.665703400763;4778.163821331271;4786.2581299898575;4745.525447455261;4754.239321708527;4762.833300834454;4765.21373973294;4765.904681906342;4158.08522125132;4158.397032430311;4172.77049762263;4179.477565304337;4186.162767446493;5955.04719244923;5963.612365196248;5971.820845374602;5978.192943952554;5986.580939334249;5480.369757477902;5531.640443371168;5537.975474537224;5541.639793413456;5542.2795036644975;6664.133662623828;6708.597484150918;6710.094137291452;6715.7985260442265;6720.899186512206;4580.083983203339;4585.610223131038;4585.968157164644;4588.49526552079;4595.988882445857;6785.796426107225;6967.407770339527;6968;6971.477139214579;6986.790396288119;4688.976555117202;4692.507286734912;4695.178343789891;4705.058988202373;4723.645726570452;4736.739479328601;4738.976305118521;4742.672051825494;4754.168020596382;4770.284457331359;5509.972450137804;5520.337559492887;5523.530499907552;5527.39198688144;5538.6399884007415;6525.902111468332;6723.327667233335;6744.393004629509;6753.189617245864;6759.188897332253;1637.7461493468531;1641.0563925742506;1682.4616122840819;1683;1685.536477468706;1103.9944800275948;1106.435717783936;1114.0419239454063;1121.4280716834473;1131.8754936956927;6207.006878899354;6270.717817698123;6272.905906411407;6279.686015699197;6301.40136687014;6799.422049125781;6808.523403361717;6814.773340798703;6825.419839313714;6832.555883867532;6152.8769424611255;6298.149749783812;6300.810975670645;6301.842453938688;6313.905291420632;3682.5949145593963;3707.629237076325;3710.5361829771277;3713.090292878208;3716;7069.929300706927;7098;7125.3230943060325;7130.607816570138;7157.4274058075225;6908.792736217922;6971.721131154798;6976.895346569806;6982.301769823079;6994.545354551938;7244.420446364278;7251.129864416198;7285.562866227937;7300.853982920418;7314.853702926018;6920.757773478105;6923.446124309942;6934.583924964519;6943.236244013054;6967.825804354931;6756.69594868242;6835.282295358916;6844.349786770249;6893.655317234018;6923.29991303382;7166.2475440080125;7215.60314182725;7286.307800758919;7287.526310789782;7296.817579560554;4642.280446530793;4686.976565117153;4687.1328804171335;4691.788869500949;4695.319178718998;6812.420944219599;6983.301669833179;6991.370776630128;6997.7200911962955;7012.053372794608;6760.830979225559;6774.390304872585;6778.627175505395;6778.7288508459105;6779.762708305383;6746.527743057939;6747.628880411428;6755.392014718699;6778.389944904982;6814.318568143146;6515.837104072436;6557.508186886098;6654.866902662016;6665;6669.799906002828;6774.559653622498;6794.150731158606;6800.863982720219;6801.625910574768;6822.147231596051;6604.339566043357;6629.834254143685;6640.435562977201;6661;6663.100481434944 14:36:05 INFO - PROCESS | 8402 | |5;yui.html;717.9425645948323;779.8089468080319;843.2958479669476;850.4174640371347;872.027689126624;13752.381142848571;13784.379702913368;13871.167729936198;13949.093308934926;13971.860281397183;12964.675883102927;13021.479140834355;13054.347282635877;13072.934635326834;13136.54022109224;589.1957478042463;597.1013624495129;776.1036003416035;779.111812533712;790.3084800799301;787.2285160542672;791.8812178173263;792.8612492813763;795.4948607634136;800.2477670989281;826.89663792026;828.2628460670009;828.2669837194067;829.9419040667156;835.9038710548274;819.2626636027563;820.5527987246965;823.4359463767308;828.4242451496212;833.125218520554;601.9006863867456;605.9242594675666;608.5679167790873;609.5123900879323;609.5672072828297;13487.055906086578;13591.116577422536;13595.252261125634;13625.795613065811;13656.385462654105;12690.682732931658;12731.61805145847;12779.680507987374;12908.483660653563;13019.414126364336;10365.326253793479;10406.375617462976;10440.47797610124;10479.161667066617;10491.632792852213;3494.7204223662047;3592.191756854713;3594.245208506217;3599.8200089995657;3711.573169085536;47066.764666176794;47540.762296188295;47774.52225477735;48042;48087.278690819665;9650.662226822027;9738.220942324597;9774.413535187912;9954.104130628279;9990.500474976223;17163.828361716223;17256.827431725524;17283.222254998556;17292.13539323054;17430.738538921927;7053.964730176419;7104.751333703295;7208.891866622005;7353.889691654629;7535.886961695579;4225;4299.849505267301;4303.031817841023;4321.7406955582765;4340.82636694535;3189.920251993719;3190.2343437574814;3201.4077395681875;3205.7114859662743;3217.6621454747383;490.82821012646;492.26406522249465;508.75325467148406;511.80551390471385;515.4587682932905;648.6302807399832;652.8922727749868;668.208173314614;670.2560158224367;673.0173946038838;8592.527410992456;8730.083341249205;8752.649894004297;8877.689280875138;8995.32535059873;518.7847043476991;605.4101109423865;608.9421504957022;675.0818886314609;684.7158429251905;4218;4219.38818871262;4229.344451610005;4260.91478170441;4288.4210631564965;53405.465945340824;53415;53546.46453535493;53636.19545706818;54529.72735136299;51935.48064519382;52050.21924671133;52545.211821822704;53123.20315195275;53791.193132102264;46223.5377646226;46907;47094.76452617784;47111;49696.0060798782;8581.742547723577;8857.846018951423;8943.105689431004;9048.819023619359;9192.080791920755;33727;34093.829530852185;34606.328145700005;35019;35084.29831403409;39916.60083399129;43473;43523;43637;43705.56294437015;10190.184785217312;10376.377417354983;10379;10649.53519454266;10714.410707411167;11789.268564270113;12004.459799309227;12007.879921201025;12054.638360849189;12057.879421205676;10879.401632910265;10899.673009809718;11064;11123.499442524944;11277.436128193722;11262.774744505228;11453.656390308304;11534.250273732181;11611.593594224161;11910.642680719593;11132.276402033842;11382;11767.588134415597;11791.469383877575;12040.397980101136;8631.482111073356;8754.824903502022;8856.690015849414;8992.46045237288;9215.400998935047;8722.302215822592;8851.203391694778;9513.238940884574;9637.759056023375;10074.69775906724 14:36:05 INFO - PROCESS | 8402 | __end_tp_report 14:36:05 INFO - PROCESS | 8402 | __start_cc_report 14:36:05 INFO - PROCESS | 8402 | _x_x_mozilla_cycle_collect,313 14:36:05 INFO - PROCESS | 8402 | __end_cc_report 14:36:05 INFO - PROCESS | 8402 | __startTimestamp1452724565151__endTimestamp 14:36:05 INFO - PROCESS | 8402 | 14:36:05 INFO - PROCESS | 8402 | ------- Summary: start ------- 14:36:05 INFO - PROCESS | 8402 | Number of tests: 6 14:36:05 INFO - PROCESS | 8402 | 14:36:05 INFO - PROCESS | 8402 | [#0] dojo.html Cycles:165 Average:5330.81 Median:5532.72 stddev:581.87 (10.5%) stddev-sans-first:559.77 14:36:05 INFO - PROCESS | 8402 | Values: 3227.5 3259.3 3291.2 3301.0 3303.1 5145.8 5284.0 5341.3 5347.3 5355.6 5262.3 5275.2 5377.1 5414.0 5441.8 4892.8 4929.9 4972.6 5014.4 5017.8 4913.2 4957.6 4958.1 4994.9 5029.2 4798.4 4869.9 4877.1 4926.3 4962.2 4906.3 4908.8 4914.0 4929.3 4929.6 4837.5 4853.8 4896.6 4918.0 4920.1 4975.3 5093.5 5151.0 5158.0 5212.0 5609.0 5771.3 5823.4 5849.2 5856.3 5801.4 5825.0 5825.7 5829.6 5830.7 5287.4 5359.0 5376.2 5376.5 5397.1 5825.1 5922.9 5926.9 5940.3 6004.0 5657.5 5674.6 5683.2 5686.9 5704.0 5569.2 5655.4 5688.3 5744.6 5747.3 5734.3 5756.2 5768.6 5776.4 5810.8 5637.5 5673.3 5698.5 5718.3 5734.4 4322.1 4341.5 4389.2 4404.6 4429.9 3985.7 3999.6 4011.9 4021.5 4026.6 5405.9 5413.0 5422.4 5460.6 5467.2 5590.2 5685.6 5707.2 5782.7 5814.4 5288.3 5295.0 5313.5 5314.1 5367.9 4793.3 4801.9 4802.7 4811.7 4858.7 5773.7 5819.6 5915.7 5992.7 6058.5 5695.3 5716.1 5720.9 5725.5 5726.7 5915.7 5947.4 5963.9 5966.8 5987.7 5532.7 5626.6 5631.5 5692.8 5740.5 5701.8 5755.5 5762.1 5763.3 5768.6 5441.6 5546.8 5595.2 5621.9 5637.4 5524.9 5541.9 5558.4 5603.3 5667.2 5564.7 5575.9 5578.7 5601.9 5614.0 5507.8 5677.6 5681.3 5699.5 5704.7 5439.2 5480.3 5510.6 5516.6 5559.9 14:36:05 INFO - PROCESS | 8402 | 14:36:05 INFO - PROCESS | 8402 | [#1] ext.html Cycles:180 Average:45641.53 Median:36988.32 stddev:76249.82 (206.1%) stddev-sans-first:76388.48 14:36:05 INFO - PROCESS | 8402 | Values: 526.1 529.2 531.5 549.7 551.6 35815.6 36129.0 36202.0 36243.6 36255.9 40238.2 40689.6 40947.8 41038.4 41410.8 8365.6 8557.9 8562.7 8578.3 8601.8 8306.2 8496.6 8535.6 8660.5 8733.4 8405.1 8447.7 8459.3 8503.8 8506.9 8645.4 8676.9 8694.0 8737.8 8760.0 8556.3 8741.6 8764.6 8765.0 8765.5 39511.8 39746.2 39939.8 40111.8 40134.2 3423.5 3490.2 3515.7 3548.6 3865.2 29390.1 30272.5 30346.2 30376.5 30385.1 3549.5 3796.1 3807.4 3918.2 4078.7 209966.0 210366.0 211390.0 211590.0 211818.0 51004.5 52138.7 59765.0 59887.7 60376.4 66247.7 66555.7 66824.0 67019.7 67356.0 14547.3 14713.8 14731.3 14739.6 14762.7 11174.0 11270.9 11274.7 11295.7 11316.3 20027.4 20555.9 20673.4 20697.8 20720.6 7251.7 7449.3 7484.9 7513.2 7566.4 898.2 957.6 986.9 1005.1 1064.8 24182.9 24216.8 24463.3 25028.6 26353.6 962.0 985.9 1009.2 1015.3 1016.6 13191.9 13284.3 13438.3 13540.3 13541.6 322459.0 324208.0 325174.0 326233.0 326913.0 51462.7 51610.7 51976.0 52059.7 52093.0 1299.7 1345.5 1366.2 1366.4 1366.6 25140.5 26102.7 26109.7 26355.3 26560.5 40665.0 41524.2 41742.6 42249.8 42254.0 319046.0 321523.0 321560.0 323684.0 324213.0 31522.7 31768.7 32047.0 32102.4 32170.8 42987.0 43315.6 43475.8 44178.3 44317.3 36858.4 37000.8 37252.4 38187.4 38416.4 37796.8 37927.8 37971.4 38189.4 38773.2 36012.8 36354.0 36834.3 36854.8 36975.8 33003.5 33250.3 34393.1 34440.5 34886.5 25905.7 26331.9 26901.0 27195.9 27302.0 14:36:05 INFO - PROCESS | 8402 | 14:36:05 INFO - PROCESS | 8402 | [#2] jquery.html Cycles:180 Average:27492.52 Median:4992.71 stddev:88253.94 (1767.7%) stddev-sans-first:88478.00 14:36:05 INFO - PROCESS | 8402 | Values: 363.8 365.9 367.2 367.6 369.0 13448.8 14255.4 15651.4 17108.0 18268.8 16010.6 16108.1 16940.6 17078.7 17107.9 5112.2 5457.7 5491.8 5524.2 5525.7 5241.6 5424.6 5470.6 5478.6 5488.4 5438.2 5447.1 5468.4 5483.2 5486.4 5297.9 5438.1 5440.3 5442.9 5458.6 4695.5 4802.1 4821.1 4837.4 4873.2 19652.1 19859.6 19861.0 19996.7 20110.7 1860.4 2191.5 2271.6 2281.4 2290.4 6800.7 11744.8 12798.7 13112.0 13599.3 1766.7 1768.7 1798.2 1821.5 1883.6 54647.5 56411.4 57748.4 57854.4 58095.7 9774.9 10073.7 10100.2 10109.7 10141.1 12668.0 13081.9 13087.5 13121.9 13156.7 7112.1 7360.1 7367.9 7398.9 7412.0 7065.3 7090.1 7090.5 7134.9 7136.8 4315.1 4327.2 4348.3 4367.5 4376.8 1799.9 1888.4 1931.4 1936.3 1957.8 953.0 976.1 980.4 1004.9 1022.8 15786.1 16168.5 16282.3 16651.8 16660.7 834.4 900.2 929.8 964.7 965.4 8776.6 9004.7 9057.0 9057.8 9315.3 517794.0 522378.0 535236.0 558993.0 563878.0 73587.0 75308.0 76344.6 77456.6 79349.0 1127.2 1148.1 1157.7 1157.8 1160.4 14258.1 14356.7 14421.4 14425.6 14616.1 30053.4 31527.2 32293.7 32894.7 33416.5 34717.7 40397.4 41305.6 41314.6 41475.0 6911.6 7171.2 7202.9 7252.4 7479.2 10704.0 10862.3 11175.1 11293.8 11350.9 8695.4 8971.2 9001.1 9156.8 9569.8 9290.0 9377.2 9745.6 9877.9 9951.4 9489.0 9543.0 9828.0 9846.3 10002.0 7011.1 7017.6 7072.0 7356.9 7393.3 9246.7 9479.7 9607.7 9690.7 9770.9 14:36:05 INFO - PROCESS | 8402 | 14:36:05 INFO - PROCESS | 8402 | [#3] mootools.html Cycles:180 Average:5705.90 Median:6606.02 stddev:2935.67 (44.4%) stddev-sans-first:2926.56 14:36:05 INFO - PROCESS | 8402 | Values: 1461.2 1471.8 1657.9 1779.6 1813.1 7940.6 8010.4 8067.8 8115.9 8192.9 8172.3 8233.3 8294.7 8304.2 8307.8 2407.4 2421.2 2436.4 2442.5 2442.7 2460.8 2462.9 2484.1 2492.2 2494.8 2378.2 2424.9 2428.3 2442.7 2456.3 2326.9 2374.1 2411.8 2411.9 2433.2 2399.8 2401.7 2423.8 2423.9 2430.8 7746.4 7828.6 7847.5 7895.6 7902.0 4924.2 4951.5 4980.0 5016.1 5052.7 3171.5 3232.0 3242.3 3266.5 3309.1 1020.9 1021.1 1040.8 1057.3 1060.2 11281.8 11436.0 11436.1 11438.3 11495.1 4469.4 4473.2 4607.1 4728.8 4730.3 9802.5 9813.6 9857.4 9863.0 9878.0 4982.5 5002.5 5008.7 5031.0 5031.7 4506.1 4524.2 4531.5 4542.2 4569.5 3759.3 3815.6 3822.2 3826.8 3847.1 1164.2 1222.2 1226.3 1229.3 1235.6 1032.9 1064.5 1076.0 1235.3 1374.6 7385.0 7563.7 7617.9 7628.2 7677.1 1046.8 1083.7 1142.9 1143.7 1151.2 5903.1 5966.9 5983.9 5998.7 5999.6 9299.9 9496.4 9497.0 9585.1 9642.3 9347.3 9469.8 9485.2 9495.9 9511.2 7050.5 7166.8 7181.3 7265.6 7553.1 7441.0 7449.4 7497.6 7542.8 7573.8 8658.1 8862.8 8875.4 9010.0 9018.0 8657.0 8971.1 9007.6 9058.1 9100.3 7260.2 7335.5 7353.9 7363.9 7382.5 7656.1 7703.4 7706.8 7712.8 7752.3 7193.8 7376.6 7441.9 7460.8 7552.6 7085.3 7143.3 7228.9 7309.9 7378.9 7154.5 7174.3 7180.9 7184.7 7244.4 6585.3 6626.7 6666.6 6676.2 6704.6 6769.4 6830.9 6838.3 6921.0 6966.3 14:36:05 INFO - PROCESS | 8402 | 14:36:05 INFO - PROCESS | 8402 | [#4] prototype.html Cycles:180 Average:5580.09 Median:6276.30 stddev:1703.22 (27.1%) stddev-sans-first:1661.77 14:36:05 INFO - PROCESS | 8402 | Values: 329.1 339.4 351.4 351.6 355.1 6125.7 6263.2 6283.4 6286.2 6313.8 6093.0 6216.8 6226.3 6243.3 6256.9 4742.8 4751.8 4752.3 4762.8 4766.2 4744.0 4764.1 4768.3 4772.5 4776.1 4667.3 4729.8 4775.7 4778.2 4786.3 4745.5 4754.2 4762.8 4765.2 4765.9 4158.1 4158.4 4172.8 4179.5 4186.2 5955.0 5963.6 5971.8 5978.2 5986.6 5480.4 5531.6 5538.0 5541.6 5542.3 6664.1 6708.6 6710.1 6715.8 6720.9 4580.1 4585.6 4586.0 4588.5 4596.0 6785.8 6967.4 6968.0 6971.5 6986.8 4689.0 4692.5 4695.2 4705.1 4723.6 4736.7 4739.0 4742.7 4754.2 4770.3 5510.0 5520.3 5523.5 5527.4 5538.6 6525.9 6723.3 6744.4 6753.2 6759.2 1637.7 1641.1 1682.5 1683.0 1685.5 1104.0 1106.4 1114.0 1121.4 1131.9 6207.0 6270.7 6272.9 6279.7 6301.4 6799.4 6808.5 6814.8 6825.4 6832.6 6152.9 6298.1 6300.8 6301.8 6313.9 3682.6 3707.6 3710.5 3713.1 3716.0 7069.9 7098.0 7125.3 7130.6 7157.4 6908.8 6971.7 6976.9 6982.3 6994.5 7244.4 7251.1 7285.6 7300.9 7314.9 6920.8 6923.4 6934.6 6943.2 6967.8 6756.7 6835.3 6844.3 6893.7 6923.3 7166.2 7215.6 7286.3 7287.5 7296.8 4642.3 4687.0 4687.1 4691.8 4695.3 6812.4 6983.3 6991.4 6997.7 7012.1 6760.8 6774.4 6778.6 6778.7 6779.8 6746.5 6747.6 6755.4 6778.4 6814.3 6515.8 6557.5 6654.9 6665.0 6669.8 6774.6 6794.2 6800.9 6801.6 6822.1 6604.3 6629.8 6640.4 6661.0 6663.1 14:36:05 INFO - PROCESS | 8402 | 14:36:05 INFO - PROCESS | 8402 | [#5] yui.html Cycles:180 Average:13647.91 Median:47325.88 stddev:15687.36 (33.1%) stddev-sans-first:15701.32 14:36:05 INFO - PROCESS | 8402 | Values: 717.9 779.8 843.3 850.4 872.0 13752.4 13784.4 13871.2 13949.1 13971.9 12964.7 13021.5 13054.3 13072.9 13136.5 589.2 597.1 776.1 779.1 790.3 787.2 791.9 792.9 795.5 800.2 826.9 828.3 828.3 829.9 835.9 819.3 820.6 823.4 828.4 833.1 601.9 605.9 608.6 609.5 609.6 13487.1 13591.1 13595.3 13625.8 13656.4 12690.7 12731.6 12779.7 12908.5 13019.4 10365.3 10406.4 10440.5 10479.2 10491.6 3494.7 3592.2 3594.2 3599.8 3711.6 47066.8 47540.8 47774.5 48042.0 48087.3 9650.7 9738.2 9774.4 9954.1 9990.5 17163.8 17256.8 17283.2 17292.1 17430.7 7054.0 7104.8 7208.9 7353.9 7535.9 4225.0 4299.8 4303.0 4321.7 4340.8 3189.9 3190.2 3201.4 3205.7 3217.7 490.8 492.3 508.8 511.8 515.5 648.6 652.9 668.2 670.3 673.0 8592.5 8730.1 8752.6 8877.7 8995.3 518.8 605.4 608.9 675.1 684.7 4218.0 4219.4 4229.3 4260.9 4288.4 53405.5 53415.0 53546.5 53636.2 54529.7 51935.5 52050.2 52545.2 53123.2 53791.2 46223.5 46907.0 47094.8 47111.0 49696.0 8581.7 8857.8 8943.1 9048.8 9192.1 33727.0 34093.8 34606.3 35019.0 35084.3 39916.6 43473.0 43523.0 43637.0 43705.6 10190.2 10376.4 10379.0 10649.5 10714.4 11789.3 12004.5 12007.9 12054.6 12057.9 10879.4 10899.7 11064.0 11123.5 11277.4 11262.8 11453.7 11534.3 11611.6 11910.6 11132.3 11382.0 11767.6 11791.5 12040.4 8631.5 8754.8 8856.7 8992.5 9215.4 8722.3 8851.2 9513.2 9637.8 10074.7 14:36:05 INFO - PROCESS | 8402 | -------- Summary: end -------- 14:36:05 INFO - PROCESS | 8402 | 14:36:05 INFO - TEST-INFO | 8402: exit 0 14:36:05 INFO - TEST-OK | dromaeo_css | took 1110801ms 14:36:05 INFO - TEST-START | kraken 14:36:05 INFO - operating with platform_type : linux_ 14:36:05 INFO - Initialising browser for kraken test... 14:36:05 INFO - TEST-INFO | started process 8637 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHic3LT/profile http://localhost:33997/getInfo.html) 14:36:09 INFO - PROCESS | 8637 | 14:36:09 INFO - PROCESS | 8637 | (process:8711): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:36:10 INFO - PROCESS | 8637 | __metrics Screen width/height:1600/1200 14:36:10 INFO - PROCESS | 8637 | colorDepth:24 14:36:10 INFO - PROCESS | 8637 | Browser inner width/height: 1024/697 14:36:10 INFO - PROCESS | 8637 | __metrics 14:36:10 INFO - PROCESS | 8637 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:36:11 INFO - TEST-INFO | 8637: exit 0 14:36:11 INFO - Browser initialized. 14:36:11 INFO - Running cycle 1/1 for kraken test... 14:36:11 INFO - TEST-INFO | started process 8760 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHic3LT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:36:12 INFO - PROCESS | 8760 | 14:36:12 INFO - PROCESS | 8760 | (process:8817): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:36:22 INFO - PROCESS | 8760 | RSS: Main: 151191552 14:36:22 INFO - PROCESS | 8760 | 14:36:25 INFO - PROCESS | 8760 | Cycle 1(1): loaded http://localhost:33997/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33997/tests/kraken/driver.html?testName=audio-beat-detection) 14:36:26 INFO - PROCESS | 8760 | RSS: Main: 151023616 14:36:26 INFO - PROCESS | 8760 | 14:36:28 INFO - PROCESS | 8760 | Cycle 1(1): loaded http://localhost:33997/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33997/tests/kraken/driver.html?testName=audio-dft) 14:36:29 INFO - PROCESS | 8760 | RSS: Main: 155348992 14:36:29 INFO - PROCESS | 8760 | 14:36:32 INFO - PROCESS | 8760 | Cycle 1(1): loaded http://localhost:33997/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33997/tests/kraken/driver.html?testName=audio-fft) 14:36:32 INFO - PROCESS | 8760 | RSS: Main: 147644416 14:36:32 INFO - PROCESS | 8760 | 14:36:34 INFO - PROCESS | 8760 | Cycle 1(1): loaded http://localhost:33997/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33997/tests/kraken/driver.html?testName=audio-oscillator) 14:36:35 INFO - PROCESS | 8760 | RSS: Main: 148942848 14:36:35 INFO - PROCESS | 8760 | 14:36:37 INFO - PROCESS | 8760 | Cycle 1(1): loaded http://localhost:33997/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33997/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:36:38 INFO - PROCESS | 8760 | RSS: Main: 149217280 14:36:38 INFO - PROCESS | 8760 | 14:36:41 INFO - PROCESS | 8760 | Cycle 1(1): loaded http://localhost:33997/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33997/tests/kraken/driver.html?testName=imaging-darkroom) 14:36:41 INFO - PROCESS | 8760 | RSS: Main: 149237760 14:36:41 INFO - PROCESS | 8760 | 14:36:45 INFO - PROCESS | 8760 | Cycle 1(1): loaded http://localhost:33997/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33997/tests/kraken/driver.html?testName=imaging-desaturate) 14:36:45 INFO - PROCESS | 8760 | RSS: Main: 149864448 14:36:45 INFO - PROCESS | 8760 | 14:36:48 INFO - PROCESS | 8760 | Cycle 1(1): loaded http://localhost:33997/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33997/tests/kraken/driver.html?testName=json-parse-financial) 14:36:49 INFO - PROCESS | 8760 | RSS: Main: 149946368 14:36:49 INFO - PROCESS | 8760 | 14:36:50 INFO - PROCESS | 8760 | Cycle 1(1): loaded http://localhost:33997/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33997/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:36:51 INFO - PROCESS | 8760 | RSS: Main: 150315008 14:36:51 INFO - PROCESS | 8760 | 14:36:53 INFO - PROCESS | 8760 | Cycle 1(1): loaded http://localhost:33997/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33997/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:36:53 INFO - PROCESS | 8760 | RSS: Main: 150302720 14:36:53 INFO - PROCESS | 8760 | 14:36:55 INFO - PROCESS | 8760 | Cycle 1(1): loaded http://localhost:33997/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33997/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:36:56 INFO - PROCESS | 8760 | RSS: Main: 149680128 14:36:56 INFO - PROCESS | 8760 | 14:36:58 INFO - PROCESS | 8760 | Cycle 1(1): loaded http://localhost:33997/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33997/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:36:59 INFO - PROCESS | 8760 | RSS: Main: 150286336 14:36:59 INFO - PROCESS | 8760 | 14:37:01 INFO - PROCESS | 8760 | Cycle 1(1): loaded http://localhost:33997/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33997/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:37:02 INFO - PROCESS | 8760 | RSS: Main: 150822912 14:37:02 INFO - PROCESS | 8760 | 14:37:04 INFO - PROCESS | 8760 | Cycle 1(1): loaded http://localhost:33997/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33997/tests/kraken/driver.html?testName=ai-astar) 14:37:04 INFO - PROCESS | 8760 | RSS: Main: 149889024 14:37:04 INFO - PROCESS | 8760 | 14:37:04 INFO - PROCESS | 8760 | __start_tp_report 14:37:04 INFO - PROCESS | 8760 | _x_x_mozilla_page_load 14:37:04 INFO - PROCESS | 8760 | _x_x_mozilla_page_load_details 14:37:04 INFO - PROCESS | 8760 | |i|pagename|runs| 14:37:04 INFO - PROCESS | 8760 | |0;ai-astar;112;108;112;112;111;124;112;112;112;113 14:37:04 INFO - PROCESS | 8760 | |1;audio-beat-detection;153;131;156;163;136;155;148;127;168;133 14:37:04 INFO - PROCESS | 8760 | |2;audio-dft;164;164;162;163;164;162;163;169;166;162 14:37:04 INFO - PROCESS | 8760 | |3;audio-fft;72;71;75;73;71;131;71;73;84;72 14:37:04 INFO - PROCESS | 8760 | |4;audio-oscillator;96;97;140;95;95;95;143;96;95;134 14:37:04 INFO - PROCESS | 8760 | |5;imaging-gaussian-blur;110;110;110;110;110;110;109;110;110;110 14:37:04 INFO - PROCESS | 8760 | |6;imaging-darkroom;147;146;147;146;147;148;148;148;147;146 14:37:04 INFO - PROCESS | 8760 | |7;imaging-desaturate;97;97;97;97;98;96;96;97;97;96 14:37:04 INFO - PROCESS | 8760 | |8;json-parse-financial;63;59;59;61;60;58;59;61;57;58 14:37:04 INFO - PROCESS | 8760 | |9;json-stringify-tinderbox;69;69;68;69;70;69;68;69;68;69 14:37:04 INFO - PROCESS | 8760 | |10;stanford-crypto-aes;82;82;83;84;82;91;84;83;83;84 14:37:04 INFO - PROCESS | 8760 | |11;stanford-crypto-ccm;115;115;123;118;130;118;124;118;116;112 14:37:04 INFO - PROCESS | 8760 | |12;stanford-crypto-pbkdf2;136;152;142;141;150;145;141;138;143;131 14:37:04 INFO - PROCESS | 8760 | |13;stanford-crypto-sha256-iterative;68;68;74;66;68;64;65;69;67;67 14:37:04 INFO - PROCESS | 8760 | __end_tp_report 14:37:04 INFO - PROCESS | 8760 | __start_cc_report 14:37:04 INFO - PROCESS | 8760 | _x_x_mozilla_cycle_collect,753 14:37:04 INFO - PROCESS | 8760 | __end_cc_report 14:37:04 INFO - PROCESS | 8760 | __startTimestamp1452724624433__endTimestamp 14:37:04 INFO - PROCESS | 8760 | 14:37:04 INFO - PROCESS | 8760 | ------- Summary: start ------- 14:37:04 INFO - PROCESS | 8760 | Number of tests: 14 14:37:04 INFO - PROCESS | 8760 | 14:37:04 INFO - PROCESS | 8760 | [#0] ai-astar Cycles:10 Average:112.80 Median:112.00 stddev:4.16 (3.7%) stddev-sans-first:4.40 14:37:04 INFO - PROCESS | 8760 | Values: 112.0 108.0 112.0 112.0 111.0 124.0 112.0 112.0 112.0 113.0 14:37:04 INFO - PROCESS | 8760 | 14:37:04 INFO - PROCESS | 8760 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:154.00 stddev:14.34 (9.3%) stddev-sans-first:15.05 14:37:04 INFO - PROCESS | 8760 | Values: 153.0 131.0 156.0 163.0 136.0 155.0 148.0 127.0 168.0 133.0 14:37:04 INFO - PROCESS | 8760 | 14:37:04 INFO - PROCESS | 8760 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:2.18 (1.3%) stddev-sans-first:2.32 14:37:04 INFO - PROCESS | 8760 | Values: 164.0 164.0 162.0 163.0 164.0 162.0 163.0 169.0 166.0 162.0 14:37:04 INFO - PROCESS | 8760 | 14:37:04 INFO - PROCESS | 8760 | [#3] audio-fft Cycles:10 Average:79.30 Median:72.50 stddev:18.58 (25.6%) stddev-sans-first:19.52 14:37:04 INFO - PROCESS | 8760 | Values: 72.0 71.0 75.0 73.0 71.0 131.0 71.0 73.0 84.0 72.0 14:37:04 INFO - PROCESS | 8760 | 14:37:04 INFO - PROCESS | 8760 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:95.00 stddev:21.10 (22.2%) stddev-sans-first:21.88 14:37:04 INFO - PROCESS | 8760 | Values: 96.0 97.0 140.0 95.0 95.0 95.0 143.0 96.0 95.0 134.0 14:37:04 INFO - PROCESS | 8760 | 14:37:04 INFO - PROCESS | 8760 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:37:04 INFO - PROCESS | 8760 | Values: 110.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 110.0 14:37:04 INFO - PROCESS | 8760 | 14:37:04 INFO - PROCESS | 8760 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 14:37:04 INFO - PROCESS | 8760 | Values: 147.0 146.0 147.0 146.0 147.0 148.0 148.0 148.0 147.0 146.0 14:37:04 INFO - PROCESS | 8760 | 14:37:04 INFO - PROCESS | 8760 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:97.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 14:37:04 INFO - PROCESS | 8760 | Values: 97.0 97.0 97.0 97.0 98.0 96.0 96.0 97.0 97.0 96.0 14:37:04 INFO - PROCESS | 8760 | 14:37:04 INFO - PROCESS | 8760 | [#8] json-parse-financial Cycles:10 Average:59.50 Median:59.50 stddev:1.78 (3.0%) stddev-sans-first:1.36 14:37:04 INFO - PROCESS | 8760 | Values: 63.0 59.0 59.0 61.0 60.0 58.0 59.0 61.0 57.0 58.0 14:37:04 INFO - PROCESS | 8760 | 14:37:04 INFO - PROCESS | 8760 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 14:37:04 INFO - PROCESS | 8760 | Values: 69.0 69.0 68.0 69.0 70.0 69.0 68.0 69.0 68.0 69.0 14:37:04 INFO - PROCESS | 8760 | 14:37:04 INFO - PROCESS | 8760 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.50 stddev:2.66 (3.2%) stddev-sans-first:2.74 14:37:04 INFO - PROCESS | 8760 | Values: 82.0 82.0 83.0 84.0 82.0 91.0 84.0 83.0 83.0 84.0 14:37:04 INFO - PROCESS | 8760 | 14:37:04 INFO - PROCESS | 8760 | [#11] stanford-crypto-ccm Cycles:10 Average:118.90 Median:118.00 stddev:5.32 (4.5%) stddev-sans-first:5.45 14:37:04 INFO - PROCESS | 8760 | Values: 115.0 115.0 123.0 118.0 130.0 118.0 124.0 118.0 116.0 112.0 14:37:04 INFO - PROCESS | 8760 | 14:37:04 INFO - PROCESS | 8760 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.90 Median:142.50 stddev:6.23 (4.4%) stddev-sans-first:6.23 14:37:04 INFO - PROCESS | 8760 | Values: 136.0 152.0 142.0 141.0 150.0 145.0 141.0 138.0 143.0 131.0 14:37:04 INFO - PROCESS | 8760 | 14:37:04 INFO - PROCESS | 8760 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:2.72 (4.0%) stddev-sans-first:2.88 14:37:04 INFO - PROCESS | 8760 | Values: 68.0 68.0 74.0 66.0 68.0 64.0 65.0 69.0 67.0 67.0 14:37:04 INFO - PROCESS | 8760 | -------- Summary: end -------- 14:37:04 INFO - PROCESS | 8760 | 14:37:05 INFO - TEST-INFO | 8760: exit 0 14:37:05 INFO - TEST-OK | kraken | took 59569ms 14:37:05 INFO - TEST-START | v8_7 14:37:05 INFO - operating with platform_type : linux_ 14:37:05 INFO - Initialising browser for v8_7 test... 14:37:05 INFO - TEST-INFO | started process 9045 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuoUWhv/profile http://localhost:33997/getInfo.html) 14:37:08 INFO - PROCESS | 9045 | 14:37:08 INFO - PROCESS | 9045 | (process:9117): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:37:09 INFO - PROCESS | 9045 | __metrics Screen width/height:1600/1200 14:37:09 INFO - PROCESS | 9045 | colorDepth:24 14:37:09 INFO - PROCESS | 9045 | Browser inner width/height: 1024/697 14:37:09 INFO - PROCESS | 9045 | __metrics 14:37:09 INFO - PROCESS | 9045 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:37:10 INFO - TEST-INFO | 9045: exit 0 14:37:10 INFO - Browser initialized. 14:37:10 INFO - Running cycle 1/1 for v8_7 test... 14:37:10 INFO - TEST-INFO | started process 9166 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuoUWhv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:37:12 INFO - PROCESS | 9166 | 14:37:12 INFO - PROCESS | 9166 | (process:9224): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:37:22 INFO - PROCESS | 9166 | RSS: Main: 150974464 14:37:22 INFO - PROCESS | 9166 | 14:37:44 INFO - PROCESS | 9166 | Cycle 1(1): loaded http://localhost:33997/tests/v8_7/run.html (next: http://localhost:33997/tests/v8_7/run.html) 14:37:45 INFO - PROCESS | 9166 | RSS: Main: 146038784 14:37:45 INFO - PROCESS | 9166 | 14:37:45 INFO - PROCESS | 9166 | __start_tp_report 14:37:45 INFO - PROCESS | 9166 | _x_x_mozilla_page_load 14:37:45 INFO - PROCESS | 9166 | _x_x_mozilla_page_load_details 14:37:45 INFO - PROCESS | 9166 | |i|pagename|runs| 14:37:45 INFO - PROCESS | 9166 | |0;Richards;166.30633627141194 14:37:45 INFO - PROCESS | 9166 | |1;DeltaBlue;190.00570017100512 14:37:45 INFO - PROCESS | 9166 | |2;Encrypt;278.31895352073474 14:37:45 INFO - PROCESS | 9166 | |3;Decrypt;5196.891191709845 14:37:45 INFO - PROCESS | 9166 | |4;RayTrace;1067.2358591248667 14:37:45 INFO - PROCESS | 9166 | |5;Earley;708.2152974504249 14:37:45 INFO - PROCESS | 9166 | |6;Boyer;12292.682926829268 14:37:45 INFO - PROCESS | 9166 | |7;RegExp;41729.166666666664 14:37:45 INFO - PROCESS | 9166 | |8;Splay;572.737686139748 14:37:45 INFO - PROCESS | 9166 | |9;NavierStokes;4826.923076923077 14:37:45 INFO - PROCESS | 9166 | __end_tp_report 14:37:45 INFO - PROCESS | 9166 | __startTimestamp1452724665213__endTimestamp 14:37:45 INFO - PROCESS | 9166 | 14:37:45 INFO - PROCESS | 9166 | ------- Summary: start ------- 14:37:45 INFO - PROCESS | 9166 | Number of tests: 10 14:37:45 INFO - PROCESS | 9166 | 14:37:45 INFO - PROCESS | 9166 | [#0] Richards Cycles:1 Average:166.31 Median:166.31 stddev:0.00 (0.0%) 14:37:45 INFO - PROCESS | 9166 | Values: 166.3 14:37:45 INFO - PROCESS | 9166 | 14:37:45 INFO - PROCESS | 9166 | [#1] DeltaBlue Cycles:1 Average:190.01 Median:190.01 stddev:0.00 (0.0%) 14:37:45 INFO - PROCESS | 9166 | Values: 190.0 14:37:45 INFO - PROCESS | 9166 | 14:37:45 INFO - PROCESS | 9166 | [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 14:37:45 INFO - PROCESS | 9166 | Values: 278.3 14:37:45 INFO - PROCESS | 9166 | 14:37:45 INFO - PROCESS | 9166 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 14:37:45 INFO - PROCESS | 9166 | Values: 5196.9 14:37:45 INFO - PROCESS | 9166 | 14:37:45 INFO - PROCESS | 9166 | [#4] RayTrace Cycles:1 Average:1067.24 Median:1067.24 stddev:0.00 (0.0%) 14:37:45 INFO - PROCESS | 9166 | Values: 1067.2 14:37:45 INFO - PROCESS | 9166 | 14:37:45 INFO - PROCESS | 9166 | [#5] Earley Cycles:1 Average:708.22 Median:708.22 stddev:0.00 (0.0%) 14:37:45 INFO - PROCESS | 9166 | Values: 708.2 14:37:45 INFO - PROCESS | 9166 | 14:37:45 INFO - PROCESS | 9166 | [#6] Boyer Cycles:1 Average:12292.68 Median:12292.68 stddev:0.00 (0.0%) 14:37:45 INFO - PROCESS | 9166 | Values: 12292.7 14:37:45 INFO - PROCESS | 9166 | 14:37:45 INFO - PROCESS | 9166 | [#7] RegExp Cycles:1 Average:41729.17 Median:41729.17 stddev:0.00 (0.0%) 14:37:45 INFO - PROCESS | 9166 | Values: 41729.2 14:37:45 INFO - PROCESS | 9166 | 14:37:45 INFO - PROCESS | 9166 | [#8] Splay Cycles:1 Average:572.74 Median:572.74 stddev:0.00 (0.0%) 14:37:45 INFO - PROCESS | 9166 | Values: 572.7 14:37:45 INFO - PROCESS | 9166 | 14:37:45 INFO - PROCESS | 9166 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 14:37:45 INFO - PROCESS | 9166 | Values: 4826.9 14:37:45 INFO - PROCESS | 9166 | -------- Summary: end -------- 14:37:45 INFO - PROCESS | 9166 | 14:37:46 INFO - TEST-INFO | 9166: exit 0 14:37:46 INFO - TEST-OK | v8_7 | took 40770ms 14:37:46 INFO - SUITE-END | took 1211s 14:37:46 INFO - Completed test suite (00:20:11) 14:37:46 INFO - Working with test: dromaeo_css 14:37:46 INFO - Generating results file: dromaeo_css 14:37:46 INFO - Working with test: kraken 14:37:46 INFO - Generating results file: kraken 14:37:46 INFO - javascript benchmark 14:37:46 INFO - Working with test: v8_7 14:37:46 INFO - Generating results file: v8_7 14:37:46 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:37:46 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 14:37:46 INFO - process_Request line: dromaeo_css 6973.88 graph.html#tests=[[72,64,43]] 14:37:46 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:37:46 INFO - process_Request line: kraken 1505.80 graph.html#tests=[[232,64,43]] 14:37:46 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:37:46 INFO - process_Request line: v8_7 20469.66 graph.html#tests=[[230,64,43]] 14:37:46 INFO - RETURN: dromaeo_css: 6973.88 14:37:46 INFO - RETURN: kraken: 1505.80 14:37:46 INFO - RETURN: v8_7: 20469.66 14:37:46 INFO - javascript benchmark 14:37:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3227.451333273343, 3259.250372414343, 3291.1936575539, 3301.042697617691, 3303.12467196193, 5145.81989630363, 5283.999999999995, 5341.2789273448125, 5347.331583552056, 5355.571554275658, 5262.2632831403635, 5275.208718692198, 5377.11277639189, 5414.0, 5441.83674489765, 4892.77982490787, 4929.926051109236, 4972.577330926875, 5014.398272207341, 5017.84946451607, 4913.213885778277, 4957.628177886655, 4958.057968985881, 4994.850154495371, 5029.195328747401, 4798.448178459487, 4869.9269510957365, 4877.073356062337, 4926.285688575154, 4962.206047032476, 4906.337644417994, 4908.803647854082, 4913.975430122862, 4929.309896614477, 4929.6302777291485, 4837.467878533358, 4853.830115945925, 4896.632752543538, 4917.975410122962, 4920.114379411704, 4975.328330675348, 5093.541581257705, 5151.0, 5157.9941911327305, 5212.035773381898, 5609.046462101412, 5771.307443106812, 5823.359430462646, 5849.239598852165, 5856.32652244993, 5801.361850196475, 5825.0, 5825.650460972355, 5829.621074630136, 5830.737616807254, 5287.4448182941005, 5359.0, 5376.220448035052, 5376.542993845528, 5397.055515284809, 5825.097109947965, 5922.851928701817, 5926.851828704317, 5940.34656187819, 6004.0, 5657.4908258256955, 5674.602777805514, 5683.204351390726, 5686.943130568724, 5704.0, 5569.164625306155, 5655.3779084300695, 5688.260526131577, 5744.569157313218, 5747.252857128547, 5734.340550836624, 5756.222909907109, 5768.567357448124, 5776.364599894008, 5810.82567522975, 5637.46444087811, 5673.31920169574, 5698.458646428583, 5718.285214348207, 5734.369219385864, 4322.113966636832, 4341.544137865541, 4389.18800021997, 4404.625606823456, 4429.867103986886, 3985.740926839746, 3999.6200360965663, 4011.8796436106963, 4021.5174179098694, 4026.57720939303, 5405.918911216335, 5412.972935135299, 5422.376426710979, 5460.6177567570685, 5467.152591348347, 5590.18942253371, 5685.573581981368, 5707.229524014205, 5782.653040817564, 5814.418558144236, 5288.338957630296, 5295.0, 5313.548348390353, 5314.096603577401, 5367.946320536823, 4793.281007848851, 4801.9039619208115, 4802.6638135330195, 4811.735354555533, 4858.659893807399, 5773.711314434261, 5819.563532735062, 5915.733791979371, 5992.730327135202, 6058.485028772604, 5695.345035320825, 5716.085426331767, 5720.8569785754025, 5725.484706376446, 5726.685032323262, 5915.704214789157, 5947.405259474018, 5963.940360596339, 5966.791162309299, 5987.730552125077, 5532.723363831873, 5626.634268772516, 5631.521320687787, 5692.829215123553, 5740.540756739534, 5701.800436984686, 5755.453231942959, 5762.078067509178, 5763.279590051244, 5768.625039372428, 5441.619086663895, 5546.750396232099, 5595.188697638901, 5621.887562248814, 5637.43625637433, 5524.944750552443, 5541.889162216814, 5558.416366281644, 5603.271574695264, 5667.1782591524825, 5564.749586268708, 5575.916361254665, 5578.748956296895, 5601.915971260353, 5614.04561224601, 5507.834764957058, 5677.630953987978, 5681.261436013458, 5699.544036477155, 5704.743286552032, 5439.184122381675, 5480.260164877691, 5510.641808282448, 5516.613837031369, 5559.916601251065], "unit": "score", "name": "dojo.html", "value": 5294.158570853807}, {"lowerIsBetter": false, "replicates": [526.0531044120582, 529.1586377659521, 531.5216305325207, 549.672944597964, 551.5532418740819, 35815.64184358156, 36129.0, 36202.0, 36243.637563624354, 36255.9123226303, 40238.195236095264, 40689.593104068954, 40947.795261023726, 41038.38442423366, 41410.792946035224, 8365.58172091396, 8557.914420855805, 8562.700305489278, 8578.270846977983, 8601.827963440728, 8306.210909963544, 8496.575171241444, 8535.57322133894, 8660.480371177719, 8733.432326898763, 8405.117462666423, 8447.662093516252, 8459.280961118282, 8503.787405314886, 8506.914930850706, 8645.351598630097, 8676.8698469523, 8694.043655197924, 8737.7815554611, 8759.956200218958, 8556.315494760403, 8741.606627701769, 8764.649414023432, 8764.956175219148, 8765.517896515688, 39511.8024409879, 39746.20507589861, 39939.8003009986, 40111.7994410029, 40134.19731605351, 3423.4522476403904, 3490.2147016921244, 3515.701165400944, 3548.627394123606, 3865.2269546090615, 29390.118296450928, 30272.54591181134, 30346.241343966358, 30376.544351834742, 30385.088447346614, 3549.4675798630155, 3796.0699628591174, 3807.3717836556934, 3918.2444190696438, 4078.6940979426663, 209966.0, 210366.0, 211390.0, 211590.0, 211818.0, 51004.48995510072, 52138.73930630323, 59765.0, 59887.70056149692, 60376.39623603708, 66247.68133115415, 66555.66722166358, 66824.0, 67019.66490167615, 67356.0, 14547.3453694584, 14713.779293310396, 14731.263436828116, 14739.55781326562, 14762.704745905237, 11173.994340509393, 11270.94364528172, 11274.661760147208, 11295.717607059889, 11316.264442811356, 20027.399178024683, 20555.8972205141, 20673.379798605765, 20697.793022069887, 20720.58558828845, 7251.746188883364, 7449.255074492507, 7484.925150748423, 7513.2111128331835, 7566.368143291251, 898.2230370729272, 957.5738796235747, 986.8865080515689, 1005.0853723111933, 1064.7551063255494, 24182.87908560481, 24216.7578324218, 24463.26610201697, 25028.624570631455, 26353.604695929578, 961.9951900240454, 985.9112679858847, 1009.1825621246813, 1015.3095894791466, 1016.5577973581368, 13191.868081319257, 13284.269365184815, 13438.260895650834, 13540.322983850769, 13541.59375218745, 322459.0, 324208.0, 325174.0, 326233.0, 326913.0, 51462.74268628633, 51610.74194629003, 51976.0, 52059.73970130201, 52093.0, 1299.7205600795874, 1345.549241004255, 1366.1598117158076, 1366.41244264967, 1366.5558693424678, 25140.497190055732, 26102.73897261079, 26109.73890261073, 26355.341116472242, 26560.468790624465, 40665.0, 41524.169516610105, 41742.582574173866, 42249.78875105605, 42254.0, 319046.0, 321523.0, 321560.0, 323684.0, 324213.0, 31522.68477315289, 31768.682313176574, 32047.0, 32102.357952840346, 32170.839145804122, 42987.0, 43315.56684433115, 43475.78262108669, 44178.33732493951, 44317.33523997207, 36858.44712329371, 37000.81499592485, 37252.44121338128, 38187.42718859164, 38416.423753644274, 37796.811015944746, 37927.81036094802, 37971.43042854304, 38189.4271585932, 38773.2245355097, 36012.81993590015, 36354.0, 36834.26331473302, 36854.8157259212, 36975.81512092422, 33003.504947425325, 33250.33499329951, 34393.140171495914, 34440.483392748625, 34886.476702849985, 25905.74094259033, 26331.868340658173, 26901.0, 27195.86402068056, 27302.0], "unit": "score", "name": "ext.html", "value": 18162.327852789993}, {"lowerIsBetter": false, "replicates": [363.7526481992246, 365.89023293012093, 367.17569057465994, 367.641549489248, 369.0478565301522, 13448.798268025963, 14255.429782808702, 15651.373945042198, 17108.0, 18268.81731182688, 16010.59973500663, 16108.11405372704, 16940.576485587837, 17078.743818842726, 17107.91446042768, 5112.182050871861, 5457.727113644321, 5491.780328786844, 5524.1989911462815, 5525.696086715229, 5241.606879484035, 5424.593155513333, 5470.589705772063, 5478.616496845222, 5488.368837583689, 5438.211459338394, 5447.12845944649, 5468.398476167618, 5483.2049352843815, 5486.396496385394, 5297.867553311159, 5438.102713052342, 5440.292761940942, 5442.91835622466, 5458.563314934816, 4695.530446955311, 4802.06359759847, 4821.059893320804, 4837.371141751585, 4873.244647079673, 19652.11565479557, 19859.602807943906, 19861.0, 19996.700049499268, 20110.69833952492, 1860.4139695995852, 2191.4521369657587, 2271.6024695678357, 2281.4410469435093, 2290.358699564125, 6800.659967001679, 11744.766799486102, 12798.744025119446, 13112.0, 13599.32003399836, 1766.7349897515346, 1768.7346897965278, 1798.2267624921278, 1821.5355084453379, 1883.6044430669576, 54647.45352546503, 56411.435885641025, 57748.42251577473, 57854.42145578533, 58095.709521452125, 9774.853377199348, 10073.748156296151, 10100.242481813893, 10109.747256318651, 10141.087302142843, 12668.0, 13081.934590326988, 13087.476500940045, 13121.868781312256, 13156.736865262641, 7112.146542414944, 7360.116785985609, 7367.8894816577795, 7398.926010739824, 7412.036435263489, 7065.258147894397, 7090.078289822393, 7090.503664743522, 7134.928650713427, 7136.750213742494, 4315.136972605492, 4327.199468098412, 4348.260795664682, 4367.497737760134, 4376.803043863034, 1799.8830076045015, 1888.4429093417475, 1931.3926199630387, 1936.2932529626867, 1957.843372530194, 953.0088707743869, 976.1312431935582, 980.3921568627496, 1004.8844382895915, 1022.7903279827617, 15786.052836829827, 16168.514944551682, 16282.267297971619, 16651.833481665028, 16660.6667866642, 834.3617132893341, 900.2123142250531, 929.8372784762639, 964.6961207219704, 965.4496936745987, 8776.561171941377, 9004.684836030707, 9057.0, 9057.77355566116, 9315.254779617615, 517794.0, 522378.0, 535236.0, 558993.0, 563878.0, 73587.0, 75308.0, 76344.61827690937, 77456.61271693606, 79349.0, 1127.2053202492223, 1148.0700632487712, 1157.716359491913, 1157.8263260510823, 1160.4197901049474, 14258.144511329354, 14356.712865742835, 14421.351039203471, 14425.567232983027, 14616.123032618078, 30053.398932021675, 31527.21181970469, 32293.677063230007, 32894.67105329012, 33416.498752518244, 34717.65282347144, 40397.39403908885, 41305.58694413018, 41314.58685413228, 41475.0, 6911.5853048817235, 7171.247019062923, 7202.927970720435, 7252.419806415369, 7479.214682458263, 10704.0, 10862.293950893167, 11175.105991520497, 11293.830592540955, 11350.94324528372, 8695.434796738191, 8971.237444817263, 9001.054889236797, 9156.771080723036, 9569.760755980878, 9289.961525008799, 9377.156055954996, 9745.561449734638, 9877.851832222379, 9951.353162044445, 9488.95255523718, 9542.952285238529, 9828.0, 9846.310758246855, 10002.0, 7011.088558487364, 7017.649117544001, 7072.045273887959, 7356.926430735838, 7393.334599886036, 9246.676366327147, 9479.72023776809, 9607.711768646952, 9690.660826871308, 9770.902290977283], "unit": "score", "name": "jquery.html", "value": 8153.423805755475}, {"lowerIsBetter": false, "replicates": [1461.181738226593, 1471.8307394649614, 1657.9088150151745, 1779.644071185763, 1813.1296977450831, 7940.602969851506, 8010.439269251155, 8067.798305042377, 8115.8782618260775, 8192.91807081929, 8172.346212303001, 8233.259006689397, 8294.70968516102, 8304.169583041692, 8307.75076747697, 2407.4101845047944, 2421.152596591188, 2436.415260337524, 2442.511497700458, 2442.7190873049562, 2460.790832779216, 2462.9261122166363, 2484.0808900706766, 2492.2024952015363, 2494.8128890333296, 2378.15575470708, 2424.9272521824373, 2428.3079322393123, 2442.6702395176603, 2456.3245107595376, 2326.941826454335, 2374.050379848057, 2411.8432301900407, 2411.927642170729, 2433.221369161869, 2399.8320117591775, 2401.6877805885124, 2423.8303318767694, 2423.854568725882, 2430.769076937688, 7746.380289576877, 7828.647710853025, 7847.450678452511, 7895.644695988694, 7901.96049019757, 4924.162892308316, 4951.480094590052, 4979.975100124476, 5016.147254966664, 5052.671576347562, 3171.540126681641, 3232.046546268856, 3242.2866969266724, 3266.477363621833, 3309.0900002499507, 1020.9183265338755, 1021.0912288063629, 1040.849076883855, 1057.2968975631195, 1060.188955449082, 11281.774364512747, 11436.027937625311, 11436.142289328334, 11438.25651332669, 11495.080393568494, 4469.374287599739, 4473.217186992263, 4607.14767767964, 4728.763561821896, 4730.337752714623, 9802.460864652512, 9813.558389872473, 9857.408555486694, 9863.01369863008, 9878.0, 4982.526659967298, 5002.474740152305, 5008.724520151354, 5031.0441016206805, 5031.6729412588065, 4506.076254367847, 4524.185646583646, 4531.524189960072, 4542.159700455426, 4569.543045695404, 3759.342115129841, 3815.5993620669983, 3822.197338558878, 3826.8086595670106, 3847.0574709196426, 1164.2025212729307, 1222.1628184693514, 1226.3010084251891, 1229.3361584744316, 1235.6293112066344, 1032.8863824979246, 1064.5369264370024, 1076.0315715855793, 1235.2588446931768, 1374.5601407549489, 7385.0, 7563.73526926566, 7617.923820761832, 7628.160902300742, 7677.117131529834, 1046.795874804406, 1083.7344850511674, 1142.9142814288962, 1143.6912033750841, 1151.1884121694186, 5903.114532820111, 5966.85082872923, 5983.880322393527, 5998.700064996733, 5999.610025348338, 9299.860502092473, 9496.382735122195, 9497.0, 9585.089416505421, 9642.276829237835, 9347.298952578583, 9469.810603787886, 9485.241180705527, 9495.90504094964, 9511.239100872051, 7050.506464547535, 7166.8208294792, 7181.281871812777, 7265.600391978492, 7553.093628764584, 7440.962795185989, 7449.366803821736, 7497.550146991198, 7542.811429714301, 7573.772786816405, 8658.134186581292, 8862.77843053903, 8875.423097498642, 9010.0, 9018.0, 8657.047724750399, 8971.147740964598, 9007.63969441215, 9058.094190580889, 9100.271978241857, 7260.165081015751, 7335.486515943832, 7353.926460735324, 7363.889541656987, 7382.52013619113, 7656.119546252252, 7703.38372930153, 7706.807329816799, 7712.768616941501, 7752.26353496417, 7193.820154496179, 7376.557406555624, 7441.888371674321, 7460.776176714708, 7552.6223688816435, 7085.2560481150795, 7143.321384468467, 7228.927710722825, 7309.853802924018, 7378.852422951403, 7154.463415243774, 7174.282571742784, 7180.856382872418, 7184.748533801292, 7244.384227340735, 6585.308542603149, 6626.734930602722, 6666.566673166229, 6676.198856137295, 6704.597724136567, 6769.356911093439, 6830.93169068303, 6838.316168383122, 6921.031055652112, 6966.268541803038], "unit": "score", "name": "mootools.html", "value": 4693.686251106737}, {"lowerIsBetter": false, "replicates": [329.1048348492101, 339.4060394309957, 351.38858386407657, 351.5974209530087, 355.11753293066727, 6125.693715314239, 6263.248410190778, 6283.371662833714, 6286.2456505219325, 6313.842153946148, 6093.0, 6216.813495595128, 6226.3462336454695, 6243.282022567395, 6256.874862502747, 4742.834000809972, 4751.809927602892, 4752.287156926454, 4762.809487620491, 4766.165920963817, 4744.0, 4764.094821983829, 4768.308595253686, 4772.498887616803, 4776.092542416947, 4667.346571479996, 4729.78715957781, 4775.665703400763, 4778.163821331271, 4786.2581299898575, 4745.525447455261, 4754.239321708527, 4762.833300834454, 4765.21373973294, 4765.904681906342, 4158.08522125132, 4158.397032430311, 4172.77049762263, 4179.477565304337, 4186.162767446493, 5955.04719244923, 5963.612365196248, 5971.820845374602, 5978.192943952554, 5986.580939334249, 5480.369757477902, 5531.640443371168, 5537.975474537224, 5541.639793413456, 5542.2795036644975, 6664.133662623828, 6708.597484150918, 6710.094137291452, 6715.7985260442265, 6720.899186512206, 4580.083983203339, 4585.610223131038, 4585.968157164644, 4588.49526552079, 4595.988882445857, 6785.796426107225, 6967.407770339527, 6968.0, 6971.477139214579, 6986.790396288119, 4688.976555117202, 4692.507286734912, 4695.178343789891, 4705.058988202373, 4723.645726570452, 4736.739479328601, 4738.976305118521, 4742.672051825494, 4754.168020596382, 4770.284457331359, 5509.972450137804, 5520.337559492887, 5523.530499907552, 5527.39198688144, 5538.6399884007415, 6525.902111468332, 6723.327667233335, 6744.393004629509, 6753.189617245864, 6759.188897332253, 1637.7461493468531, 1641.0563925742506, 1682.4616122840819, 1683.0, 1685.536477468706, 1103.9944800275948, 1106.435717783936, 1114.0419239454063, 1121.4280716834473, 1131.8754936956927, 6207.006878899354, 6270.717817698123, 6272.905906411407, 6279.686015699197, 6301.40136687014, 6799.422049125781, 6808.523403361717, 6814.773340798703, 6825.419839313714, 6832.555883867532, 6152.8769424611255, 6298.149749783812, 6300.810975670645, 6301.842453938688, 6313.905291420632, 3682.5949145593963, 3707.629237076325, 3710.5361829771277, 3713.090292878208, 3716.0, 7069.929300706927, 7098.0, 7125.3230943060325, 7130.607816570138, 7157.4274058075225, 6908.792736217922, 6971.721131154798, 6976.895346569806, 6982.301769823079, 6994.545354551938, 7244.420446364278, 7251.129864416198, 7285.562866227937, 7300.853982920418, 7314.853702926018, 6920.757773478105, 6923.446124309942, 6934.583924964519, 6943.236244013054, 6967.825804354931, 6756.69594868242, 6835.282295358916, 6844.349786770249, 6893.655317234018, 6923.29991303382, 7166.2475440080125, 7215.60314182725, 7286.307800758919, 7287.526310789782, 7296.817579560554, 4642.280446530793, 4686.976565117153, 4687.1328804171335, 4691.788869500949, 4695.319178718998, 6812.420944219599, 6983.301669833179, 6991.370776630128, 6997.7200911962955, 7012.053372794608, 6760.830979225559, 6774.390304872585, 6778.627175505395, 6778.7288508459105, 6779.762708305383, 6746.527743057939, 6747.628880411428, 6755.392014718699, 6778.389944904982, 6814.318568143146, 6515.837104072436, 6557.508186886098, 6654.866902662016, 6665.0, 6669.799906002828, 6774.559653622498, 6794.150731158606, 6800.863982720219, 6801.625910574768, 6822.147231596051, 6604.339566043357, 6629.834254143685, 6640.435562977201, 6661.0, 6663.100481434944], "unit": "score", "name": "prototype.html", "value": 5022.366295156309}, {"lowerIsBetter": false, "replicates": [717.9425645948323, 779.8089468080319, 843.2958479669476, 850.4174640371347, 872.027689126624, 13752.381142848571, 13784.379702913368, 13871.167729936198, 13949.093308934926, 13971.860281397183, 12964.675883102927, 13021.479140834355, 13054.347282635877, 13072.934635326834, 13136.54022109224, 589.1957478042463, 597.1013624495129, 776.1036003416035, 779.111812533712, 790.3084800799301, 787.2285160542672, 791.8812178173263, 792.8612492813763, 795.4948607634136, 800.2477670989281, 826.89663792026, 828.2628460670009, 828.2669837194067, 829.9419040667156, 835.9038710548274, 819.2626636027563, 820.5527987246965, 823.4359463767308, 828.4242451496212, 833.125218520554, 601.9006863867456, 605.9242594675666, 608.5679167790873, 609.5123900879323, 609.5672072828297, 13487.055906086578, 13591.116577422536, 13595.252261125634, 13625.795613065811, 13656.385462654105, 12690.682732931658, 12731.61805145847, 12779.680507987374, 12908.483660653563, 13019.414126364336, 10365.326253793479, 10406.375617462976, 10440.47797610124, 10479.161667066617, 10491.632792852213, 3494.7204223662047, 3592.191756854713, 3594.245208506217, 3599.8200089995657, 3711.573169085536, 47066.764666176794, 47540.762296188295, 47774.52225477735, 48042.0, 48087.278690819665, 9650.662226822027, 9738.220942324597, 9774.413535187912, 9954.104130628279, 9990.500474976223, 17163.828361716223, 17256.827431725524, 17283.222254998556, 17292.13539323054, 17430.738538921927, 7053.964730176419, 7104.751333703295, 7208.891866622005, 7353.889691654629, 7535.886961695579, 4225.0, 4299.849505267301, 4303.031817841023, 4321.7406955582765, 4340.82636694535, 3189.920251993719, 3190.2343437574814, 3201.4077395681875, 3205.7114859662743, 3217.6621454747383, 490.82821012646, 492.26406522249465, 508.75325467148406, 511.80551390471385, 515.4587682932905, 648.6302807399832, 652.8922727749868, 668.208173314614, 670.2560158224367, 673.0173946038838, 8592.527410992456, 8730.083341249205, 8752.649894004297, 8877.689280875138, 8995.32535059873, 518.7847043476991, 605.4101109423865, 608.9421504957022, 675.0818886314609, 684.7158429251905, 4218.0, 4219.38818871262, 4229.344451610005, 4260.91478170441, 4288.4210631564965, 53405.465945340824, 53415.0, 53546.46453535493, 53636.19545706818, 54529.72735136299, 51935.48064519382, 52050.21924671133, 52545.211821822704, 53123.20315195275, 53791.193132102264, 46223.5377646226, 46907.0, 47094.76452617784, 47111.0, 49696.0060798782, 8581.742547723577, 8857.846018951423, 8943.105689431004, 9048.819023619359, 9192.080791920755, 33727.0, 34093.829530852185, 34606.328145700005, 35019.0, 35084.29831403409, 39916.60083399129, 43473.0, 43523.0, 43637.0, 43705.56294437015, 10190.184785217312, 10376.377417354983, 10379.0, 10649.53519454266, 10714.410707411167, 11789.268564270113, 12004.459799309227, 12007.879921201025, 12054.638360849189, 12057.879421205676, 10879.401632910265, 10899.673009809718, 11064.0, 11123.499442524944, 11277.436128193722, 11262.774744505228, 11453.656390308304, 11534.250273732181, 11611.593594224161, 11910.642680719593, 11132.276402033842, 11382.0, 11767.588134415597, 11791.469383877575, 12040.397980101136, 8631.482111073356, 8754.824903502022, 8856.690015849414, 8992.46045237288, 9215.400998935047, 8722.302215822592, 8851.203391694778, 9513.238940884574, 9637.759056023375, 10074.69775906724], "unit": "score", "name": "yui.html", "value": 6224.163190582837}], "name": "dromaeo_css", "value": 6973.878372615504}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 112.0, 112.0, 111.0, 124.0, 112.0, 112.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.8}, {"lowerIsBetter": true, "replicates": [153.0, 131.0, 156.0, 163.0, 136.0, 155.0, 148.0, 127.0, 168.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 147.0}, {"lowerIsBetter": true, "replicates": [164.0, 164.0, 162.0, 163.0, 164.0, 162.0, 163.0, 169.0, 166.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.9}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 75.0, 73.0, 71.0, 131.0, 71.0, 73.0, 84.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.3}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 140.0, 95.0, 95.0, 95.0, 143.0, 96.0, 95.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 108.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 146.0, 147.0, 148.0, 148.0, 148.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 97.0, 98.0, 96.0, 96.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [63.0, 59.0, 59.0, 61.0, 60.0, 58.0, 59.0, 61.0, 57.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 59.5}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 69.0, 70.0, 69.0, 68.0, 69.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 83.0, 84.0, 82.0, 91.0, 84.0, 83.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [115.0, 115.0, 123.0, 118.0, 130.0, 118.0, 124.0, 118.0, 116.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.9}, {"lowerIsBetter": true, "replicates": [136.0, 152.0, 142.0, 141.0, 150.0, 145.0, 141.0, 138.0, 143.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 74.0, 66.0, 68.0, 64.0, 65.0, 69.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1505.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.30633627141194], "unit": "score", "name": "Richards", "value": 212.27092600000003}, {"lowerIsBetter": false, "replicates": [190.00570017100512], "unit": "score", "name": "DeltaBlue", "value": 347.979034}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1067.2358591248667], "unit": "score", "name": "RayTrace", "value": 693.3696929999998}, {"lowerIsBetter": false, "replicates": [708.2152974504249], "unit": "score", "name": "Earley", "value": 941.0457559999996}, {"lowerIsBetter": false, "replicates": [12292.682926829268], "unit": "score", "name": "Boyer", "value": 54.21623611111113}, {"lowerIsBetter": false, "replicates": [41729.166666666664], "unit": "score", "name": "RegExp", "value": 21.830893659510746}, {"lowerIsBetter": false, "replicates": [572.737686139748], "unit": "score", "name": "Splay", "value": 142.28328599999995}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20469.663136092502}]} 14:37:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20469.66"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1505.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6973.88"}}} 14:37:46 INFO - Return code: 0 14:37:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:37:46 INFO - # TBPL SUCCESS # 14:37:46 INFO - Running post-action listener: _resource_record_post_action 14:37:46 INFO - Running post-run listener: _resource_record_post_run 14:37:47 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 12288; Write bytes: 411824128; Read time: 32; Write time: 216352 14:37:47 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 95227904; Read time: 8; Write time: 42656 14:37:47 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 8192; Write bytes: 316596224; Read time: 24; Write time: 173696 14:37:47 INFO - Running post-run listener: _upload_blobber_files 14:37:47 INFO - Blob upload gear active. 14:37:47 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:37:47 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:37:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 14:37:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 14:37:48 INFO - (blobuploader) - INFO - Open directory for files ... 14:37:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:37:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:37:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:37:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:37:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:37:48 INFO - (blobuploader) - INFO - Done attempting. 14:37:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:37:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:37:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:37:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:37:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:37:50 INFO - (blobuploader) - INFO - Done attempting. 14:37:50 INFO - (blobuploader) - INFO - Iteration through files over. 14:37:50 INFO - Return code: 0 14:37:50 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:37:50 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:37:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df23b5121091070da2a8563c2dfe82c1a514eb30ba38aa822f423538748d1b5a873b00a955a72f67f7f564016e95ccf2b6240f63c07d54b1d4660ffd944ef26d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e645137e0129d1acf4a535436f44b2352f0d9c89b32f341b7d9b5fd8a7ba2765cd54d16d8607bae4634de0cfe4aef2b3025ee6f3695aaa9425778d81de5d1bfb"} 14:37:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:37:50 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:37:50 INFO - Contents: 14:37:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df23b5121091070da2a8563c2dfe82c1a514eb30ba38aa822f423538748d1b5a873b00a955a72f67f7f564016e95ccf2b6240f63c07d54b1d4660ffd944ef26d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e645137e0129d1acf4a535436f44b2352f0d9c89b32f341b7d9b5fd8a7ba2765cd54d16d8607bae4634de0cfe4aef2b3025ee6f3695aaa9425778d81de5d1bfb"} 14:37:50 INFO - Copying logs to upload dir... 14:37:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1274.896257 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-13 14:37:49.929122) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 14:37:49.933378) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1452722873.394500-2134549360 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/df23b5121091070da2a8563c2dfe82c1a514eb30ba38aa822f423538748d1b5a873b00a955a72f67f7f564016e95ccf2b6240f63c07d54b1d4660ffd944ef26d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e645137e0129d1acf4a535436f44b2352f0d9c89b32f341b7d9b5fd8a7ba2765cd54d16d8607bae4634de0cfe4aef2b3025ee6f3695aaa9425778d81de5d1bfb"} build_url:https://queue.taskcluster.net/v1/task/PjFhipT1RyOLTqkYSkX4MA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011302 build_url: 'https://queue.taskcluster.net/v1/task/PjFhipT1RyOLTqkYSkX4MA/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/df23b5121091070da2a8563c2dfe82c1a514eb30ba38aa822f423538748d1b5a873b00a955a72f67f7f564016e95ccf2b6240f63c07d54b1d4660ffd944ef26d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e645137e0129d1acf4a535436f44b2352f0d9c89b32f341b7d9b5fd8a7ba2765cd54d16d8607bae4634de0cfe4aef2b3025ee6f3695aaa9425778d81de5d1bfb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 14:37:49.965991) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 14:37:49.966660) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1452722873.394500-2134549360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004567 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 14:37:50.050210) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 14:37:50.050602) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 14:37:50.050970) ========= ========= Total master_lag: 0.25 =========