builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-026 starttime: 1450832663.29 results: success (0) buildid: 20151222143005 builduid: 8aa7d3ed96f34592b8b153024e64d230 revision: 645cb0f2d2836e5daddff06665bbd306a8b9093d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 17:04:23.289092) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 17:04:23.289541) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 17:04:23.289819) ========= 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=a65b340e283ce644d68cb24e000001c9-1450830720.969814-642385902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006351 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 17:04:23.313212) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 17:04:23.313535) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 17:04:23.357442) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 17:04:23.357731) ========= 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=a65b340e283ce644d68cb24e000001c9-1450830720.969814-642385902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004570 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 17:04:23.407815) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 17:04:23.408106) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 17:04:23.408469) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 17:04:23.408743) ========= 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=a65b340e283ce644d68cb24e000001c9-1450830720.969814-642385902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-22 17:04:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2015-12-22 17:04:23 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169610 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 17:04:23.590390) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 17:04:23.590699) ========= 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=a65b340e283ce644d68cb24e000001c9-1450830720.969814-642385902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016064 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 17:04:23.639596) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 17:04:23.639952) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 645cb0f2d2836e5daddff06665bbd306a8b9093d --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 645cb0f2d2836e5daddff06665bbd306a8b9093d --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=a65b340e283ce644d68cb24e000001c9-1450830720.969814-642385902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-22 17:04:23,999 truncating revision to first 12 chars 2015-12-22 17:04:23,999 Setting DEBUG logging. 2015-12-22 17:04:23,999 attempt 1/10 2015-12-22 17:04:23,999 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/645cb0f2d283?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-22 17:04:24,260 unpacking tar archive at: fx-team-645cb0f2d283/testing/mozharness/ program finished with exit code 0 elapsedTime=0.521746 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 17:04:24.174857) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 17:04:24.175232) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 17:04:24.184638) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 17:04:24.185198) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 17:04:24.185813) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-22 17:04:24.186162) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a65b340e283ce644d68cb24e000001c9-1450830720.969814-642385902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:04:24 INFO - MultiFileLogger online at 20151222 17:04:24 in /builds/slave/test-pgo 17:04:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:04:24 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:04:24 INFO - {'append_to_log': False, 17:04:24 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:04:24 INFO - 'blob_upload_branch': 'Fx-Team', 17:04:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:04:24 INFO - 'branch': 'Fx-Team', 17:04:24 INFO - 'buildbot_json_path': 'buildprops.json', 17:04:24 INFO - 'config_files': ('talos/linux_config.py',), 17:04:24 INFO - 'default_actions': ('clobber', 17:04:24 INFO - 'read-buildbot-config', 17:04:24 INFO - 'download-and-extract', 17:04:24 INFO - 'populate-webroot', 17:04:24 INFO - 'create-virtualenv', 17:04:24 INFO - 'install', 17:04:24 INFO - 'run-tests'), 17:04:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:04:24 INFO - 'download_minidump_stackwalk': True, 17:04:24 INFO - 'download_symbols': 'ondemand', 17:04:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:04:24 INFO - 'tooltool.py': '/tools/tooltool.py', 17:04:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:04:24 INFO - '/tools/misc-python/virtualenv.py')}, 17:04:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:04:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:04:24 INFO - 'installer_path': 'installer.exe', 17:04:24 INFO - 'log_level': 'info', 17:04:24 INFO - 'log_name': 'talos', 17:04:24 INFO - 'log_to_console': True, 17:04:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:04:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:04:24 INFO - 'opt_config_files': (), 17:04:24 INFO - 'pip_index': False, 17:04:24 INFO - 'sps_profile': False, 17:04:24 INFO - 'sps_profile_interval': 0, 17:04:24 INFO - 'suite': 'dromaeojs-e10s', 17:04:24 INFO - 'system_bits': '64', 17:04:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:04:24 INFO - 'title': 'talos-linux64-ix-026', 17:04:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:04:24 INFO - 'use_talos_json': True, 17:04:24 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:04:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:04:24 INFO - 'work_dir': 'build'} 17:04:24 INFO - ##### 17:04:24 INFO - ##### Running clobber step. 17:04:24 INFO - ##### 17:04:24 INFO - Running pre-action listener: _resource_record_pre_action 17:04:24 INFO - Running main action method: clobber 17:04:24 INFO - rmtree: /builds/slave/test-pgo/build 17:04:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:04:25 INFO - Running post-action listener: _resource_record_post_action 17:04:25 INFO - ##### 17:04:25 INFO - ##### Running read-buildbot-config step. 17:04:25 INFO - ##### 17:04:25 INFO - Running pre-action listener: _resource_record_pre_action 17:04:25 INFO - Running main action method: read_buildbot_config 17:04:25 INFO - Using buildbot properties: 17:04:25 INFO - { 17:04:25 INFO - "project": "", 17:04:25 INFO - "product": "firefox", 17:04:25 INFO - "script_repo_revision": "production", 17:04:25 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:04:25 INFO - "repository": "", 17:04:25 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:04:25 INFO - "buildid": "20151222143005", 17:04:25 INFO - "pgo_build": "True", 17:04:25 INFO - "basedir": "/builds/slave/test-pgo", 17:04:25 INFO - "buildnumber": 401, 17:04:25 INFO - "slavename": "talos-linux64-ix-026", 17:04:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:04:25 INFO - "platform": "ubuntu64_hw", 17:04:25 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:04:25 INFO - "branch": "fx-team", 17:04:25 INFO - "repo_path": "integration/fx-team", 17:04:25 INFO - "revision": "645cb0f2d2836e5daddff06665bbd306a8b9093d", 17:04:25 INFO - "stage_platform": "linux64-pgo", 17:04:25 INFO - "builduid": "8aa7d3ed96f34592b8b153024e64d230", 17:04:25 INFO - "slavebuilddir": "test" 17:04:25 INFO - } 17:04:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 17:04:25 INFO - Running post-action listener: _resource_record_post_action 17:04:25 INFO - ##### 17:04:25 INFO - ##### Running download-and-extract step. 17:04:25 INFO - ##### 17:04:25 INFO - Running pre-action listener: _resource_record_pre_action 17:04:25 INFO - Running main action method: download_and_extract 17:04:25 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:04:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:25 INFO - https://queue.taskcluster.net/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:04:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/test_packages.json 17:04:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/test_packages.json 17:04:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 17:04:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 17:04:26 INFO - Downloaded 1302 bytes. 17:04:26 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 17:04:26 INFO - Using the following test package requirements: 17:04:26 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:04:26 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:04:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:04:26 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:04:26 INFO - u'jsshell-linux-x86_64.zip'], 17:04:26 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:04:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:04:26 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:04:26 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:04:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:04:26 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:04:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:04:26 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:04:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:04:26 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:04:26 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:04:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:04:26 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:04:26 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')]} 17:04:26 INFO - https://queue.taskcluster.net/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:04:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:04:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:04:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/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 17:04:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/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 17:04:28 INFO - Downloaded 23176547 bytes. 17:04:28 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 17:04:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:04:28 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 17:04:29 INFO - Return code: 0 17:04:29 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 17:04:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:29 INFO - https://queue.taskcluster.net/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:04:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:04:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:04:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/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 17:04:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/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 17:04:32 INFO - Downloaded 23176547 bytes. 17:04:32 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 17:04:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:04:32 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 17:04:33 INFO - Return code: 0 17:04: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')]} 17:04:33 INFO - https://queue.taskcluster.net/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:04:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:04:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:04:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/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 17:04:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/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 17:04:34 INFO - Downloaded 11132277 bytes. 17:04:34 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 17:04:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:04:34 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 17:04:34 INFO - Return code: 0 17:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:34 INFO - https://queue.taskcluster.net/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:04:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:04:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:04:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/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 17:04:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JDjODWhqTOqY6mOmBWxxMw/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 17:04:36 INFO - Downloaded 54924809 bytes. 17:04:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:04:36 INFO - mkdir: /builds/slave/test-pgo/properties 17:04:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:04:36 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:04:36 INFO - Contents: 17:04:36 INFO - build_url:https://queue.taskcluster.net/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:04:36 INFO - Running post-action listener: _resource_record_post_action 17:04:36 INFO - Running post-action listener: set_extra_try_arguments 17:04:36 INFO - ##### 17:04:36 INFO - ##### Running populate-webroot step. 17:04:36 INFO - ##### 17:04:36 INFO - Running pre-action listener: _resource_record_pre_action 17:04:36 INFO - Running main action method: populate_webroot 17:04:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:04:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:04:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:04:36 INFO - '--tppagecycles', 17:04:36 INFO - '7'], 17:04:36 INFO - 'tests': ['tsvgm']}}, 17:04:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:04:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:04:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:04:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:04:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:04:36 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:04:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:04:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:36 INFO - 'talos_options': ['--e10s'], 17:04:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:04:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:36 INFO - 'tests': ['damp', 'tps']}, 17:04:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:36 INFO - 'talos_options': ['--e10s'], 17:04:36 INFO - 'tests': ['damp', 'tps']}, 17:04:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:04:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:04:36 INFO - 'other': {'tests': ['a11yr', 17:04:36 INFO - 'ts_paint', 17:04:36 INFO - 'tpaint', 17:04:36 INFO - 'sessionrestore', 17:04:36 INFO - 'sessionrestore_no_auto_restore']}, 17:04:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:04:36 INFO - 'tests': ['a11yr', 17:04:36 INFO - 'ts_paint', 17:04:36 INFO - 'tpaint', 17:04:36 INFO - 'sessionrestore', 17:04:36 INFO - 'sessionrestore_no_auto_restore']}, 17:04:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:04:36 INFO - 'tests': ['a11yr', 17:04:36 INFO - 'ts_paint', 17:04:36 INFO - 'tpaint', 17:04:36 INFO - 'sessionrestore', 17:04:36 INFO - 'sessionrestore_no_auto_restore']}, 17:04:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:04:36 INFO - 'tests': ['a11yr', 17:04:36 INFO - 'ts_paint', 17:04:36 INFO - 'tpaint', 17:04:36 INFO - 'sessionrestore', 17:04:36 INFO - 'sessionrestore_no_auto_restore']}, 17:04:36 INFO - 'other_l64': {'tests': ['a11yr', 17:04:36 INFO - 'ts_paint', 17:04:36 INFO - 'tpaint', 17:04:36 INFO - 'sessionrestore', 17:04:36 INFO - 'sessionrestore_no_auto_restore']}, 17:04:36 INFO - 'other_nol64': {'tests': ['a11yr', 17:04:36 INFO - 'ts_paint', 17:04:36 INFO - 'tpaint', 17:04:36 INFO - 'sessionrestore', 17:04:36 INFO - 'sessionrestore_no_auto_restore']}, 17:04:36 INFO - 'svgr': {'tests': ['tsvgx', 17:04:36 INFO - 'tsvgr_opacity', 17:04:36 INFO - 'tart', 17:04:36 INFO - 'tscrollx', 17:04:36 INFO - 'cart']}, 17:04:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:04:36 INFO - 'tests': ['tsvgx', 17:04:36 INFO - 'tsvgr_opacity', 17:04:36 INFO - 'tart', 17:04:36 INFO - 'tscrollx', 17:04:36 INFO - 'cart']}, 17:04:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:36 INFO - 'tests': ['tp5o']}, 17:04:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:36 INFO - 'talos_options': ['--e10s'], 17:04:36 INFO - 'tests': ['tp5o']}, 17:04:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:36 INFO - 'talos_options': ['--xperf_path', 17:04:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:04:36 INFO - 'tests': ['tp5n']}, 17:04:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:36 INFO - 'talos_options': ['--e10s', 17:04:36 INFO - '--xperf_path', 17:04:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:04:36 INFO - 'tests': ['tp5n']}}, 17:04:36 INFO - 'talos.zip': {'path': '', 17:04:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:04:36 INFO - Running post-action listener: _resource_record_post_action 17:04:36 INFO - ##### 17:04:36 INFO - ##### Running create-virtualenv step. 17:04:36 INFO - ##### 17:04:36 INFO - Running pre-action listener: _resource_record_pre_action 17:04:36 INFO - Running main action method: create_virtualenv 17:04:36 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:04:36 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 17:04:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:04:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:04:36 INFO - Using real prefix '/usr' 17:04:36 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:04:37 INFO - Installing distribute.............................................................................................................................................................................................done. 17:04:39 INFO - Installing pip.................done. 17:04:39 INFO - Return code: 0 17:04:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:04:39 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')]} 17:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:39 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')]} 17:04:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:39 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 0x7fe590c27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a32840>, '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 0x299f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299fb60>, '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': 'a65b340e283ce644d68cb24e000001c9-1450830720.969814-642385902', '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 17:04:39 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 17:04:39 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 17:04:39 INFO - Using env: {'DISPLAY': ':0', 17:04:39 INFO - 'HOME': '/home/cltbld', 17:04:39 INFO - 'LANG': 'en_US.UTF-8', 17:04:39 INFO - 'LANGUAGE': 'en_US:en', 17:04:39 INFO - 'LOGNAME': 'cltbld', 17:04:39 INFO - 'MAIL': '/var/mail/cltbld', 17:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:39 INFO - 'MOZ_NO_REMOTE': '1', 17:04:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:39 INFO - 'NO_EM_RESTART': '1', 17:04:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:39 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:39 INFO - 'SHELL': '/bin/bash', 17:04:39 INFO - 'SHLVL': '1', 17:04:39 INFO - 'TERM': 'linux', 17:04:39 INFO - 'TMOUT': '86400', 17:04:39 INFO - 'USER': 'cltbld', 17:04:39 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1450830720.969814-642385902', 17:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:39 INFO - '_': '/tools/buildbot/bin/python'} 17:04:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:39 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 17:04:39 INFO - Cleaning up... 17:04:39 INFO - Return code: 0 17:04:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:04:39 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')]} 17:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:39 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')]} 17:04:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:39 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 0x7fe590c27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a32840>, '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 0x299f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299fb60>, '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': 'a65b340e283ce644d68cb24e000001c9-1450830720.969814-642385902', '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 17:04:39 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 17:04:39 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 17:04:39 INFO - Using env: {'DISPLAY': ':0', 17:04:39 INFO - 'HOME': '/home/cltbld', 17:04:39 INFO - 'LANG': 'en_US.UTF-8', 17:04:39 INFO - 'LANGUAGE': 'en_US:en', 17:04:39 INFO - 'LOGNAME': 'cltbld', 17:04:39 INFO - 'MAIL': '/var/mail/cltbld', 17:04:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:39 INFO - 'MOZ_NO_REMOTE': '1', 17:04:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:39 INFO - 'NO_EM_RESTART': '1', 17:04:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:39 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:39 INFO - 'SHELL': '/bin/bash', 17:04:39 INFO - 'SHLVL': '1', 17:04:39 INFO - 'TERM': 'linux', 17:04:39 INFO - 'TMOUT': '86400', 17:04:39 INFO - 'USER': 'cltbld', 17:04:39 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1450830720.969814-642385902', 17:04:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:39 INFO - '_': '/tools/buildbot/bin/python'} 17:04:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:39 INFO - Downloading/unpacking psutil>=0.7.1 17:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:41 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 17:04:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:04:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:04:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:04:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:04:41 INFO - Installing collected packages: psutil 17:04:41 INFO - Running setup.py install for psutil 17:04:41 INFO - building 'psutil._psutil_linux' extension 17:04:41 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 17:04:41 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 17:04:41 INFO - building 'psutil._psutil_posix' extension 17:04:41 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 17:04:41 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 17:04:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:04:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:04:42 INFO - Successfully installed psutil 17:04:42 INFO - Cleaning up... 17:04:42 INFO - Return code: 0 17:04:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe590c27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a32840>, '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 0x299f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299fb60>, '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': 'a65b340e283ce644d68cb24e000001c9-1450830720.969814-642385902', '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 17:04:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 17:04:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:04:42 INFO - Using env: {'DISPLAY': ':0', 17:04:42 INFO - 'HOME': '/home/cltbld', 17:04:42 INFO - 'LANG': 'en_US.UTF-8', 17:04:42 INFO - 'LANGUAGE': 'en_US:en', 17:04:42 INFO - 'LOGNAME': 'cltbld', 17:04:42 INFO - 'MAIL': '/var/mail/cltbld', 17:04:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:42 INFO - 'MOZ_NO_REMOTE': '1', 17:04:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:42 INFO - 'NO_EM_RESTART': '1', 17:04:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:42 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:42 INFO - 'SHELL': '/bin/bash', 17:04:42 INFO - 'SHLVL': '1', 17:04:42 INFO - 'TERM': 'linux', 17:04:42 INFO - 'TMOUT': '86400', 17:04:42 INFO - 'USER': 'cltbld', 17:04:42 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1450830720.969814-642385902', 17:04:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:42 INFO - '_': '/tools/buildbot/bin/python'} 17:04:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:04:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:04:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:04:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:04:44 INFO - Installing collected packages: mozsystemmonitor 17:04:44 INFO - Running setup.py install for mozsystemmonitor 17:04:44 INFO - Successfully installed mozsystemmonitor 17:04:44 INFO - Cleaning up... 17:04:44 INFO - Return code: 0 17:04:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:04: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')]} 17:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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')]} 17:04:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:44 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 0x7fe590c27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a32840>, '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 0x299f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299fb60>, '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': 'a65b340e283ce644d68cb24e000001c9-1450830720.969814-642385902', '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 17:04:44 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 17:04:44 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 17:04:44 INFO - Using env: {'DISPLAY': ':0', 17:04:44 INFO - 'HOME': '/home/cltbld', 17:04:44 INFO - 'LANG': 'en_US.UTF-8', 17:04:44 INFO - 'LANGUAGE': 'en_US:en', 17:04:44 INFO - 'LOGNAME': 'cltbld', 17:04:44 INFO - 'MAIL': '/var/mail/cltbld', 17:04:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:44 INFO - 'MOZ_NO_REMOTE': '1', 17:04:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:44 INFO - 'NO_EM_RESTART': '1', 17:04:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:44 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:44 INFO - 'SHELL': '/bin/bash', 17:04:44 INFO - 'SHLVL': '1', 17:04:44 INFO - 'TERM': 'linux', 17:04:44 INFO - 'TMOUT': '86400', 17:04:44 INFO - 'USER': 'cltbld', 17:04:44 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1450830720.969814-642385902', 17:04:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:44 INFO - '_': '/tools/buildbot/bin/python'} 17:04:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:44 INFO - Downloading/unpacking blobuploader==1.2.4 17:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:46 INFO - Downloading blobuploader-1.2.4.tar.gz 17:04:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:04:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:04:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:04:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:04:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:46 INFO - Downloading docopt-0.6.1.tar.gz 17:04:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:04:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:04:46 INFO - Installing collected packages: blobuploader, requests, docopt 17:04:46 INFO - Running setup.py install for blobuploader 17:04:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:04:46 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:04:46 INFO - Running setup.py install for requests 17:04:47 INFO - Running setup.py install for docopt 17:04:47 INFO - Successfully installed blobuploader requests docopt 17:04:47 INFO - Cleaning up... 17:04:47 INFO - Return code: 0 17:04:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:47 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 0x7fe590c27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a32840>, '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 0x299f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299fb60>, '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': 'a65b340e283ce644d68cb24e000001c9-1450830720.969814-642385902', '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 17:04:47 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 17:04:47 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 17:04:47 INFO - Using env: {'DISPLAY': ':0', 17:04:47 INFO - 'HOME': '/home/cltbld', 17:04:47 INFO - 'LANG': 'en_US.UTF-8', 17:04:47 INFO - 'LANGUAGE': 'en_US:en', 17:04:47 INFO - 'LOGNAME': 'cltbld', 17:04:47 INFO - 'MAIL': '/var/mail/cltbld', 17:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:47 INFO - 'MOZ_NO_REMOTE': '1', 17:04:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:47 INFO - 'NO_EM_RESTART': '1', 17:04:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:47 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:47 INFO - 'SHELL': '/bin/bash', 17:04:47 INFO - 'SHLVL': '1', 17:04:47 INFO - 'TERM': 'linux', 17:04:47 INFO - 'TMOUT': '86400', 17:04:47 INFO - 'USER': 'cltbld', 17:04:47 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1450830720.969814-642385902', 17:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:47 INFO - '_': '/tools/buildbot/bin/python'} 17:04:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:04:47 INFO - Running setup.py (path:/tmp/pip-2AbkRI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:04:47 INFO - Running setup.py (path:/tmp/pip-paf0yJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:04:47 INFO - Running setup.py (path:/tmp/pip-7FB_cI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:04:47 INFO - Running setup.py (path:/tmp/pip-cOGvmD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:04:47 INFO - Running setup.py (path:/tmp/pip-F_qNu8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:04:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:04:47 INFO - Running setup.py (path:/tmp/pip-6aeESk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:04:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:04:48 INFO - Running setup.py (path:/tmp/pip-DHjmXW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:04:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:04:48 INFO - Running setup.py (path:/tmp/pip-tKIa8_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:04:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:04:48 INFO - Running setup.py (path:/tmp/pip-FWkaGW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:04:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:04:48 INFO - Running setup.py (path:/tmp/pip-DBK11C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:04:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:04:48 INFO - Running setup.py (path:/tmp/pip-KArM3l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:04:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:04:48 INFO - Running setup.py (path:/tmp/pip-yictFT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:04:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:04:48 INFO - Running setup.py (path:/tmp/pip-qQczNZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:04:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:04:48 INFO - Running setup.py (path:/tmp/pip-LmZ8rl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:04:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:04:48 INFO - Running setup.py (path:/tmp/pip-Yf0zSS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:04:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:04:48 INFO - Running setup.py (path:/tmp/pip-4EPQ2s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:04:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:04:48 INFO - Running setup.py (path:/tmp/pip-wJbhhE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:04:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:04:48 INFO - Running setup.py install for manifestparser 17:04:48 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:04:48 INFO - Running setup.py install for mozcrash 17:04:49 INFO - Running setup.py install for mozdebug 17:04:49 INFO - Running setup.py install for mozdevice 17:04:49 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:04:49 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:04:49 INFO - Running setup.py install for mozfile 17:04:49 INFO - Running setup.py install for mozhttpd 17:04:49 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:04:49 INFO - Running setup.py install for mozinfo 17:04:49 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:04:49 INFO - Running setup.py install for mozInstall 17:04:49 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:04:49 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:04:49 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:04:49 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:04:49 INFO - Running setup.py install for mozleak 17:04:49 INFO - Running setup.py install for mozlog 17:04:49 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:04:49 INFO - Running setup.py install for moznetwork 17:04:49 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:04:49 INFO - Running setup.py install for mozprocess 17:04:50 INFO - Running setup.py install for mozprofile 17:04:50 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:04:50 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:04:50 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:04:50 INFO - Running setup.py install for mozrunner 17:04:50 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:04:50 INFO - Running setup.py install for mozscreenshot 17:04:50 INFO - Running setup.py install for moztest 17:04:50 INFO - Running setup.py install for mozversion 17:04:50 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:04:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:04:50 INFO - Cleaning up... 17:04:50 INFO - Return code: 0 17:04:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:50 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 0x7fe590c27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a32840>, '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 0x299f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299fb60>, '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': 'a65b340e283ce644d68cb24e000001c9-1450830720.969814-642385902', '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 17:04:50 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 17:04:50 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 17:04:50 INFO - Using env: {'DISPLAY': ':0', 17:04:50 INFO - 'HOME': '/home/cltbld', 17:04:50 INFO - 'LANG': 'en_US.UTF-8', 17:04:50 INFO - 'LANGUAGE': 'en_US:en', 17:04:50 INFO - 'LOGNAME': 'cltbld', 17:04:50 INFO - 'MAIL': '/var/mail/cltbld', 17:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:50 INFO - 'MOZ_NO_REMOTE': '1', 17:04:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:50 INFO - 'NO_EM_RESTART': '1', 17:04:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:50 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:50 INFO - 'SHELL': '/bin/bash', 17:04:50 INFO - 'SHLVL': '1', 17:04:50 INFO - 'TERM': 'linux', 17:04:50 INFO - 'TMOUT': '86400', 17:04:50 INFO - 'USER': 'cltbld', 17:04:50 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1450830720.969814-642385902', 17:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:50 INFO - '_': '/tools/buildbot/bin/python'} 17:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:04:50 INFO - Running setup.py (path:/tmp/pip-g8Rp1i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:04:50 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)) 17:04:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:04:50 INFO - Running setup.py (path:/tmp/pip-Pw8PLC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:04:51 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)) 17:04:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:04:51 INFO - Running setup.py (path:/tmp/pip-YsI8Kp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:04:51 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)) 17:04:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:04:51 INFO - Running setup.py (path:/tmp/pip-5LLZVr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:04:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:04:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:04:51 INFO - Running setup.py (path:/tmp/pip-7Ot4HE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:04:51 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)) 17:04:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:04:51 INFO - Running setup.py (path:/tmp/pip-fud3DK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:04:51 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)) 17:04:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:04:51 INFO - Running setup.py (path:/tmp/pip-6GZN01-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:04:51 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)) 17:04:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:04:51 INFO - Running setup.py (path:/tmp/pip-gTnOM2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:04:51 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)) 17:04:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:04:51 INFO - Running setup.py (path:/tmp/pip-I3lygw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:04:51 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)) 17:04:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:04:51 INFO - Running setup.py (path:/tmp/pip-NGgluv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:04:51 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)) 17:04:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:04:51 INFO - Running setup.py (path:/tmp/pip-_vLQdf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:04:51 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)) 17:04:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:04:51 INFO - Running setup.py (path:/tmp/pip-KuhEAD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:04:51 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)) 17:04:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:04:51 INFO - Running setup.py (path:/tmp/pip-84ce4O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:04:51 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)) 17:04:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:04:51 INFO - Running setup.py (path:/tmp/pip-PexiHq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:04:51 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)) 17:04:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:04:51 INFO - Running setup.py (path:/tmp/pip-q8eoTV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:04:51 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)) 17:04:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:04:51 INFO - Running setup.py (path:/tmp/pip-mcISn6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:04:52 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)) 17:04:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:04:52 INFO - Running setup.py (path:/tmp/pip-EOt5zS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:04:52 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)) 17:04:52 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)) 17:04:52 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)) 17:04:52 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)) 17:04:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:04:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:04:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:04:52 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 17:04:52 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 17:04:52 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 17:04:52 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 17:04:52 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 17:04:52 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 17:04:53 INFO - Downloading blessings-1.5.1.tar.gz 17:04:53 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 17:04:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:04:53 INFO - Installing collected packages: blessings 17:04:53 INFO - Running setup.py install for blessings 17:04:53 INFO - Successfully installed blessings 17:04:53 INFO - Cleaning up... 17:04:54 INFO - Return code: 0 17:04:54 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:04:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:04:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:04:54 INFO - Reading from file tmpfile_stdout 17:04:54 INFO - Current package versions: 17:04:54 INFO - argparse == 1.2.1 17:04:54 INFO - blessings == 1.5.1 17:04:54 INFO - blobuploader == 1.2.4 17:04:54 INFO - docopt == 0.6.1 17:04:54 INFO - manifestparser == 1.1 17:04:54 INFO - mozInstall == 1.12 17:04:54 INFO - mozcrash == 0.16 17:04:54 INFO - mozdebug == 0.1 17:04:54 INFO - mozdevice == 0.47 17:04:54 INFO - mozfile == 1.2 17:04:54 INFO - mozhttpd == 0.7 17:04:54 INFO - mozinfo == 0.9 17:04:54 INFO - mozleak == 0.1 17:04:54 INFO - mozlog == 3.1 17:04:54 INFO - moznetwork == 0.27 17:04:54 INFO - mozprocess == 0.22 17:04:54 INFO - mozprofile == 0.28 17:04:54 INFO - mozrunner == 6.11 17:04:54 INFO - mozscreenshot == 0.1 17:04:54 INFO - mozsystemmonitor == 0.0 17:04:54 INFO - moztest == 0.7 17:04:54 INFO - mozversion == 1.4 17:04:54 INFO - psutil == 3.1.1 17:04:54 INFO - requests == 1.2.3 17:04:54 INFO - wsgiref == 0.1.2 17:04:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:04:54 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')]} 17:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:54 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')]} 17:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:54 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 0x7fe590c27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a32840>, '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 0x299f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299fb60>, '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': 'a65b340e283ce644d68cb24e000001c9-1450830720.969814-642385902', '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 17:04:54 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 17:04:54 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 17:04:54 INFO - Using env: {'DISPLAY': ':0', 17:04:54 INFO - 'HOME': '/home/cltbld', 17:04:54 INFO - 'LANG': 'en_US.UTF-8', 17:04:54 INFO - 'LANGUAGE': 'en_US:en', 17:04:54 INFO - 'LOGNAME': 'cltbld', 17:04:54 INFO - 'MAIL': '/var/mail/cltbld', 17:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:54 INFO - 'MOZ_NO_REMOTE': '1', 17:04:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:54 INFO - 'NO_EM_RESTART': '1', 17:04:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:54 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:54 INFO - 'SHELL': '/bin/bash', 17:04:54 INFO - 'SHLVL': '1', 17:04:54 INFO - 'TERM': 'linux', 17:04:54 INFO - 'TMOUT': '86400', 17:04:54 INFO - 'USER': 'cltbld', 17:04:54 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1450830720.969814-642385902', 17:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:54 INFO - '_': '/tools/buildbot/bin/python'} 17:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:54 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)) 17:04:54 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)) 17:04:54 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)) 17:04:54 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)) 17:04:54 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)) 17:04:54 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)) 17:04:54 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)) 17:04:54 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)) 17:04:54 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)) 17:04:54 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)) 17:04:54 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)) 17:04:54 INFO - Cleaning up... 17:04:54 INFO - Return code: 0 17:04:54 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:04:54 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')]} 17:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:54 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')]} 17:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:54 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 0x7fe590c27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a32840>, '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 0x299f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299fb60>, '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': 'a65b340e283ce644d68cb24e000001c9-1450830720.969814-642385902', '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 17:04:54 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 17:04:54 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 17:04:54 INFO - Using env: {'DISPLAY': ':0', 17:04:54 INFO - 'HOME': '/home/cltbld', 17:04:54 INFO - 'LANG': 'en_US.UTF-8', 17:04:54 INFO - 'LANGUAGE': 'en_US:en', 17:04:54 INFO - 'LOGNAME': 'cltbld', 17:04:54 INFO - 'MAIL': '/var/mail/cltbld', 17:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:54 INFO - 'MOZ_NO_REMOTE': '1', 17:04:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:54 INFO - 'NO_EM_RESTART': '1', 17:04:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:54 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:54 INFO - 'SHELL': '/bin/bash', 17:04:54 INFO - 'SHLVL': '1', 17:04:54 INFO - 'TERM': 'linux', 17:04:54 INFO - 'TMOUT': '86400', 17:04:54 INFO - 'USER': 'cltbld', 17:04:54 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1450830720.969814-642385902', 17:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:54 INFO - '_': '/tools/buildbot/bin/python'} 17:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:54 INFO - Downloading/unpacking jsonschema 17:04:54 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 17:04:54 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 17:04:54 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 17:04:54 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 17:04:54 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 17:04:54 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 17:04:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:04:56 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 17:04:56 INFO - Downloading/unpacking functools32 (from jsonschema) 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04:56 INFO - Downloading functools32-3.2.3-2.tar.gz 17:04:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 17:04:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:04:56 INFO - warning: no files found matching '*.txt' 17:04:56 INFO - no previously-included directories found matching 'build' 17:04:56 INFO - no previously-included directories found matching 'dist' 17:04:56 INFO - no previously-included directories found matching '.git*' 17:04:56 INFO - Installing collected packages: jsonschema, functools32 17:04:56 INFO - Running setup.py install for functools32 17:04:56 INFO - warning: no files found matching '*.txt' 17:04:56 INFO - no previously-included directories found matching 'build' 17:04:56 INFO - no previously-included directories found matching 'dist' 17:04:56 INFO - no previously-included directories found matching '.git*' 17:04:56 INFO - Successfully installed jsonschema functools32 17:04:56 INFO - Cleaning up... 17:04:56 INFO - Return code: 0 17:04:56 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:04: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')]} 17:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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')]} 17:04:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe590c27f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29a1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a32840>, '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 0x299f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299fb60>, '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': 'a65b340e283ce644d68cb24e000001c9-1450830720.969814-642385902', '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 17:04: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', 'flake8'] in /builds/slave/test-pgo/build 17:04: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 flake8 17:04:56 INFO - Using env: {'DISPLAY': ':0', 17:04:56 INFO - 'HOME': '/home/cltbld', 17:04:56 INFO - 'LANG': 'en_US.UTF-8', 17:04:56 INFO - 'LANGUAGE': 'en_US:en', 17:04:56 INFO - 'LOGNAME': 'cltbld', 17:04:56 INFO - 'MAIL': '/var/mail/cltbld', 17:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:56 INFO - 'MOZ_NO_REMOTE': '1', 17:04:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:56 INFO - 'NO_EM_RESTART': '1', 17:04:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:04:56 INFO - 'PWD': '/builds/slave/test-pgo', 17:04:56 INFO - 'SHELL': '/bin/bash', 17:04:56 INFO - 'SHLVL': '1', 17:04:56 INFO - 'TERM': 'linux', 17:04:56 INFO - 'TMOUT': '86400', 17:04:56 INFO - 'USER': 'cltbld', 17:04:56 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1450830720.969814-642385902', 17:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:56 INFO - '_': '/tools/buildbot/bin/python'} 17:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:56 INFO - Downloading/unpacking flake8 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:04:58 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 17:04:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:04:58 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 17:04:58 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 17:04:58 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 17:04:58 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 17:04:58 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 17:04:58 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 17:04:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:04:58 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 17:04:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:04:58 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 17:04:58 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 17:04:58 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 17:04:58 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 17:04:58 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 17:04:58 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 17:04:59 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 17:04:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:04:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:04:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:04:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:04:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:04:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:04:59 INFO - no previously-included directories found matching 'docs/_build' 17:04:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:04:59 INFO - Running setup.py install for pep8 17:04:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:04:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:04:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:04:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:04:59 INFO - no previously-included directories found matching 'docs/_build' 17:04:59 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:04:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:04:59 INFO - Cleaning up... 17:04:59 INFO - Return code: 0 17:04:59 INFO - Running post-action listener: _resource_record_post_action 17:04:59 INFO - Running post-action listener: _start_resource_monitoring 17:04:59 INFO - Starting resource monitoring. 17:04:59 INFO - ##### 17:04:59 INFO - ##### Running install step. 17:04:59 INFO - ##### 17:04:59 INFO - Running pre-action listener: _resource_record_pre_action 17:04:59 INFO - Running main action method: install 17:04:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:04:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:04:59 INFO - Reading from file tmpfile_stdout 17:04:59 INFO - Detecting whether we're running mozinstall >=1.0... 17:04:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:04:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:04:59 INFO - Reading from file tmpfile_stdout 17:04:59 INFO - Output received: 17:04:59 INFO - Usage: mozinstall [options] installer 17:04:59 INFO - Options: 17:04:59 INFO - -h, --help show this help message and exit 17:04:59 INFO - -d DEST, --destination=DEST 17:04:59 INFO - Directory to install application into. [default: 17:04:59 INFO - "/builds/slave/test-pgo"] 17:04:59 INFO - --app=APP Application being installed. [default: firefox] 17:04:59 INFO - mkdir: /builds/slave/test-pgo/build/application 17:04:59 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'] 17:04:59 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 17:05:15 INFO - Reading from file tmpfile_stdout 17:05:15 INFO - Output received: 17:05:15 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:05:15 INFO - Running post-action listener: _resource_record_post_action 17:05:15 INFO - ##### 17:05:15 INFO - ##### Running run-tests step. 17:05:15 INFO - ##### 17:05:15 INFO - Running pre-action listener: _resource_record_pre_action 17:05:15 INFO - Running main action method: run_tests 17:05:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:05:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:05:15 INFO - Python 2.7.3 17:05:15 INFO - Return code: 0 17:05:15 INFO - grabbing minidump binary from tooltool 17:05:15 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')]} 17:05:15 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 0x2a32840>, '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 0x299f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299fb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:05:15 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 17:05:15 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 17:05:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:05:15 INFO - Return code: 0 17:05:15 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:05:15 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:05:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:05:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:05:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:05:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:05:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:05:16 INFO - Return code: 0 17:05:16 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/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 17:05:16 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/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 17:05:16 INFO - Using env: {'DISPLAY': ':0', 17:05:16 INFO - 'HOME': '/home/cltbld', 17:05:16 INFO - 'LANG': 'en_US.UTF-8', 17:05:16 INFO - 'LANGUAGE': 'en_US:en', 17:05:16 INFO - 'LOGNAME': 'cltbld', 17:05:16 INFO - 'MAIL': '/var/mail/cltbld', 17:05:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:05:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:05:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:16 INFO - 'MOZ_NO_REMOTE': '1', 17:05:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:05:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:05:16 INFO - 'NO_EM_RESTART': '1', 17:05:16 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:05:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:05:16 INFO - 'PWD': '/builds/slave/test-pgo', 17:05:16 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:05:16 INFO - 'SHELL': '/bin/bash', 17:05:16 INFO - 'SHLVL': '1', 17:05:16 INFO - 'TERM': 'linux', 17:05:16 INFO - 'TMOUT': '86400', 17:05:16 INFO - 'USER': 'cltbld', 17:05:16 INFO - 'XDG_SESSION_COOKIE': 'a65b340e283ce644d68cb24e000001c9-1450830720.969814-642385902', 17:05:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:16 INFO - '_': '/tools/buildbot/bin/python'} 17:05:16 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/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 17:05:16 INFO - mozversion application_buildid: 20151222143005 17:05:16 INFO - mozversion application_changeset: 645cb0f2d2836e5daddff06665bbd306a8b9093d 17:05:16 INFO - mozversion application_display_name: Nightly 17:05:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:05:16 INFO - mozversion application_name: Firefox 17:05:16 INFO - mozversion application_remotingname: firefox 17:05:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:05:16 INFO - mozversion application_vendor: Mozilla 17:05:16 INFO - mozversion application_version: 46.0a1 17:05:16 INFO - mozversion platform_buildid: 20151222143005 17:05:16 INFO - mozversion platform_changeset: 645cb0f2d2836e5daddff06665bbd306a8b9093d 17:05:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:05:16 INFO - mozversion platform_version: 46.0a1 17:05:16 INFO - using testdate: 1450832716 17:05:16 INFO - actual date: 1450832716 17:05:16 INFO - starting webserver on 'localhost:57292' 17:05:16 INFO - SUITE-START | Running 3 tests 17:05:16 INFO - TEST-START | dromaeo_css 17:05:17 INFO - operating with platform_type : linux_ 17:05:17 INFO - Initialising browser for dromaeo_css test... 17:05:17 INFO - TEST-INFO | started process 20819 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpS7fT5q/profile http://localhost:57292/getInfo.html) 17:05:21 INFO - PROCESS | 20819 | __metrics Screen width/height:1600/1200 17:05:21 INFO - PROCESS | 20819 | colorDepth:24 17:05:21 INFO - PROCESS | 20819 | Browser inner width/height: 1024/697 17:05:21 INFO - PROCESS | 20819 | __metrics 17:05:21 INFO - PROCESS | 20819 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:05:22 INFO - TEST-INFO | 20819: exit 0 17:05:22 INFO - Browser initialized. 17:05:22 INFO - Running cycle 1/1 for dromaeo_css test... 17:05:22 INFO - TEST-INFO | started process 20952 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpS7fT5q/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:05:34 INFO - PROCESS | 20952 | RSS: Main: 151138304 17:05:34 INFO - PROCESS | 20952 | 17:06:23 INFO - PROCESS | 20952 | 1450832783899 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] 17:08:32 INFO - PROCESS | 20952 | Cycle 1(1): loaded http://localhost:57292/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57292/tests/dromaeo/cssquery-ext.html) 17:08:34 INFO - PROCESS | 20952 | RSS: Main: 156454912 17:08:34 INFO - PROCESS | 20952 | 17:11:36 INFO - PROCESS | 20952 | Cycle 1(1): loaded http://localhost:57292/tests/dromaeo/cssquery-ext.html (next: http://localhost:57292/tests/dromaeo/cssquery-jquery.html) 17:11:36 INFO - PROCESS | 20952 | RSS: Main: 152707072 17:11:36 INFO - PROCESS | 20952 | 17:14:38 INFO - PROCESS | 20952 | Cycle 1(1): loaded http://localhost:57292/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57292/tests/dromaeo/cssquery-mootools.html) 17:14:38 INFO - PROCESS | 20952 | RSS: Main: 153169920 17:14:38 INFO - PROCESS | 20952 | 17:17:40 INFO - PROCESS | 20952 | Cycle 1(1): loaded http://localhost:57292/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57292/tests/dromaeo/cssquery-prototype.html) 17:17:41 INFO - PROCESS | 20952 | RSS: Main: 153128960 17:17:41 INFO - PROCESS | 20952 | 17:20:43 INFO - PROCESS | 20952 | Cycle 1(1): loaded http://localhost:57292/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57292/tests/dromaeo/cssquery-yui.html) 17:20:44 INFO - PROCESS | 20952 | RSS: Main: 153890816 17:20:44 INFO - PROCESS | 20952 | 17:23:46 INFO - PROCESS | 20952 | Cycle 1(1): loaded http://localhost:57292/tests/dromaeo/cssquery-yui.html (next: http://localhost:57292/tests/dromaeo/cssquery-dojo.html) 17:23:46 INFO - PROCESS | 20952 | RSS: Main: 156053504 17:23:46 INFO - PROCESS | 20952 | 17:23:46 INFO - PROCESS | 20952 | __start_tp_report 17:23:46 INFO - PROCESS | 20952 | _x_x_mozilla_page_load 17:23:46 INFO - PROCESS | 20952 | _x_x_mozilla_page_load_details 17:23:46 INFO - PROCESS | 20952 | |i|pagename|runs| 17:23:46 INFO - PROCESS | 20952 | |0;dojo.html;3171.540126681631;3187.2669286064206;3219.3883162199195;3224.387366400383;3227.080282119595;5283.8150664726745;5341.092014357559;5350.491703288186;5351.357837059549;5370.91943620846;5331.920021199685;5350.036993341197;5358.866028349294;5372.086745253307;5435;4855.805767769285;4946.332245146913;4983.551480366767;5026.070177017264;5071.290019397287;5013.197888337867;5050.520200580939;5061.873453163682;5097.745112744348;5111.309973153632;4712.316714076457;4799.808007679689;4839;4848.224284114543;4967.254911763228;4955.801767929279;4962.206047032458;4971.055499455092;4973.179425394806;5004.624653150991;4914.950850491485;4953.257011448276;4957.231629097496;4969.956309175078;4989.326440930464;5177.663451875616;5254.816081437131;5259.631825772198;5278.287431196778;5378.569714422837;5781.624194427349;5820.650760954314;5825.446582574648;5830;5940.821775346703;5931.673757943311;5939.584229103964;5940.6435613863305;5945.108233764927;5963;5528.695921724304;5533.5849811263915;5534.308211473566;5535.58483113764;5536.861578460571;5798.246227990334;5904.439078287556;5962.493188079062;5981.850453738692;5987.670678112746;5734.713264336767;5737.512311453574;5756.971215143897;5778.768849245983;5802.680852553066;5855.326637436664;5868.119782032644;5876.529877609781;5893.911591326134;5908.172855800191;5670.829875103754;5795.82612521625;5798.362180160179;5809.651420914674;5904.675242861598;5888.705564721747;5893.528517718572;5893.882122357529;5896.115582662635;5898.351181370046;4466.196084704784;4476.395686582269;4499.257622492318;4503.707259028152;4558.475775285819;3821.140243445258;3918.4122381642983;3964.306246406867;4003.739756915791;4029.8388064477094;5434.70109143993;5470.452954704498;5503.00519777823;5519.282493275929;5531.557475401958;5631.436856314336;5849.385814489502;5868.178455016301;5873.706314684248;5878.412158784173;5381.300430943952;5410.269613602192;5465.781368745205;5481.890362192734;5510.6969116698965;4975.850724478271;5009.499050094962;5029.748512574357;5045.091883460939;5058.570021548209;5628.774849006076;5906.438888305604;5913.615614985012;5914.349421563625;5933.614315069507;5804.303483581828;5857.384974577779;5885.352611212848;5942.73257703413;5977.3126090500145;5809.970950145223;5812.273465816773;5828.213191219131;5894.410558944071;5925.525957923442;5662.745176467151;5781.21953536284;5781.4507621775865;5787.884242315046;5792.333881603669;5805.593608447368;5810.564207684525;5900.232969713909;5910.763569457174;5955.017422125301;5739.282589676291;5743.282089738783;5747.339056008445;5754.251947246831;5776.133579963039;5556.194351819045;5584.106542953108;5774.8845023098465;5790.739416726342;5796.855078623068;5619.8876022480135;5636.85907852307;5656.151577263443;5664.886702265849;5727.541796656341;5701.40135285789;5724.79963201286;5749.310082790092;5755;5776.653400795965;5451.291332126798;5548.223248745259;5556.638818476948;5645.830625081254;5647.350554686263 17:23:46 INFO - PROCESS | 20952 | |1;ext.html;564.7882044233412;616.7687117331;618.0944915698498;620.481897615491;623.9376062393758;36447.635523644756;36703.81648091756;36738.63261367386;36789.44815827765;36836.63163368365;42062;42627.36058959118;42760.572394276045;42774.786126069324;43064.56935430645;8684.826303473943;8799.95600021999;8809.339299552526;8843.027267000625;8854.601542930584;8611.397202195849;8630.525321107336;8647.264982476465;8724.956375218148;8733;8675.08911564286;8766.298696104328;8812.206901378875;8822.250108740765;8827.867581986244;8673.913260867404;8724.171203735636;8766.342524310703;8804.823903521894;8814.735557933273;8558.101399353041;8762.211400973943;8780.429272097294;8787.560621968876;8792.164744349277;39657.80171099126;39669.20661586752;39806.80096599498;40014.19971600552;40103.79948100241;3491.9825400873087;3627.546556680415;3854.6338097880657;4028.3554631258858;4034.9596504034876;28869;28878.566821497694;29114.272143196376;29356.853215733998;30114.54828177579;3935.488386509764;3983.3626619740994;3989.3018721723874;4064.329385651364;4124.52567954683;278696;278730.99999999796;278763;279858.6007069972;282349;50923;51764.74117629463;54764.726176368866;60306.396936030076;61281.69359153176;56069.71965140148;56083;56211.71894140503;56328.436715633135;56540;15582.220888955508;15651.434856514257;15660.373585056697;15781.210939452982;15838.76241856373;11605.419729013516;11620.477078531487;11635.825462618068;11698.70753231176;11796.351200684045;18365.3572124975;18412.631747365245;18582.628347433245;18589.44231673052;18589.535261618566;7867.803304917423;7996.400269979775;8021.5187088774865;8253.587320634064;8305.750827475065;859.5229647545547;944.1832814615308;949.8480243161199;976.4483067067084;1068.471106802138;28106.437871242462;28712;28745.71254287472;28994.855025724737;29406;1032.3341444768232;1050.4642632257603;1077.2997551591527;1095.5562996986234;1101.2566517600587;13920.651983700489;14280.428782848778;14332.355044023045;14365.92817035929;14381.424743010162;315676;324452;325045;325116;326011;43499;43754.78122609366;43864.780676096416;43867;43977.34033989493;1320.6830360713552;1335.105479328852;1339.55125033115;1356.2405053170257;1366.1393322206748;25767.742322577284;27219.727802721718;27317.863410682818;27356.316092097855;28440.85779571089;39845.60154398419;39908.60091399165;40016.59983400129;40123.79938100291;40131.59868401395;247186;248172;248700;248942;249326;30607.54088688716;31679.683203168595;32128.678713213503;32163.03510894677;32213.35573288568;38050;39588.80205598954;40541.797291013354;41057;41132.79433602813;33329;34079.4888076684;34549.48175777315;34740.652593473744;35076.82461587676;34387.31225375429;34898.82550587333;35366.46950295696;35519;35781.46327805033;32892.83553582313;33299.167520812174;33795.83102084474;33960;34182;28990.710092899644;29951.400971980875;31268.218294542818;31658.733650653718;31714.365712685154;24119.22628897629;24316.392090197885;24426.51146977015;24643.260702178963;24689.553693043476 17:23:46 INFO - PROCESS | 20952 | |2;jquery.html;363.69631357816223;364.67908240748136;365.14555939102496;367.7444176297474;368.4730834906083;16424.178791060443;16938.407155749537;17563.121843907786;17645.117744112777;18222.453326400195;11080.168987325962;11587.246828956111;13192.27442490665;13193.472261109568;13224.074314797968;4804.231322988323;5575.888482230353;5581.7209139543065;5601.411851755568;5611.438856114376;5504.311961004874;5532.1425179097105;5537.695426751527;5545.805896793613;5547.861303467405;5364.249005139283;5539.861503462405;6290.339514350996;6497.122888410051;6506.642134682591;6397.968010159966;6457.580257283285;6484.740610375579;6898.896516552256;6909.792706218822;6560.934390656128;6574.408303252731;6602.702878370437;6604.570702904296;6617.602943823338;22560.43598910024;22734.77265227343;22911.77088229113;23200.187993420317;23879.283621491384;2278.874661893595;2304.5621331947045;2317.478567322356;2359.056377449017;2395.5089206712582;14338.56984290473;14387.208703521303;14401.783973240304;15070.623234419227;15117.622059448602;1955.1690531524046;1994.601079784049;2015.6674148765437;2080.4382816639422;2094.1518684932626;65167.06748196342;69772.6511367445;70374.2962570378;71216.64391678009;71809;15265.389384424721;15567.221638918008;15631.84368156304;15665.29506172225;15764.896457248113;24257.878710606336;24301.39246518851;24347.26958191257;24589.38526536815;24647.753522464904;8949.731508054638;8981.236594889377;8984.371094023487;9013.63945442188;9081.228095611816;7556.58438785861;7569.280918312751;7592.392608591299;7608.467407281437;7615.619219039026;7647.617619119022;7816.218378162252;7849.332806711379;7871.645775940096;8008;1886.9433916982512;1928.9614207716047;3155.191879227489;3262.862824849727;3314.105191598255;886.6719313853915;889.4040992535017;899.6401439424283;942.8727121838601;1057.5611121384538;16469.505914822574;16915.23881425339;17503.47489575315;17511.474655760347;18147.909260453613;935.4013431403907;939.3847030195096;966.7679756858304;974.6734843827255;974.7514383832078;9999;10093.899061009442;10181.981801819908;10237.129843963347;10242.692719218436;388113;394776;396799;531065;536519;41626.791866040476;41768.164636707705;52423.73788131111;63046.73906521844;66475.66762166159;1141.2923987127867;1165.6211731187398;1166.650004998497;1181.781370446453;1193.779150857077;15743.527694169194;15809;15866.206689665702;15920.124393158025;16192.67614647677;34121.65878341185;34147.48778768271;34191.72454367321;34361.82819085888;34857.47713784346;44997.55002449934;45123.548764511936;45352.092958141315;45557.544424556654;46337;9044.50255235942;9076.954615226881;9210.032946540518;9211.76970575741;9257.953710231675;10743.871387233128;13046.739065218453;17676.292948281924;17976.550586235448;17990.460286191435;13531.458741650224;13813;13869.791953120914;14160.929195353958;14992.325345359703;14235.359408826835;14270.643233919234;14310.49913253031;14550.41798328055;14631.195284259467;14797.556073317817;15036.699266014837;15126.697466050837;15179.696406072038;15361.462348817739;9182.770430739285;9195.218406435528;9424.528773561431;9794.902050979685;9844.704658860246;11361.715957101138;14550.199739014455;14641;14902.1803800792;15001.324940377928 17:23:46 INFO - PROCESS | 20952 | |3;mootools.html;1566.7806507089017;1664.4257731082776;1693.906835124068;1745.467632372127;1759.0852756566578;7357.30105639964;7749.651265693044;7751.069871615407;7752.418568607349;7836.764897053084;7764.107127680319;7769.378449724023;7781.2607802258835;7802.024746906637;7871.448998570102;2251.6509940959177;2273.4998300373973;2293.7247530296386;2293.8508996915148;2299.2642354446584;2291.0950174680993;2314.687517185184;2321.6749655048307;2326;2327.173853282086;2127.4043267885017;2183.650615901456;2183.7161169048;2185.7486389065302;2221.056051178251;2222.466608014065;2271.375371772759;2298.0463107810237;2307.6653885186556;2308.0998410619873;2243.753187149412;2268.194790849258;2270.71616047994;2283.5889539882814;2285.954280914389;7594.088709354913;7597.468177227596;7678.193789652062;7686.346660533862;7725.884111738328;4637.25803871379;4698.08387364464;4711.505291944331;4728.858134255978;4730.148573256813;3051.2371907023244;3075.0928476099602;3135.0594821553673;3150.401423729507;3156.700113489215;980.9068138526828;987.333549853853;1018.4347687033693;1019.6125472320545;1032.1536340201037;10360.94819525905;10423.166146708245;10448.791024179474;10475.214358923035;10520.473976301155;4174.519930208005;4230.111676547959;4269.167512335127;4327.307630779061;4328.242557552416;8456.154384561494;8467.830643387098;8471.534065626449;8498.617562209716;8503.107173746792;4664.86005419838;4684.273937539687;4691.179043667413;4714.080754252887;4719.669623126349;4278.957210427856;4291.249031419551;4294.969207390266;4332.696711230246;4352.825886964486;3365.5528122907385;3393.7624366294617;3395.7792743471596;3404.2510647657477;3422.247105636756;1065.504540388723;1070.272214893864;1070.352436775755;1077.9514921828536;1079.611339917629;1061.3207547169818;1075.5321435175724;1119.1158984402393;1249.1505776072358;1377.7864431013209;7242.746503872339;7271.054762880792;7281.507291005331;7308.269173082649;7373.705051797975;1109.7114750165015;1121.971950701239;1135.2620796482188;1142.9199956003;1143.085531574737;5784.363719990798;5797.4782269595935;5828.766849326064;5845.795397161079;5870.354261031283;8940.8658870117;8958.19376256127;9153.81692366149;9236.445813251226;9239.30705197113;9041.321900857462;9055.36612437123;9073.818523629623;9128.22410095136;9144.679936202201;6905.205901321312;7031.613261270679;7074.434045276365;7140.107486564179;7279.89080163798;6778.288279730557;6805.557638753465;6819.5226334158115;6826.941824017285;6845.691943862637;7923;8093.757187284391;8139.511629302261;8189.754307370788;8233.670653174046;8153.388495862715;8183.590820458834;8188.836223275382;8250.958745206235;8269.917300826915;6302.495800335871;6469.417752402306;6502.544821862613;6747.763828265987;6768;7182.569045857265;7211.8557628848175;7218.855622887408;7260.528065675714;7278.126624805057;6792.252852186157;6847.34950179752;6950.096487456598;7002.859942801218;7023.508354415347;6881.10446533435;6887.827804304732;6933.306669333027;6959;6970.860582788418;6796.76211332601;6812.727490900506;6827.283135270924;6831.89752153728;6842.315768423118;6277.121203031488;6291.087792270004;6292.056191571301;6314.589551679126;6350.396712312323;6107.938920610737;6121.4490695837585;6383.170187875547;6391.265004524354;6407.199100112486 17:23:46 INFO - PROCESS | 20952 | |4;prototype.html;345.082081662777;351.36929212064325;351.9542459480267;352.8800207929307;353.81167479141504;6301.40136687014;6334.176557047583;6439.967800160998;6455.128557644723;6469.773557925473;6145.72344244509;6295.646436016255;6321.968390158055;6342.0486926960975;6350.460210882069;4836.443808961962;4839.661223714342;4842.927356089662;4845.491223421543;4861.781219845116;4822.831200907969;4834.323194752737;4836.226203807391;4853.223484242504;4870.391201099863;4670.346151538787;4783.067301876118;4801.4718380978065;4814.66297359185;4817.831375901844;4787.018661174451;4804.1352556539805;4806.255030470283;4823.397075365579;4827.541383568555;4176.937345939813;4192.266353388145;4194.2869712149;4196.412502249687;4198.8243291878325;5908.881822363529;5981.730822113015;6039.184710064129;6074.058520929263;6075.878482430371;5575.804846830382;5590.748416321235;5590.776368945238;5595.38450770415;5598.552115830724;6686.966565167143;6703.262641109474;6725.66371681414;6732.091167692348;6734.259231484532;4577.839775607871;4578.908421831578;4587.288970209623;4587.678862479628;4620.19146649335;6881.4860730639175;6953.860922781567;7018.263082376328;7023.964880175567;7038.577685338896;4696.530346965276;4701.529847015271;4715.81136754526;4716.457607375127;4740.028294199681;4773.689710168897;4785.377900872864;4787.712737235777;4790.4251489821445;4803.207470767354;5447.918281225785;5502.174673798962;5518.33779946401;5558.194061861008;5573.164025396223;6687.76592819249;6793.796186114326;6796.52424330302;6797.456203503807;6799.626020568916;1664.0847533856331;1693.3649881294514;1704.2927185217995;1709.572606848288;1710.0765586583107;1107.8615173103362;1137.9772404551863;1143.5997400909782;1154.0825044089968;1156.670348950545;6267.2792628848265;6310.1796766420075;6332.525060620472;6334.714937827809;6336.58812177207;6832.555883867532;6853.314668533207;6868.450523958071;6871.4502839772695;6900.378965892994;6305.180326557518;6308.716107775161;6335;6366.172397588284;6380.776672816429;3815.542134943769;3830.693544516432;3832.3676593362343;3839.462475253467;3845.1540661054523;7068.717251309993;7109.964450177716;7110.253423390573;7110.431165506747;7110.893336599956;7037.120359955005;7225.421966242688;7270.4910656254615;7272.090988626422;7280.599567023864;7037.788866334018;7069.045678833395;7070.116235470567;7077.858442831114;7079.221285658574;7045.295470452914;7048.612326322102;7063.434925205868;7066.752663656747;7068.505204635626;6776.186857577122;6893.7931862044215;6956.478264130312;6986.720531178696;6998.16022077354;7022.12223472066;7061.293870612898;7076.964615177097;7078.646067696697;7079.2566780487305;4754.857354279377;4771.332013518179;4784.186688262934;4789.808407663654;4795.95204047955;6902.585844849325;6992.300769922967;7023.929760702327;7037.612931288828;7062.71749130029;6845.726170953305;6852.588844669336;6862.965685171742;6868.210155832143;6878.8624227516175;6770.01834733951;6789.219239787488;6806.251312355538;6822.215445223863;6838.521303508706;6477.190351206099;6681.699323530355;6695.866082678222;6701.966490167713;6706;6862.862742745017;6867.416269616939;6877.1747390313485;6879.862402752017;6890.793276201722;6617.569857959217;6707.262201157771;6707.530472867048;6708.42978346846;6713.1944166700305 17:23:46 INFO - PROCESS | 20952 | |5;yui.html;739.4158614694392;776.7126163319571;844.8986121665401;862.2670729879599;895.1853813030142;13142.605721828337;13402.731945361087;13476.05667603267;13476.932615336935;13496.595102146926;13042.217466951966;13150.802737958938;13243.933780331085;14804.703905921875;15240.618984525392;814.4136221920209;821.7986593284654;824.1758241758242;825.0882774534143;826.9917300827005;805.7985503624094;813.0974618173823;813.1543195077143;815.176671561721;816.1878930464167;859.9140085991413;860.9612567434481;862.1550880137469;869.0831173112364;872.0451106038877;852.5651917522108;855.324293807891;857.7984173719171;859.0764927702744;860.4407135362002;620.5625034350817;620.9627422354628;622.4615707413055;626.145311649595;627.4980015987237;13241;13259.46962121514;13286.60140195786;13288.667783305398;13291.53479628218;11820;12060.517579296906;12111.939440302831;12157.586184606378;12264.141510094298;9676.274279429;9684;9709.514524273829;9818.509074546244;10009.749756256078;3565.893023209308;3579.2304654499408;3626.2566173934542;3646.8723594674325;3694.021084412606;48121.75939120317;48238;48275.51724482745;48553;48856.26715599269;8654.826903461895;8780.429272097294;8780.692675756318;8782.912170878337;8969.955150224338;15990.200489975454;16043.438479653156;16052.678946421007;16073.517794466185;16118.919405402898;7039.366457018893;7190.460715446363;7345.7428989986165;7362.3741981932135;7412.925870741331;4104.343305071175;4176.62410383067;4179.352200408942;4190.769507677107;4229.725067870579;3030.530267808493;3041.7110374514828;3047.9390412191633;3048.2988912550236;3063.954040689347;540.6107602526175;550.1500182218482;556.8023351710166;560.4815545620285;574.047081844145;458.83940620783125;557.2950217974266;582.4815913836688;582.8834233153386;618.3167599802243;8334.20825021622;8858.512781797062;9238.815223695488;9299;9313;478.1894688503024;544.6868050870766;553.6041730162952;564.179104477612;580.0371383503364;3704.592494825567;3951.636978803884;4134.586541345901;4167.354060120686;4236;52194.739026304625;56075.439245607835;58090.419095809346;58181.70909145427;58285.125723114186;49336.25995610069;52237.216441752644;56592;57371.713141434026;58901.11648325193;45841.77079114583;46169.76915115403;46290;48023.5197648026;48094.5190548097;8665.17680820321;8669.349798765244;8697.304215662605;8969.775755606162;9025.142611451902;33932.49101263434;34547.82726086354;34872;35052.29895402129;35354.82322588371;45885;45973.54026459826;46067.76966115148;46455;46932.76533617447;9886.4562449066;10366.637167699095;10462.267641265038;10464.476776161313;10651.520681569504;11255.380954047607;11609.825852612048;12005.159638825198;12084.879151208375;12524.874751252371;11001;11056.115510758958;11238.10095192399;11486.885131148916;11509.309441433541;11131.888681113409;11320.660380188607;11435.942820285845;11486.310821350746;11797.705057373634;10542.103921166787;10546.789064218827;10810.783784324427;10948.671539853816;11362.488688008894;8740.125987401208;9005.324600654845;9073.274138069071;9136.497492637704;9205.861912071457;9254.305927055364;9583.952080239555;9617.807643847224;9684.612615495302;9718.222542196467 17:23:46 INFO - PROCESS | 20952 | __end_tp_report 17:23:46 INFO - PROCESS | 20952 | __start_cc_report 17:23:46 INFO - PROCESS | 20952 | _x_x_mozilla_cycle_collect,303 17:23:46 INFO - PROCESS | 20952 | __end_cc_report 17:23:46 INFO - PROCESS | 20952 | __startTimestamp1450833826863__endTimestamp 17:23:46 INFO - PROCESS | 20952 | 17:23:46 INFO - PROCESS | 20952 | ------- Summary: start ------- 17:23:46 INFO - PROCESS | 20952 | Number of tests: 6 17:23:46 INFO - PROCESS | 20952 | 17:23:46 INFO - PROCESS | 20952 | [#0] dojo.html Cycles:165 Average:5408.26 Median:5631.44 stddev:608.96 (10.8%) stddev-sans-first:585.00 17:23:46 INFO - PROCESS | 20952 | Values: 3171.5 3187.3 3219.4 3224.4 3227.1 5283.8 5341.1 5350.5 5351.4 5370.9 5331.9 5350.0 5358.9 5372.1 5435.0 4855.8 4946.3 4983.6 5026.1 5071.3 5013.2 5050.5 5061.9 5097.7 5111.3 4712.3 4799.8 4839.0 4848.2 4967.3 4955.8 4962.2 4971.1 4973.2 5004.6 4915.0 4953.3 4957.2 4970.0 4989.3 5177.7 5254.8 5259.6 5278.3 5378.6 5781.6 5820.7 5825.4 5830.0 5940.8 5931.7 5939.6 5940.6 5945.1 5963.0 5528.7 5533.6 5534.3 5535.6 5536.9 5798.2 5904.4 5962.5 5981.9 5987.7 5734.7 5737.5 5757.0 5778.8 5802.7 5855.3 5868.1 5876.5 5893.9 5908.2 5670.8 5795.8 5798.4 5809.7 5904.7 5888.7 5893.5 5893.9 5896.1 5898.4 4466.2 4476.4 4499.3 4503.7 4558.5 3821.1 3918.4 3964.3 4003.7 4029.8 5434.7 5470.5 5503.0 5519.3 5531.6 5631.4 5849.4 5868.2 5873.7 5878.4 5381.3 5410.3 5465.8 5481.9 5510.7 4975.9 5009.5 5029.7 5045.1 5058.6 5628.8 5906.4 5913.6 5914.3 5933.6 5804.3 5857.4 5885.4 5942.7 5977.3 5810.0 5812.3 5828.2 5894.4 5925.5 5662.7 5781.2 5781.5 5787.9 5792.3 5805.6 5810.6 5900.2 5910.8 5955.0 5739.3 5743.3 5747.3 5754.3 5776.1 5556.2 5584.1 5774.9 5790.7 5796.9 5619.9 5636.9 5656.2 5664.9 5727.5 5701.4 5724.8 5749.3 5755.0 5776.7 5451.3 5548.2 5556.6 5645.8 5647.4 17:23:46 INFO - PROCESS | 20952 | 17:23:46 INFO - PROCESS | 20952 | [#1] ext.html Cycles:180 Average:44602.44 Median:35650.23 stddev:74550.76 (209.1%) stddev-sans-first:74686.57 17:23:46 INFO - PROCESS | 20952 | Values: 564.8 616.8 618.1 620.5 623.9 36447.6 36703.8 36738.6 36789.4 36836.6 42062.0 42627.4 42760.6 42774.8 43064.6 8684.8 8800.0 8809.3 8843.0 8854.6 8611.4 8630.5 8647.3 8725.0 8733.0 8675.1 8766.3 8812.2 8822.3 8827.9 8673.9 8724.2 8766.3 8804.8 8814.7 8558.1 8762.2 8780.4 8787.6 8792.2 39657.8 39669.2 39806.8 40014.2 40103.8 3492.0 3627.5 3854.6 4028.4 4035.0 28869.0 28878.6 29114.3 29356.9 30114.5 3935.5 3983.4 3989.3 4064.3 4124.5 278696.0 278731.0 278763.0 279858.6 282349.0 50923.0 51764.7 54764.7 60306.4 61281.7 56069.7 56083.0 56211.7 56328.4 56540.0 15582.2 15651.4 15660.4 15781.2 15838.8 11605.4 11620.5 11635.8 11698.7 11796.4 18365.4 18412.6 18582.6 18589.4 18589.5 7867.8 7996.4 8021.5 8253.6 8305.8 859.5 944.2 949.8 976.4 1068.5 28106.4 28712.0 28745.7 28994.9 29406.0 1032.3 1050.5 1077.3 1095.6 1101.3 13920.7 14280.4 14332.4 14365.9 14381.4 315676.0 324452.0 325045.0 325116.0 326011.0 43499.0 43754.8 43864.8 43867.0 43977.3 1320.7 1335.1 1339.6 1356.2 1366.1 25767.7 27219.7 27317.9 27356.3 28440.9 39845.6 39908.6 40016.6 40123.8 40131.6 247186.0 248172.0 248700.0 248942.0 249326.0 30607.5 31679.7 32128.7 32163.0 32213.4 38050.0 39588.8 40541.8 41057.0 41132.8 33329.0 34079.5 34549.5 34740.7 35076.8 34387.3 34898.8 35366.5 35519.0 35781.5 32892.8 33299.2 33795.8 33960.0 34182.0 28990.7 29951.4 31268.2 31658.7 31714.4 24119.2 24316.4 24426.5 24643.3 24689.6 17:23:46 INFO - PROCESS | 20952 | 17:23:46 INFO - PROCESS | 20952 | [#2] jquery.html Cycles:180 Average:26662.95 Median:34134.57 stddev:74098.36 (217.1%) stddev-sans-first:74279.91 17:23:46 INFO - PROCESS | 20952 | Values: 363.7 364.7 365.1 367.7 368.5 16424.2 16938.4 17563.1 17645.1 18222.5 11080.2 11587.2 13192.3 13193.5 13224.1 4804.2 5575.9 5581.7 5601.4 5611.4 5504.3 5532.1 5537.7 5545.8 5547.9 5364.2 5539.9 6290.3 6497.1 6506.6 6398.0 6457.6 6484.7 6898.9 6909.8 6560.9 6574.4 6602.7 6604.6 6617.6 22560.4 22734.8 22911.8 23200.2 23879.3 2278.9 2304.6 2317.5 2359.1 2395.5 14338.6 14387.2 14401.8 15070.6 15117.6 1955.2 1994.6 2015.7 2080.4 2094.2 65167.1 69772.7 70374.3 71216.6 71809.0 15265.4 15567.2 15631.8 15665.3 15764.9 24257.9 24301.4 24347.3 24589.4 24647.8 8949.7 8981.2 8984.4 9013.6 9081.2 7556.6 7569.3 7592.4 7608.5 7615.6 7647.6 7816.2 7849.3 7871.6 8008.0 1886.9 1929.0 3155.2 3262.9 3314.1 886.7 889.4 899.6 942.9 1057.6 16469.5 16915.2 17503.5 17511.5 18147.9 935.4 939.4 966.8 974.7 974.8 9999.0 10093.9 10182.0 10237.1 10242.7 388113.0 394776.0 396799.0 531065.0 536519.0 41626.8 41768.2 52423.7 63046.7 66475.7 1141.3 1165.6 1166.7 1181.8 1193.8 15743.5 15809.0 15866.2 15920.1 16192.7 34121.7 34147.5 34191.7 34361.8 34857.5 44997.6 45123.5 45352.1 45557.5 46337.0 9044.5 9077.0 9210.0 9211.8 9258.0 10743.9 13046.7 17676.3 17976.6 17990.5 13531.5 13813.0 13869.8 14160.9 14992.3 14235.4 14270.6 14310.5 14550.4 14631.2 14797.6 15036.7 15126.7 15179.7 15361.5 9182.8 9195.2 9424.5 9794.9 9844.7 11361.7 14550.2 14641.0 14902.2 15001.3 17:23:46 INFO - PROCESS | 20952 | 17:23:46 INFO - PROCESS | 20952 | [#3] mootools.html Cycles:180 Average:5348.46 Median:6284.10 stddev:2720.65 (43.3%) stddev-sans-first:2713.44 17:23:46 INFO - PROCESS | 20952 | Values: 1566.8 1664.4 1693.9 1745.5 1759.1 7357.3 7749.7 7751.1 7752.4 7836.8 7764.1 7769.4 7781.3 7802.0 7871.4 2251.7 2273.5 2293.7 2293.9 2299.3 2291.1 2314.7 2321.7 2326.0 2327.2 2127.4 2183.7 2183.7 2185.7 2221.1 2222.5 2271.4 2298.0 2307.7 2308.1 2243.8 2268.2 2270.7 2283.6 2286.0 7594.1 7597.5 7678.2 7686.3 7725.9 4637.3 4698.1 4711.5 4728.9 4730.1 3051.2 3075.1 3135.1 3150.4 3156.7 980.9 987.3 1018.4 1019.6 1032.2 10360.9 10423.2 10448.8 10475.2 10520.5 4174.5 4230.1 4269.2 4327.3 4328.2 8456.2 8467.8 8471.5 8498.6 8503.1 4664.9 4684.3 4691.2 4714.1 4719.7 4279.0 4291.2 4295.0 4332.7 4352.8 3365.6 3393.8 3395.8 3404.3 3422.2 1065.5 1070.3 1070.4 1078.0 1079.6 1061.3 1075.5 1119.1 1249.2 1377.8 7242.7 7271.1 7281.5 7308.3 7373.7 1109.7 1122.0 1135.3 1142.9 1143.1 5784.4 5797.5 5828.8 5845.8 5870.4 8940.9 8958.2 9153.8 9236.4 9239.3 9041.3 9055.4 9073.8 9128.2 9144.7 6905.2 7031.6 7074.4 7140.1 7279.9 6778.3 6805.6 6819.5 6826.9 6845.7 7923.0 8093.8 8139.5 8189.8 8233.7 8153.4 8183.6 8188.8 8251.0 8269.9 6302.5 6469.4 6502.5 6747.8 6768.0 7182.6 7211.9 7218.9 7260.5 7278.1 6792.3 6847.3 6950.1 7002.9 7023.5 6881.1 6887.8 6933.3 6959.0 6970.9 6796.8 6812.7 6827.3 6831.9 6842.3 6277.1 6291.1 6292.1 6314.6 6350.4 6107.9 6121.4 6383.2 6391.3 6407.2 17:23:46 INFO - PROCESS | 20952 | 17:23:46 INFO - PROCESS | 20952 | [#4] prototype.html Cycles:180 Average:5624.78 Median:6334.86 stddev:1703.47 (26.9%) stddev-sans-first:1661.51 17:23:46 INFO - PROCESS | 20952 | Values: 345.1 351.4 352.0 352.9 353.8 6301.4 6334.2 6440.0 6455.1 6469.8 6145.7 6295.6 6322.0 6342.0 6350.5 4836.4 4839.7 4842.9 4845.5 4861.8 4822.8 4834.3 4836.2 4853.2 4870.4 4670.3 4783.1 4801.5 4814.7 4817.8 4787.0 4804.1 4806.3 4823.4 4827.5 4176.9 4192.3 4194.3 4196.4 4198.8 5908.9 5981.7 6039.2 6074.1 6075.9 5575.8 5590.7 5590.8 5595.4 5598.6 6687.0 6703.3 6725.7 6732.1 6734.3 4577.8 4578.9 4587.3 4587.7 4620.2 6881.5 6953.9 7018.3 7024.0 7038.6 4696.5 4701.5 4715.8 4716.5 4740.0 4773.7 4785.4 4787.7 4790.4 4803.2 5447.9 5502.2 5518.3 5558.2 5573.2 6687.8 6793.8 6796.5 6797.5 6799.6 1664.1 1693.4 1704.3 1709.6 1710.1 1107.9 1138.0 1143.6 1154.1 1156.7 6267.3 6310.2 6332.5 6334.7 6336.6 6832.6 6853.3 6868.5 6871.5 6900.4 6305.2 6308.7 6335.0 6366.2 6380.8 3815.5 3830.7 3832.4 3839.5 3845.2 7068.7 7110.0 7110.3 7110.4 7110.9 7037.1 7225.4 7270.5 7272.1 7280.6 7037.8 7069.0 7070.1 7077.9 7079.2 7045.3 7048.6 7063.4 7066.8 7068.5 6776.2 6893.8 6956.5 6986.7 6998.2 7022.1 7061.3 7077.0 7078.6 7079.3 4754.9 4771.3 4784.2 4789.8 4796.0 6902.6 6992.3 7023.9 7037.6 7062.7 6845.7 6852.6 6863.0 6868.2 6878.9 6770.0 6789.2 6806.3 6822.2 6838.5 6477.2 6681.7 6695.9 6702.0 6706.0 6862.9 6867.4 6877.2 6879.9 6890.8 6617.6 6707.3 6707.5 6708.4 6713.2 17:23:46 INFO - PROCESS | 20952 | 17:23:46 INFO - PROCESS | 20952 | [#5] yui.html Cycles:180 Average:13774.33 Median:48704.63 stddev:16279.55 (33.4%) stddev-sans-first:16295.79 17:23:46 INFO - PROCESS | 20952 | Values: 739.4 776.7 844.9 862.3 895.2 13142.6 13402.7 13476.1 13476.9 13496.6 13042.2 13150.8 13243.9 14804.7 15240.6 814.4 821.8 824.2 825.1 827.0 805.8 813.1 813.2 815.2 816.2 859.9 861.0 862.2 869.1 872.0 852.6 855.3 857.8 859.1 860.4 620.6 621.0 622.5 626.1 627.5 13241.0 13259.5 13286.6 13288.7 13291.5 11820.0 12060.5 12111.9 12157.6 12264.1 9676.3 9684.0 9709.5 9818.5 10009.7 3565.9 3579.2 3626.3 3646.9 3694.0 48121.8 48238.0 48275.5 48553.0 48856.3 8654.8 8780.4 8780.7 8782.9 8970.0 15990.2 16043.4 16052.7 16073.5 16118.9 7039.4 7190.5 7345.7 7362.4 7412.9 4104.3 4176.6 4179.4 4190.8 4229.7 3030.5 3041.7 3047.9 3048.3 3064.0 540.6 550.2 556.8 560.5 574.0 458.8 557.3 582.5 582.9 618.3 8334.2 8858.5 9238.8 9299.0 9313.0 478.2 544.7 553.6 564.2 580.0 3704.6 3951.6 4134.6 4167.4 4236.0 52194.7 56075.4 58090.4 58181.7 58285.1 49336.3 52237.2 56592.0 57371.7 58901.1 45841.8 46169.8 46290.0 48023.5 48094.5 8665.2 8669.3 8697.3 8969.8 9025.1 33932.5 34547.8 34872.0 35052.3 35354.8 45885.0 45973.5 46067.8 46455.0 46932.8 9886.5 10366.6 10462.3 10464.5 10651.5 11255.4 11609.8 12005.2 12084.9 12524.9 11001.0 11056.1 11238.1 11486.9 11509.3 11131.9 11320.7 11435.9 11486.3 11797.7 10542.1 10546.8 10810.8 10948.7 11362.5 8740.1 9005.3 9073.3 9136.5 9205.9 9254.3 9584.0 9617.8 9684.6 9718.2 17:23:46 INFO - PROCESS | 20952 | -------- Summary: end -------- 17:23:46 INFO - PROCESS | 20952 | 17:23:47 INFO - TEST-INFO | 20952: exit 0 17:23:47 INFO - TEST-OK | dromaeo_css | took 1110539ms 17:23:47 INFO - TEST-START | kraken 17:23:47 INFO - operating with platform_type : linux_ 17:23:47 INFO - Initialising browser for kraken test... 17:23:47 INFO - TEST-INFO | started process 21189 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpptnWmx/profile http://localhost:57292/getInfo.html) 17:23:51 INFO - PROCESS | 21189 | __metrics Screen width/height:1600/1200 17:23:51 INFO - PROCESS | 21189 | colorDepth:24 17:23:51 INFO - PROCESS | 21189 | Browser inner width/height: 1024/697 17:23:51 INFO - PROCESS | 21189 | __metrics 17:23:51 INFO - PROCESS | 21189 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:23:52 INFO - TEST-INFO | 21189: exit 0 17:23:52 INFO - Browser initialized. 17:23:52 INFO - Running cycle 1/1 for kraken test... 17:23:52 INFO - TEST-INFO | started process 21309 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpptnWmx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:24:04 INFO - PROCESS | 21309 | RSS: Main: 150917120 17:24:04 INFO - PROCESS | 21309 | 17:24:07 INFO - PROCESS | 21309 | Cycle 1(1): loaded http://localhost:57292/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57292/tests/kraken/driver.html?testName=audio-beat-detection) 17:24:07 INFO - PROCESS | 21309 | RSS: Main: 151543808 17:24:07 INFO - PROCESS | 21309 | 17:24:10 INFO - PROCESS | 21309 | Cycle 1(1): loaded http://localhost:57292/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57292/tests/kraken/driver.html?testName=audio-dft) 17:24:11 INFO - PROCESS | 21309 | RSS: Main: 151924736 17:24:11 INFO - PROCESS | 21309 | 17:24:13 INFO - PROCESS | 21309 | Cycle 1(1): loaded http://localhost:57292/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57292/tests/kraken/driver.html?testName=audio-fft) 17:24:14 INFO - PROCESS | 21309 | RSS: Main: 146833408 17:24:14 INFO - PROCESS | 21309 | 17:24:16 INFO - PROCESS | 21309 | Cycle 1(1): loaded http://localhost:57292/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57292/tests/kraken/driver.html?testName=audio-oscillator) 17:24:17 INFO - PROCESS | 21309 | RSS: Main: 146649088 17:24:17 INFO - PROCESS | 21309 | 17:24:19 INFO - PROCESS | 21309 | Cycle 1(1): loaded http://localhost:57292/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57292/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:24:19 INFO - PROCESS | 21309 | RSS: Main: 147369984 17:24:19 INFO - PROCESS | 21309 | 17:24:22 INFO - PROCESS | 21309 | Cycle 1(1): loaded http://localhost:57292/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57292/tests/kraken/driver.html?testName=imaging-darkroom) 17:24:23 INFO - PROCESS | 21309 | RSS: Main: 147914752 17:24:23 INFO - PROCESS | 21309 | 17:24:26 INFO - PROCESS | 21309 | Cycle 1(1): loaded http://localhost:57292/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57292/tests/kraken/driver.html?testName=imaging-desaturate) 17:24:27 INFO - PROCESS | 21309 | RSS: Main: 148840448 17:24:27 INFO - PROCESS | 21309 | 17:24:30 INFO - PROCESS | 21309 | Cycle 1(1): loaded http://localhost:57292/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57292/tests/kraken/driver.html?testName=json-parse-financial) 17:24:30 INFO - PROCESS | 21309 | RSS: Main: 148992000 17:24:30 INFO - PROCESS | 21309 | 17:24:32 INFO - PROCESS | 21309 | Cycle 1(1): loaded http://localhost:57292/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57292/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:24:32 INFO - PROCESS | 21309 | RSS: Main: 149323776 17:24:32 INFO - PROCESS | 21309 | 17:24:34 INFO - PROCESS | 21309 | Cycle 1(1): loaded http://localhost:57292/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57292/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:24:35 INFO - PROCESS | 21309 | RSS: Main: 149041152 17:24:35 INFO - PROCESS | 21309 | 17:24:37 INFO - PROCESS | 21309 | Cycle 1(1): loaded http://localhost:57292/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57292/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:24:37 INFO - PROCESS | 21309 | RSS: Main: 149299200 17:24:37 INFO - PROCESS | 21309 | 17:24:40 INFO - PROCESS | 21309 | Cycle 1(1): loaded http://localhost:57292/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57292/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:24:41 INFO - PROCESS | 21309 | RSS: Main: 149843968 17:24:41 INFO - PROCESS | 21309 | 17:24:43 INFO - PROCESS | 21309 | Cycle 1(1): loaded http://localhost:57292/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57292/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:24:44 INFO - PROCESS | 21309 | RSS: Main: 148905984 17:24:44 INFO - PROCESS | 21309 | 17:24:45 INFO - PROCESS | 21309 | Cycle 1(1): loaded http://localhost:57292/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57292/tests/kraken/driver.html?testName=ai-astar) 17:24:46 INFO - PROCESS | 21309 | RSS: Main: 149323776 17:24:46 INFO - PROCESS | 21309 | 17:24:46 INFO - PROCESS | 21309 | __start_tp_report 17:24:46 INFO - PROCESS | 21309 | _x_x_mozilla_page_load 17:24:46 INFO - PROCESS | 21309 | _x_x_mozilla_page_load_details 17:24:46 INFO - PROCESS | 21309 | |i|pagename|runs| 17:24:46 INFO - PROCESS | 21309 | |0;ai-astar;112;108;112;111;112;123;111;111;111;118 17:24:46 INFO - PROCESS | 21309 | |1;audio-beat-detection;163;124;149;162;122;164;148;138;165;127 17:24:46 INFO - PROCESS | 21309 | |2;audio-dft;162;162;163;165;163;162;162;163;170;162 17:24:46 INFO - PROCESS | 21309 | |3;audio-fft;78;73;73;71;73;159;71;78;72;73 17:24:46 INFO - PROCESS | 21309 | |4;audio-oscillator;95;93;142;94;96;94;140;94;96;139 17:24:46 INFO - PROCESS | 21309 | |5;imaging-gaussian-blur;109;110;110;110;111;111;110;110;110;111 17:24:46 INFO - PROCESS | 21309 | |6;imaging-darkroom;146;149;146;147;147;146;146;146;146;146 17:24:46 INFO - PROCESS | 21309 | |7;imaging-desaturate;96;98;96;97;97;98;96;97;97;97 17:24:46 INFO - PROCESS | 21309 | |8;json-parse-financial;60;60;61;60;60;60;60;61;58;63 17:24:46 INFO - PROCESS | 21309 | |9;json-stringify-tinderbox;66;66;66;65;67;67;67;66;66;67 17:24:46 INFO - PROCESS | 21309 | |10;stanford-crypto-aes;84;86;86;86;86;85;89;87;86;85 17:24:46 INFO - PROCESS | 21309 | |11;stanford-crypto-ccm;122;123;125;122;124;127;119;126;124;126 17:24:46 INFO - PROCESS | 21309 | |12;stanford-crypto-pbkdf2;141;163;150;149;150;144;150;148;150;141 17:24:46 INFO - PROCESS | 21309 | |13;stanford-crypto-sha256-iterative;67;72;68;68;72;70;68;69;66;68 17:24:46 INFO - PROCESS | 21309 | __end_tp_report 17:24:46 INFO - PROCESS | 21309 | __start_cc_report 17:24:46 INFO - PROCESS | 21309 | _x_x_mozilla_cycle_collect,728 17:24:46 INFO - PROCESS | 21309 | __end_cc_report 17:24:46 INFO - PROCESS | 21309 | __startTimestamp1450833886121__endTimestamp 17:24:46 INFO - PROCESS | 21309 | 17:24:46 INFO - PROCESS | 21309 | ------- Summary: start ------- 17:24:46 INFO - PROCESS | 21309 | Number of tests: 14 17:24:46 INFO - PROCESS | 21309 | 17:24:46 INFO - PROCESS | 21309 | [#0] ai-astar Cycles:10 Average:112.90 Median:112.00 stddev:4.33 (3.9%) stddev-sans-first:4.58 17:24:46 INFO - PROCESS | 21309 | Values: 112.0 108.0 112.0 111.0 112.0 123.0 111.0 111.0 111.0 118.0 17:24:46 INFO - PROCESS | 21309 | 17:24:46 INFO - PROCESS | 21309 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:155.50 stddev:17.41 (11.2%) stddev-sans-first:17.37 17:24:46 INFO - PROCESS | 21309 | Values: 163.0 124.0 149.0 162.0 122.0 164.0 148.0 138.0 165.0 127.0 17:24:46 INFO - PROCESS | 21309 | 17:24:46 INFO - PROCESS | 21309 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:2.50 (1.5%) stddev-sans-first:2.60 17:24:46 INFO - PROCESS | 21309 | Values: 162.0 162.0 163.0 165.0 163.0 162.0 162.0 163.0 170.0 162.0 17:24:46 INFO - PROCESS | 21309 | 17:24:46 INFO - PROCESS | 21309 | [#3] audio-fft Cycles:10 Average:82.10 Median:73.00 stddev:27.14 (37.2%) stddev-sans-first:28.74 17:24:46 INFO - PROCESS | 21309 | Values: 78.0 73.0 73.0 71.0 73.0 159.0 71.0 78.0 72.0 73.0 17:24:46 INFO - PROCESS | 21309 | 17:24:46 INFO - PROCESS | 21309 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:94.00 stddev:22.14 (23.5%) stddev-sans-first:22.95 17:24:46 INFO - PROCESS | 21309 | Values: 95.0 93.0 142.0 94.0 96.0 94.0 140.0 94.0 96.0 139.0 17:24:46 INFO - PROCESS | 21309 | 17:24:46 INFO - PROCESS | 21309 | [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.50 17:24:46 INFO - PROCESS | 21309 | Values: 109.0 110.0 110.0 110.0 111.0 111.0 110.0 110.0 110.0 111.0 17:24:46 INFO - PROCESS | 21309 | 17:24:46 INFO - PROCESS | 21309 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 17:24:46 INFO - PROCESS | 21309 | Values: 146.0 149.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 17:24:46 INFO - PROCESS | 21309 | 17:24:46 INFO - PROCESS | 21309 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:97.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 17:24:46 INFO - PROCESS | 21309 | Values: 96.0 98.0 96.0 97.0 97.0 98.0 96.0 97.0 97.0 97.0 17:24:46 INFO - PROCESS | 21309 | 17:24:46 INFO - PROCESS | 21309 | [#8] json-parse-financial Cycles:10 Average:60.30 Median:60.00 stddev:1.25 (2.1%) stddev-sans-first:1.32 17:24:46 INFO - PROCESS | 21309 | Values: 60.0 60.0 61.0 60.0 60.0 60.0 60.0 61.0 58.0 63.0 17:24:46 INFO - PROCESS | 21309 | 17:24:46 INFO - PROCESS | 21309 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 17:24:46 INFO - PROCESS | 21309 | Values: 66.0 66.0 66.0 65.0 67.0 67.0 67.0 66.0 66.0 67.0 17:24:46 INFO - PROCESS | 21309 | 17:24:46 INFO - PROCESS | 21309 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:86.00 stddev:1.33 (1.6%) stddev-sans-first:1.20 17:24:46 INFO - PROCESS | 21309 | Values: 84.0 86.0 86.0 86.0 86.0 85.0 89.0 87.0 86.0 85.0 17:24:46 INFO - PROCESS | 21309 | 17:24:46 INFO - PROCESS | 21309 | [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:124.50 stddev:2.39 (1.9%) stddev-sans-first:2.45 17:24:46 INFO - PROCESS | 21309 | Values: 122.0 123.0 125.0 122.0 124.0 127.0 119.0 126.0 124.0 126.0 17:24:46 INFO - PROCESS | 21309 | 17:24:46 INFO - PROCESS | 21309 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.60 Median:150.00 stddev:6.26 (4.2%) stddev-sans-first:6.00 17:24:46 INFO - PROCESS | 21309 | Values: 141.0 163.0 150.0 149.0 150.0 144.0 150.0 148.0 150.0 141.0 17:24:46 INFO - PROCESS | 21309 | 17:24:46 INFO - PROCESS | 21309 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:68.50 stddev:1.99 (2.9%) stddev-sans-first:2.00 17:24:46 INFO - PROCESS | 21309 | Values: 67.0 72.0 68.0 68.0 72.0 70.0 68.0 69.0 66.0 68.0 17:24:46 INFO - PROCESS | 21309 | -------- Summary: end -------- 17:24:46 INFO - PROCESS | 21309 | 17:24:46 INFO - TEST-INFO | 21309: exit 0 17:24:46 INFO - TEST-OK | kraken | took 59456ms 17:24:46 INFO - TEST-START | v8_7 17:24:46 INFO - operating with platform_type : linux_ 17:24:46 INFO - Initialising browser for v8_7 test... 17:24:47 INFO - TEST-INFO | started process 21598 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8VbWDn/profile http://localhost:57292/getInfo.html) 17:24:51 INFO - PROCESS | 21598 | __metrics Screen width/height:1600/1200 17:24:51 INFO - PROCESS | 21598 | colorDepth:24 17:24:51 INFO - PROCESS | 21598 | Browser inner width/height: 1024/697 17:24:51 INFO - PROCESS | 21598 | __metrics 17:24:51 INFO - PROCESS | 21598 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:24:52 INFO - TEST-INFO | 21598: exit 0 17:24:52 INFO - Browser initialized. 17:24:52 INFO - Running cycle 1/1 for v8_7 test... 17:24:52 INFO - TEST-INFO | started process 21719 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8VbWDn/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:25:04 INFO - PROCESS | 21719 | RSS: Main: 150908928 17:25:04 INFO - PROCESS | 21719 | 17:25:25 INFO - PROCESS | 21719 | Cycle 1(1): loaded http://localhost:57292/tests/v8_7/run.html (next: http://localhost:57292/tests/v8_7/run.html) 17:25:25 INFO - PROCESS | 21719 | RSS: Main: 146886656 17:25:25 INFO - PROCESS | 21719 | 17:25:25 INFO - PROCESS | 21719 | __start_tp_report 17:25:25 INFO - PROCESS | 21719 | _x_x_mozilla_page_load 17:25:25 INFO - PROCESS | 21719 | _x_x_mozilla_page_load_details 17:25:25 INFO - PROCESS | 21719 | |i|pagename|runs| 17:25:25 INFO - PROCESS | 21719 | |0;Richards;165.61775422325275 17:25:25 INFO - PROCESS | 21719 | |1;DeltaBlue;187.4062968515742 17:25:25 INFO - PROCESS | 21719 | |2;Encrypt;281.61081385525205 17:25:25 INFO - PROCESS | 21719 | |3;Decrypt;5138.461538461538 17:25:25 INFO - PROCESS | 21719 | |4;RayTrace;1058.2010582010582 17:25:25 INFO - PROCESS | 21719 | |5;Earley;695.8942240779402 17:25:25 INFO - PROCESS | 21719 | |6;Boyer;12156.626506024097 17:25:25 INFO - PROCESS | 21719 | |7;RegExp;25550 17:25:25 INFO - PROCESS | 21719 | |8;Splay;644.3298969072165 17:25:25 INFO - PROCESS | 21719 | |9;NavierStokes;4840.579710144928 17:25:25 INFO - PROCESS | 21719 | __end_tp_report 17:25:25 INFO - PROCESS | 21719 | __startTimestamp1450833925811__endTimestamp 17:25:25 INFO - PROCESS | 21719 | 17:25:25 INFO - PROCESS | 21719 | ------- Summary: start ------- 17:25:25 INFO - PROCESS | 21719 | Number of tests: 10 17:25:25 INFO - PROCESS | 21719 | 17:25:25 INFO - PROCESS | 21719 | [#0] Richards Cycles:1 Average:165.62 Median:165.62 stddev:0.00 (0.0%) 17:25:25 INFO - PROCESS | 21719 | Values: 165.6 17:25:25 INFO - PROCESS | 21719 | 17:25:25 INFO - PROCESS | 21719 | [#1] DeltaBlue Cycles:1 Average:187.41 Median:187.41 stddev:0.00 (0.0%) 17:25:25 INFO - PROCESS | 21719 | Values: 187.4 17:25:25 INFO - PROCESS | 21719 | 17:25:25 INFO - PROCESS | 21719 | [#2] Encrypt Cycles:1 Average:281.61 Median:281.61 stddev:0.00 (0.0%) 17:25:25 INFO - PROCESS | 21719 | Values: 281.6 17:25:25 INFO - PROCESS | 21719 | 17:25:25 INFO - PROCESS | 21719 | [#3] Decrypt Cycles:1 Average:5138.46 Median:5138.46 stddev:0.00 (0.0%) 17:25:25 INFO - PROCESS | 21719 | Values: 5138.5 17:25:25 INFO - PROCESS | 21719 | 17:25:25 INFO - PROCESS | 21719 | [#4] RayTrace Cycles:1 Average:1058.20 Median:1058.20 stddev:0.00 (0.0%) 17:25:25 INFO - PROCESS | 21719 | Values: 1058.2 17:25:25 INFO - PROCESS | 21719 | 17:25:25 INFO - PROCESS | 21719 | [#5] Earley Cycles:1 Average:695.89 Median:695.89 stddev:0.00 (0.0%) 17:25:25 INFO - PROCESS | 21719 | Values: 695.9 17:25:25 INFO - PROCESS | 21719 | 17:25:25 INFO - PROCESS | 21719 | [#6] Boyer Cycles:1 Average:12156.63 Median:12156.63 stddev:0.00 (0.0%) 17:25:25 INFO - PROCESS | 21719 | Values: 12156.6 17:25:25 INFO - PROCESS | 21719 | 17:25:25 INFO - PROCESS | 21719 | [#7] RegExp Cycles:1 Average:25550.00 Median:25550.00 stddev:0.00 (0.0%) 17:25:25 INFO - PROCESS | 21719 | Values: 25550.0 17:25:25 INFO - PROCESS | 21719 | 17:25:25 INFO - PROCESS | 21719 | [#8] Splay Cycles:1 Average:644.33 Median:644.33 stddev:0.00 (0.0%) 17:25:25 INFO - PROCESS | 21719 | Values: 644.3 17:25:25 INFO - PROCESS | 21719 | 17:25:25 INFO - PROCESS | 21719 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 17:25:25 INFO - PROCESS | 21719 | Values: 4840.6 17:25:25 INFO - PROCESS | 21719 | -------- Summary: end -------- 17:25:25 INFO - PROCESS | 21719 | 17:25:26 INFO - TEST-INFO | 21719: exit 0 17:25:26 INFO - TEST-OK | v8_7 | took 39671ms 17:25:26 INFO - SUITE-END | took 1209s 17:25:26 INFO - Completed test suite (00:20:09) 17:25:26 INFO - Working with test: dromaeo_css 17:25:26 INFO - Generating results file: dromaeo_css 17:25:26 INFO - Working with test: kraken 17:25:26 INFO - Generating results file: kraken 17:25:26 INFO - javascript benchmark 17:25:26 INFO - Working with test: v8_7 17:25:26 INFO - Generating results file: v8_7 17:25:26 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:25:26 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 17:25:26 INFO - process_Request line: dromaeo_css 7113.55 graph.html#tests=[[72,64,43]] 17:25:26 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:25:27 INFO - process_Request line: kraken 1520.30 graph.html#tests=[[232,64,43]] 17:25:27 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:25:27 INFO - process_Request line: v8_7 21325.98 graph.html#tests=[[230,64,43]] 17:25:27 INFO - RETURN: dromaeo_css: 7113.55 17:25:27 INFO - RETURN: kraken: 1520.30 17:25:27 INFO - RETURN: v8_7: 21325.98 17:25:27 INFO - javascript benchmark 17:25:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3171.540126681631, 3187.2669286064206, 3219.3883162199195, 3224.387366400383, 3227.080282119595, 5283.8150664726745, 5341.092014357559, 5350.491703288186, 5351.357837059549, 5370.91943620846, 5331.920021199685, 5350.036993341197, 5358.866028349294, 5372.086745253307, 5435.0, 4855.805767769285, 4946.332245146913, 4983.551480366767, 5026.070177017264, 5071.290019397287, 5013.197888337867, 5050.520200580939, 5061.873453163682, 5097.745112744348, 5111.309973153632, 4712.316714076457, 4799.808007679689, 4839.0, 4848.224284114543, 4967.254911763228, 4955.801767929279, 4962.206047032458, 4971.055499455092, 4973.179425394806, 5004.624653150991, 4914.950850491485, 4953.257011448276, 4957.231629097496, 4969.956309175078, 4989.326440930464, 5177.663451875616, 5254.816081437131, 5259.631825772198, 5278.287431196778, 5378.569714422837, 5781.624194427349, 5820.650760954314, 5825.446582574648, 5830.0, 5940.821775346703, 5931.673757943311, 5939.584229103964, 5940.6435613863305, 5945.108233764927, 5963.0, 5528.695921724304, 5533.5849811263915, 5534.308211473566, 5535.58483113764, 5536.861578460571, 5798.246227990334, 5904.439078287556, 5962.493188079062, 5981.850453738692, 5987.670678112746, 5734.713264336767, 5737.512311453574, 5756.971215143897, 5778.768849245983, 5802.680852553066, 5855.326637436664, 5868.119782032644, 5876.529877609781, 5893.911591326134, 5908.172855800191, 5670.829875103754, 5795.82612521625, 5798.362180160179, 5809.651420914674, 5904.675242861598, 5888.705564721747, 5893.528517718572, 5893.882122357529, 5896.115582662635, 5898.351181370046, 4466.196084704784, 4476.395686582269, 4499.257622492318, 4503.707259028152, 4558.475775285819, 3821.140243445258, 3918.4122381642983, 3964.306246406867, 4003.739756915791, 4029.8388064477094, 5434.70109143993, 5470.452954704498, 5503.00519777823, 5519.282493275929, 5531.557475401958, 5631.436856314336, 5849.385814489502, 5868.178455016301, 5873.706314684248, 5878.412158784173, 5381.300430943952, 5410.269613602192, 5465.781368745205, 5481.890362192734, 5510.6969116698965, 4975.850724478271, 5009.499050094962, 5029.748512574357, 5045.091883460939, 5058.570021548209, 5628.774849006076, 5906.438888305604, 5913.615614985012, 5914.349421563625, 5933.614315069507, 5804.303483581828, 5857.384974577779, 5885.352611212848, 5942.73257703413, 5977.3126090500145, 5809.970950145223, 5812.273465816773, 5828.213191219131, 5894.410558944071, 5925.525957923442, 5662.745176467151, 5781.21953536284, 5781.4507621775865, 5787.884242315046, 5792.333881603669, 5805.593608447368, 5810.564207684525, 5900.232969713909, 5910.763569457174, 5955.017422125301, 5739.282589676291, 5743.282089738783, 5747.339056008445, 5754.251947246831, 5776.133579963039, 5556.194351819045, 5584.106542953108, 5774.8845023098465, 5790.739416726342, 5796.855078623068, 5619.8876022480135, 5636.85907852307, 5656.151577263443, 5664.886702265849, 5727.541796656341, 5701.40135285789, 5724.79963201286, 5749.310082790092, 5755.0, 5776.653400795965, 5451.291332126798, 5548.223248745259, 5556.638818476948, 5645.830625081254, 5647.350554686263], "unit": "score", "name": "dojo.html", "value": 5367.826139057041}, {"lowerIsBetter": false, "replicates": [564.7882044233412, 616.7687117331, 618.0944915698498, 620.481897615491, 623.9376062393758, 36447.635523644756, 36703.81648091756, 36738.63261367386, 36789.44815827765, 36836.63163368365, 42062.0, 42627.36058959118, 42760.572394276045, 42774.786126069324, 43064.56935430645, 8684.826303473943, 8799.95600021999, 8809.339299552526, 8843.027267000625, 8854.601542930584, 8611.397202195849, 8630.525321107336, 8647.264982476465, 8724.956375218148, 8733.0, 8675.08911564286, 8766.298696104328, 8812.206901378875, 8822.250108740765, 8827.867581986244, 8673.913260867404, 8724.171203735636, 8766.342524310703, 8804.823903521894, 8814.735557933273, 8558.101399353041, 8762.211400973943, 8780.429272097294, 8787.560621968876, 8792.164744349277, 39657.80171099126, 39669.20661586752, 39806.80096599498, 40014.19971600552, 40103.79948100241, 3491.9825400873087, 3627.546556680415, 3854.6338097880657, 4028.3554631258858, 4034.9596504034876, 28869.0, 28878.566821497694, 29114.272143196376, 29356.853215733998, 30114.54828177579, 3935.488386509764, 3983.3626619740994, 3989.3018721723874, 4064.329385651364, 4124.52567954683, 278696.0, 278730.99999999796, 278763.0, 279858.6007069972, 282349.0, 50923.0, 51764.74117629463, 54764.726176368866, 60306.396936030076, 61281.69359153176, 56069.71965140148, 56083.0, 56211.71894140503, 56328.436715633135, 56540.0, 15582.220888955508, 15651.434856514257, 15660.373585056697, 15781.210939452982, 15838.76241856373, 11605.419729013516, 11620.477078531487, 11635.825462618068, 11698.70753231176, 11796.351200684045, 18365.3572124975, 18412.631747365245, 18582.628347433245, 18589.44231673052, 18589.535261618566, 7867.803304917423, 7996.400269979775, 8021.5187088774865, 8253.587320634064, 8305.750827475065, 859.5229647545547, 944.1832814615308, 949.8480243161199, 976.4483067067084, 1068.471106802138, 28106.437871242462, 28712.0, 28745.71254287472, 28994.855025724737, 29406.0, 1032.3341444768232, 1050.4642632257603, 1077.2997551591527, 1095.5562996986234, 1101.2566517600587, 13920.651983700489, 14280.428782848778, 14332.355044023045, 14365.92817035929, 14381.424743010162, 315676.0, 324452.0, 325045.0, 325116.0, 326011.0, 43499.0, 43754.78122609366, 43864.780676096416, 43867.0, 43977.34033989493, 1320.6830360713552, 1335.105479328852, 1339.55125033115, 1356.2405053170257, 1366.1393322206748, 25767.742322577284, 27219.727802721718, 27317.863410682818, 27356.316092097855, 28440.85779571089, 39845.60154398419, 39908.60091399165, 40016.59983400129, 40123.79938100291, 40131.59868401395, 247186.0, 248172.0, 248700.0, 248942.0, 249326.0, 30607.54088688716, 31679.683203168595, 32128.678713213503, 32163.03510894677, 32213.35573288568, 38050.0, 39588.80205598954, 40541.797291013354, 41057.0, 41132.79433602813, 33329.0, 34079.4888076684, 34549.48175777315, 34740.652593473744, 35076.82461587676, 34387.31225375429, 34898.82550587333, 35366.46950295696, 35519.0, 35781.46327805033, 32892.83553582313, 33299.167520812174, 33795.83102084474, 33960.0, 34182.0, 28990.710092899644, 29951.400971980875, 31268.218294542818, 31658.733650653718, 31714.365712685154, 24119.22628897629, 24316.392090197885, 24426.51146977015, 24643.260702178963, 24689.553693043476], "unit": "score", "name": "ext.html", "value": 18069.653191736576}, {"lowerIsBetter": false, "replicates": [363.69631357816223, 364.67908240748136, 365.14555939102496, 367.7444176297474, 368.4730834906083, 16424.178791060443, 16938.407155749537, 17563.121843907786, 17645.117744112777, 18222.453326400195, 11080.168987325962, 11587.246828956111, 13192.27442490665, 13193.472261109568, 13224.074314797968, 4804.231322988323, 5575.888482230353, 5581.7209139543065, 5601.411851755568, 5611.438856114376, 5504.311961004874, 5532.1425179097105, 5537.695426751527, 5545.805896793613, 5547.861303467405, 5364.249005139283, 5539.861503462405, 6290.339514350996, 6497.122888410051, 6506.642134682591, 6397.968010159966, 6457.580257283285, 6484.740610375579, 6898.896516552256, 6909.792706218822, 6560.934390656128, 6574.408303252731, 6602.702878370437, 6604.570702904296, 6617.602943823338, 22560.43598910024, 22734.77265227343, 22911.77088229113, 23200.187993420317, 23879.283621491384, 2278.874661893595, 2304.5621331947045, 2317.478567322356, 2359.056377449017, 2395.5089206712582, 14338.56984290473, 14387.208703521303, 14401.783973240304, 15070.623234419227, 15117.622059448602, 1955.1690531524046, 1994.601079784049, 2015.6674148765437, 2080.4382816639422, 2094.1518684932626, 65167.06748196342, 69772.6511367445, 70374.2962570378, 71216.64391678009, 71809.0, 15265.389384424721, 15567.221638918008, 15631.84368156304, 15665.29506172225, 15764.896457248113, 24257.878710606336, 24301.39246518851, 24347.26958191257, 24589.38526536815, 24647.753522464904, 8949.731508054638, 8981.236594889377, 8984.371094023487, 9013.63945442188, 9081.228095611816, 7556.58438785861, 7569.280918312751, 7592.392608591299, 7608.467407281437, 7615.619219039026, 7647.617619119022, 7816.218378162252, 7849.332806711379, 7871.645775940096, 8008.0, 1886.9433916982512, 1928.9614207716047, 3155.191879227489, 3262.862824849727, 3314.105191598255, 886.6719313853915, 889.4040992535017, 899.6401439424283, 942.8727121838601, 1057.5611121384538, 16469.505914822574, 16915.23881425339, 17503.47489575315, 17511.474655760347, 18147.909260453613, 935.4013431403907, 939.3847030195096, 966.7679756858304, 974.6734843827255, 974.7514383832078, 9999.0, 10093.899061009442, 10181.981801819908, 10237.129843963347, 10242.692719218436, 388113.0, 394776.0, 396799.0, 531065.0, 536519.0, 41626.791866040476, 41768.164636707705, 52423.73788131111, 63046.73906521844, 66475.66762166159, 1141.2923987127867, 1165.6211731187398, 1166.650004998497, 1181.781370446453, 1193.779150857077, 15743.527694169194, 15809.0, 15866.206689665702, 15920.124393158025, 16192.67614647677, 34121.65878341185, 34147.48778768271, 34191.72454367321, 34361.82819085888, 34857.47713784346, 44997.55002449934, 45123.548764511936, 45352.092958141315, 45557.544424556654, 46337.0, 9044.50255235942, 9076.954615226881, 9210.032946540518, 9211.76970575741, 9257.953710231675, 10743.871387233128, 13046.739065218453, 17676.292948281924, 17976.550586235448, 17990.460286191435, 13531.458741650224, 13813.0, 13869.791953120914, 14160.929195353958, 14992.325345359703, 14235.359408826835, 14270.643233919234, 14310.49913253031, 14550.41798328055, 14631.195284259467, 14797.556073317817, 15036.699266014837, 15126.697466050837, 15179.696406072038, 15361.462348817739, 9182.770430739285, 9195.218406435528, 9424.528773561431, 9794.902050979685, 9844.704658860246, 11361.715957101138, 14550.199739014455, 14641.0, 14902.1803800792, 15001.324940377928], "unit": "score", "name": "jquery.html", "value": 9617.906119175113}, {"lowerIsBetter": false, "replicates": [1566.7806507089017, 1664.4257731082776, 1693.906835124068, 1745.467632372127, 1759.0852756566578, 7357.30105639964, 7749.651265693044, 7751.069871615407, 7752.418568607349, 7836.764897053084, 7764.107127680319, 7769.378449724023, 7781.2607802258835, 7802.024746906637, 7871.448998570102, 2251.6509940959177, 2273.4998300373973, 2293.7247530296386, 2293.8508996915148, 2299.2642354446584, 2291.0950174680993, 2314.687517185184, 2321.6749655048307, 2326.0, 2327.173853282086, 2127.4043267885017, 2183.650615901456, 2183.7161169048, 2185.7486389065302, 2221.056051178251, 2222.466608014065, 2271.375371772759, 2298.0463107810237, 2307.6653885186556, 2308.0998410619873, 2243.753187149412, 2268.194790849258, 2270.71616047994, 2283.5889539882814, 2285.954280914389, 7594.088709354913, 7597.468177227596, 7678.193789652062, 7686.346660533862, 7725.884111738328, 4637.25803871379, 4698.08387364464, 4711.505291944331, 4728.858134255978, 4730.148573256813, 3051.2371907023244, 3075.0928476099602, 3135.0594821553673, 3150.401423729507, 3156.700113489215, 980.9068138526828, 987.333549853853, 1018.4347687033693, 1019.6125472320545, 1032.1536340201037, 10360.94819525905, 10423.166146708245, 10448.791024179474, 10475.214358923035, 10520.473976301155, 4174.519930208005, 4230.111676547959, 4269.167512335127, 4327.307630779061, 4328.242557552416, 8456.154384561494, 8467.830643387098, 8471.534065626449, 8498.617562209716, 8503.107173746792, 4664.86005419838, 4684.273937539687, 4691.179043667413, 4714.080754252887, 4719.669623126349, 4278.957210427856, 4291.249031419551, 4294.969207390266, 4332.696711230246, 4352.825886964486, 3365.5528122907385, 3393.7624366294617, 3395.7792743471596, 3404.2510647657477, 3422.247105636756, 1065.504540388723, 1070.272214893864, 1070.352436775755, 1077.9514921828536, 1079.611339917629, 1061.3207547169818, 1075.5321435175724, 1119.1158984402393, 1249.1505776072358, 1377.7864431013209, 7242.746503872339, 7271.054762880792, 7281.507291005331, 7308.269173082649, 7373.705051797975, 1109.7114750165015, 1121.971950701239, 1135.2620796482188, 1142.9199956003, 1143.085531574737, 5784.363719990798, 5797.4782269595935, 5828.766849326064, 5845.795397161079, 5870.354261031283, 8940.8658870117, 8958.19376256127, 9153.81692366149, 9236.445813251226, 9239.30705197113, 9041.321900857462, 9055.36612437123, 9073.818523629623, 9128.22410095136, 9144.679936202201, 6905.205901321312, 7031.613261270679, 7074.434045276365, 7140.107486564179, 7279.89080163798, 6778.288279730557, 6805.557638753465, 6819.5226334158115, 6826.941824017285, 6845.691943862637, 7923.0, 8093.757187284391, 8139.511629302261, 8189.754307370788, 8233.670653174046, 8153.388495862715, 8183.590820458834, 8188.836223275382, 8250.958745206235, 8269.917300826915, 6302.495800335871, 6469.417752402306, 6502.544821862613, 6747.763828265987, 6768.0, 7182.569045857265, 7211.8557628848175, 7218.855622887408, 7260.528065675714, 7278.126624805057, 6792.252852186157, 6847.34950179752, 6950.096487456598, 7002.859942801218, 7023.508354415347, 6881.10446533435, 6887.827804304732, 6933.306669333027, 6959.0, 6970.860582788418, 6796.76211332601, 6812.727490900506, 6827.283135270924, 6831.89752153728, 6842.315768423118, 6277.121203031488, 6291.087792270004, 6292.056191571301, 6314.589551679126, 6350.396712312323, 6107.938920610737, 6121.4490695837585, 6383.170187875547, 6391.265004524354, 6407.199100112486], "unit": "score", "name": "mootools.html", "value": 4422.969991165904}, {"lowerIsBetter": false, "replicates": [345.082081662777, 351.36929212064325, 351.9542459480267, 352.8800207929307, 353.81167479141504, 6301.40136687014, 6334.176557047583, 6439.967800160998, 6455.128557644723, 6469.773557925473, 6145.72344244509, 6295.646436016255, 6321.968390158055, 6342.0486926960975, 6350.460210882069, 4836.443808961962, 4839.661223714342, 4842.927356089662, 4845.491223421543, 4861.781219845116, 4822.831200907969, 4834.323194752737, 4836.226203807391, 4853.223484242504, 4870.391201099863, 4670.346151538787, 4783.067301876118, 4801.4718380978065, 4814.66297359185, 4817.831375901844, 4787.018661174451, 4804.1352556539805, 4806.255030470283, 4823.397075365579, 4827.541383568555, 4176.937345939813, 4192.266353388145, 4194.2869712149, 4196.412502249687, 4198.8243291878325, 5908.881822363529, 5981.730822113015, 6039.184710064129, 6074.058520929263, 6075.878482430371, 5575.804846830382, 5590.748416321235, 5590.776368945238, 5595.38450770415, 5598.552115830724, 6686.966565167143, 6703.262641109474, 6725.66371681414, 6732.091167692348, 6734.259231484532, 4577.839775607871, 4578.908421831578, 4587.288970209623, 4587.678862479628, 4620.19146649335, 6881.4860730639175, 6953.860922781567, 7018.263082376328, 7023.964880175567, 7038.577685338896, 4696.530346965276, 4701.529847015271, 4715.81136754526, 4716.457607375127, 4740.028294199681, 4773.689710168897, 4785.377900872864, 4787.712737235777, 4790.4251489821445, 4803.207470767354, 5447.918281225785, 5502.174673798962, 5518.33779946401, 5558.194061861008, 5573.164025396223, 6687.76592819249, 6793.796186114326, 6796.52424330302, 6797.456203503807, 6799.626020568916, 1664.0847533856331, 1693.3649881294514, 1704.2927185217995, 1709.572606848288, 1710.0765586583107, 1107.8615173103362, 1137.9772404551863, 1143.5997400909782, 1154.0825044089968, 1156.670348950545, 6267.2792628848265, 6310.1796766420075, 6332.525060620472, 6334.714937827809, 6336.58812177207, 6832.555883867532, 6853.314668533207, 6868.450523958071, 6871.4502839772695, 6900.378965892994, 6305.180326557518, 6308.716107775161, 6335.0, 6366.172397588284, 6380.776672816429, 3815.542134943769, 3830.693544516432, 3832.3676593362343, 3839.462475253467, 3845.1540661054523, 7068.717251309993, 7109.964450177716, 7110.253423390573, 7110.431165506747, 7110.893336599956, 7037.120359955005, 7225.421966242688, 7270.4910656254615, 7272.090988626422, 7280.599567023864, 7037.788866334018, 7069.045678833395, 7070.116235470567, 7077.858442831114, 7079.221285658574, 7045.295470452914, 7048.612326322102, 7063.434925205868, 7066.752663656747, 7068.505204635626, 6776.186857577122, 6893.7931862044215, 6956.478264130312, 6986.720531178696, 6998.16022077354, 7022.12223472066, 7061.293870612898, 7076.964615177097, 7078.646067696697, 7079.2566780487305, 4754.857354279377, 4771.332013518179, 4784.186688262934, 4789.808407663654, 4795.95204047955, 6902.585844849325, 6992.300769922967, 7023.929760702327, 7037.612931288828, 7062.71749130029, 6845.726170953305, 6852.588844669336, 6862.965685171742, 6868.210155832143, 6878.8624227516175, 6770.01834733951, 6789.219239787488, 6806.251312355538, 6822.215445223863, 6838.521303508706, 6477.190351206099, 6681.699323530355, 6695.866082678222, 6701.966490167713, 6706.0, 6862.862742745017, 6867.416269616939, 6877.1747390313485, 6879.862402752017, 6890.793276201722, 6617.569857959217, 6707.262201157771, 6707.530472867048, 6708.42978346846, 6713.1944166700305], "unit": "score", "name": "prototype.html", "value": 5069.136218812124}, {"lowerIsBetter": false, "replicates": [739.4158614694392, 776.7126163319571, 844.8986121665401, 862.2670729879599, 895.1853813030142, 13142.605721828337, 13402.731945361087, 13476.05667603267, 13476.932615336935, 13496.595102146926, 13042.217466951966, 13150.802737958938, 13243.933780331085, 14804.703905921875, 15240.618984525392, 814.4136221920209, 821.7986593284654, 824.1758241758242, 825.0882774534143, 826.9917300827005, 805.7985503624094, 813.0974618173823, 813.1543195077143, 815.176671561721, 816.1878930464167, 859.9140085991413, 860.9612567434481, 862.1550880137469, 869.0831173112364, 872.0451106038877, 852.5651917522108, 855.324293807891, 857.7984173719171, 859.0764927702744, 860.4407135362002, 620.5625034350817, 620.9627422354628, 622.4615707413055, 626.145311649595, 627.4980015987237, 13241.0, 13259.46962121514, 13286.60140195786, 13288.667783305398, 13291.53479628218, 11820.0, 12060.517579296906, 12111.939440302831, 12157.586184606378, 12264.141510094298, 9676.274279429, 9684.0, 9709.514524273829, 9818.509074546244, 10009.749756256078, 3565.893023209308, 3579.2304654499408, 3626.2566173934542, 3646.8723594674325, 3694.021084412606, 48121.75939120317, 48238.0, 48275.51724482745, 48553.0, 48856.26715599269, 8654.826903461895, 8780.429272097294, 8780.692675756318, 8782.912170878337, 8969.955150224338, 15990.200489975454, 16043.438479653156, 16052.678946421007, 16073.517794466185, 16118.919405402898, 7039.366457018893, 7190.460715446363, 7345.7428989986165, 7362.3741981932135, 7412.925870741331, 4104.343305071175, 4176.62410383067, 4179.352200408942, 4190.769507677107, 4229.725067870579, 3030.530267808493, 3041.7110374514828, 3047.9390412191633, 3048.2988912550236, 3063.954040689347, 540.6107602526175, 550.1500182218482, 556.8023351710166, 560.4815545620285, 574.047081844145, 458.83940620783125, 557.2950217974266, 582.4815913836688, 582.8834233153386, 618.3167599802243, 8334.20825021622, 8858.512781797062, 9238.815223695488, 9299.0, 9313.0, 478.1894688503024, 544.6868050870766, 553.6041730162952, 564.179104477612, 580.0371383503364, 3704.592494825567, 3951.636978803884, 4134.586541345901, 4167.354060120686, 4236.0, 52194.739026304625, 56075.439245607835, 58090.419095809346, 58181.70909145427, 58285.125723114186, 49336.25995610069, 52237.216441752644, 56592.0, 57371.713141434026, 58901.11648325193, 45841.77079114583, 46169.76915115403, 46290.0, 48023.5197648026, 48094.5190548097, 8665.17680820321, 8669.349798765244, 8697.304215662605, 8969.775755606162, 9025.142611451902, 33932.49101263434, 34547.82726086354, 34872.0, 35052.29895402129, 35354.82322588371, 45885.0, 45973.54026459826, 46067.76966115148, 46455.0, 46932.76533617447, 9886.4562449066, 10366.637167699095, 10462.267641265038, 10464.476776161313, 10651.520681569504, 11255.380954047607, 11609.825852612048, 12005.159638825198, 12084.879151208375, 12524.874751252371, 11001.0, 11056.115510758958, 11238.10095192399, 11486.885131148916, 11509.309441433541, 11131.888681113409, 11320.660380188607, 11435.942820285845, 11486.310821350746, 11797.705057373634, 10542.103921166787, 10546.789064218827, 10810.783784324427, 10948.671539853816, 11362.488688008894, 8740.125987401208, 9005.324600654845, 9073.274138069071, 9136.497492637704, 9205.861912071457, 9254.305927055364, 9583.952080239555, 9617.807643847224, 9684.612615495302, 9718.222542196467], "unit": "score", "name": "yui.html", "value": 6194.44143015325}], "name": "dromaeo_css", "value": 7113.54540701895}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 112.0, 111.0, 112.0, 123.0, 111.0, 111.0, 111.0, 118.0], "unit": "score", "name": "ai-astar", "value": 112.9}, {"lowerIsBetter": true, "replicates": [163.0, 124.0, 149.0, 162.0, 122.0, 164.0, 148.0, 138.0, 165.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 163.0, 165.0, 163.0, 162.0, 162.0, 163.0, 170.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.4}, {"lowerIsBetter": true, "replicates": [78.0, 73.0, 73.0, 71.0, 73.0, 159.0, 71.0, 78.0, 72.0, 73.0], "unit": "score", "name": "audio-fft", "value": 82.1}, {"lowerIsBetter": true, "replicates": [95.0, 93.0, 142.0, 94.0, 96.0, 94.0, 140.0, 94.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 111.0, 111.0, 110.0, 110.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [146.0, 149.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 96.0, 97.0, 97.0, 98.0, 96.0, 97.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.9}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 61.0, 58.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 60.3}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 65.0, 67.0, 67.0, 67.0, 66.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.3}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 86.0, 86.0, 86.0, 85.0, 89.0, 87.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [122.0, 123.0, 125.0, 122.0, 124.0, 127.0, 119.0, 126.0, 124.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.8}, {"lowerIsBetter": true, "replicates": [141.0, 163.0, 150.0, 149.0, 150.0, 144.0, 150.0, 148.0, 150.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.6}, {"lowerIsBetter": true, "replicates": [67.0, 72.0, 68.0, 68.0, 72.0, 70.0, 68.0, 69.0, 66.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1520.2999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.61775422325275], "unit": "score", "name": "Richards", "value": 213.15347599999996}, {"lowerIsBetter": false, "replicates": [187.4062968515742], "unit": "score", "name": "DeltaBlue", "value": 352.8056479999999}, {"lowerIsBetter": false, "replicates": [281.61081385525205], "unit": "score", "name": "Encrypt", "value": 945.2087309999996}, {"lowerIsBetter": false, "replicates": [5138.461538461538], "unit": "score", "name": "Decrypt", "value": 51.80169161676644}, {"lowerIsBetter": false, "replicates": [1058.2010582010582], "unit": "score", "name": "RayTrace", "value": 699.2896049999997}, {"lowerIsBetter": false, "replicates": [695.8942240779402], "unit": "score", "name": "Earley", "value": 957.7073310000004}, {"lowerIsBetter": false, "replicates": [12156.626506024097], "unit": "score", "name": "Boyer", "value": 54.82302180376615}, {"lowerIsBetter": false, "replicates": [25550.0], "unit": "score", "name": "RegExp", "value": 35.65499021526421}, {"lowerIsBetter": false, "replicates": [644.3298969072165], "unit": "score", "name": "Splay", "value": 126.47403200000002}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21325.982205816872}]} 17:25:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21325.98"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1520.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "7113.55"}}} 17:25:27 INFO - Return code: 0 17:25:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:25:27 INFO - # TBPL SUCCESS # 17:25:27 INFO - Running post-action listener: _resource_record_post_action 17:25:27 INFO - Running post-run listener: _resource_record_post_run 17:25:28 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 16384; Write bytes: 571379712; Read time: 576; Write time: 889816 17:25:28 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 8192; Write bytes: 250470400; Read time: 288; Write time: 521924 17:25:28 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 8192; Write bytes: 320909312; Read time: 288; Write time: 367892 17:25:28 INFO - Running post-run listener: _upload_blobber_files 17:25:28 INFO - Blob upload gear active. 17:25:28 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:25:28 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 17:25:28 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'] 17:25:28 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 17:25:28 INFO - (blobuploader) - INFO - Open directory for files ... 17:25:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:25:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:25:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:25:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:25:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:25:29 INFO - (blobuploader) - INFO - Done attempting. 17:25:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:25:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:25:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:25:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:25:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:25:30 INFO - (blobuploader) - INFO - Done attempting. 17:25:30 INFO - (blobuploader) - INFO - Iteration through files over. 17:25:30 INFO - Return code: 0 17:25:30 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:25:30 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:25:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03b216157edb8d44994d2ab93b03cea959399b84428b59e1830165c58a3959ecac23262663eb0cfd0cd69d5f635babcd84aa95d999cf44bc9a2141eeadec84ae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e96516da1a639f070d079a9897cc4131c43c5febd91e858a2b4841e172fa52139dbb375e7243a8c512861e53ed358308b097610f5a3c638ed32a4fe002afa3b"} 17:25:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:25:30 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:25:30 INFO - Contents: 17:25:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/03b216157edb8d44994d2ab93b03cea959399b84428b59e1830165c58a3959ecac23262663eb0cfd0cd69d5f635babcd84aa95d999cf44bc9a2141eeadec84ae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e96516da1a639f070d079a9897cc4131c43c5febd91e858a2b4841e172fa52139dbb375e7243a8c512861e53ed358308b097610f5a3c638ed32a4fe002afa3b"} 17:25:30 INFO - Copying logs to upload dir... 17:25:30 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.121923 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-22 17:25:30.326623) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 17:25:30.330565) ========= 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=a65b340e283ce644d68cb24e000001c9-1450830720.969814-642385902 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/03b216157edb8d44994d2ab93b03cea959399b84428b59e1830165c58a3959ecac23262663eb0cfd0cd69d5f635babcd84aa95d999cf44bc9a2141eeadec84ae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e96516da1a639f070d079a9897cc4131c43c5febd91e858a2b4841e172fa52139dbb375e7243a8c512861e53ed358308b097610f5a3c638ed32a4fe002afa3b"} build_url:https://queue.taskcluster.net/v1/task/JDjODWhqTOqY6mOmBWxxMw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011255 build_url: 'https://queue.taskcluster.net/v1/task/JDjODWhqTOqY6mOmBWxxMw/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/03b216157edb8d44994d2ab93b03cea959399b84428b59e1830165c58a3959ecac23262663eb0cfd0cd69d5f635babcd84aa95d999cf44bc9a2141eeadec84ae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2e96516da1a639f070d079a9897cc4131c43c5febd91e858a2b4841e172fa52139dbb375e7243a8c512861e53ed358308b097610f5a3c638ed32a4fe002afa3b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 17:25:30.357641) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 17:25:30.358340) ========= 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=a65b340e283ce644d68cb24e000001c9-1450830720.969814-642385902 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 17:25:30.442374) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 17:25:30.442866) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 17:25:30.443364) ========= ========= Total master_lag: 0.23 =========