builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-046 starttime: 1452019949.53 results: success (0) buildid: 20160105083117 builduid: 56faca9b8a9d427a82568c98a24a4b7f revision: 059248332fe762e014889bdd1a34b846e0955e8d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 10:52:29.534957) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 10:52:29.535426) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 10:52:29.535829) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1452019222.38999-795687543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006429 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 10:52:29.569081) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 10:52:29.569429) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 10:52:29.646253) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 10:52:29.646573) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1452019222.38999-795687543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004659 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 10:52:29.704430) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 10:52:29.704987) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 10:52:29.705455) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 10:52:29.705746) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1452019222.38999-795687543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-05 10:52:30-- 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% 64.8M=0s 2016-01-05 10:52:30 (64.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.184623 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 10:52:29.904213) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 10:52:29.904590) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1452019222.38999-795687543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014773 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 10:52:29.989107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 10:52:29.989499) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 059248332fe762e014889bdd1a34b846e0955e8d --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 059248332fe762e014889bdd1a34b846e0955e8d --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1452019222.38999-795687543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-05 10:52:30,389 truncating revision to first 12 chars 2016-01-05 10:52:30,390 Setting DEBUG logging. 2016-01-05 10:52:30,390 attempt 1/10 2016-01-05 10:52:30,390 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/059248332fe7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-05 10:52:30,623 unpacking tar archive at: fx-team-059248332fe7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.505872 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 10:52:30.508531) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 10:52:30.508891) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 10:52:30.518219) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 10:52:30.518773) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 10:52:30.519472) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-05 10:52:30.519896) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1452019222.38999-795687543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:52:31 INFO - MultiFileLogger online at 20160105 10:52:31 in /builds/slave/test-pgo 10:52:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:52:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:52:31 INFO - {'append_to_log': False, 10:52:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:52:31 INFO - 'blob_upload_branch': 'Fx-Team', 10:52:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:52:31 INFO - 'branch': 'Fx-Team', 10:52:31 INFO - 'buildbot_json_path': 'buildprops.json', 10:52:31 INFO - 'config_files': ('talos/linux_config.py',), 10:52:31 INFO - 'default_actions': ('clobber', 10:52:31 INFO - 'read-buildbot-config', 10:52:31 INFO - 'download-and-extract', 10:52:31 INFO - 'populate-webroot', 10:52:31 INFO - 'create-virtualenv', 10:52:31 INFO - 'install', 10:52:31 INFO - 'run-tests'), 10:52:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:52:31 INFO - 'download_minidump_stackwalk': True, 10:52:31 INFO - 'download_symbols': 'ondemand', 10:52:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:52:31 INFO - 'tooltool.py': '/tools/tooltool.py', 10:52:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:52:31 INFO - '/tools/misc-python/virtualenv.py')}, 10:52:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:52:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:52:31 INFO - 'installer_path': 'installer.exe', 10:52:31 INFO - 'log_level': 'info', 10:52:31 INFO - 'log_name': 'talos', 10:52:31 INFO - 'log_to_console': True, 10:52:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:52:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:52:31 INFO - 'opt_config_files': (), 10:52:31 INFO - 'pip_index': False, 10:52:31 INFO - 'sps_profile': False, 10:52:31 INFO - 'sps_profile_interval': 0, 10:52:31 INFO - 'suite': 'dromaeojs-e10s', 10:52:31 INFO - 'system_bits': '32', 10:52:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:52:31 INFO - 'title': 'talos-linux64-ix-046', 10:52:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:52:31 INFO - 'use_talos_json': True, 10:52:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:52:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:52:31 INFO - 'work_dir': 'build'} 10:52:31 INFO - ##### 10:52:31 INFO - ##### Running clobber step. 10:52:31 INFO - ##### 10:52:31 INFO - Running pre-action listener: _resource_record_pre_action 10:52:31 INFO - Running main action method: clobber 10:52:31 INFO - rmtree: /builds/slave/test-pgo/build 10:52:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:52:31 INFO - Running post-action listener: _resource_record_post_action 10:52:31 INFO - ##### 10:52:31 INFO - ##### Running read-buildbot-config step. 10:52:31 INFO - ##### 10:52:31 INFO - Running pre-action listener: _resource_record_pre_action 10:52:31 INFO - Running main action method: read_buildbot_config 10:52:31 INFO - Using buildbot properties: 10:52:31 INFO - { 10:52:31 INFO - "project": "", 10:52:31 INFO - "product": "firefox", 10:52:31 INFO - "script_repo_revision": "production", 10:52:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:52:31 INFO - "repository": "", 10:52:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 10:52:31 INFO - "buildid": "20160105083117", 10:52:31 INFO - "pgo_build": "True", 10:52:31 INFO - "basedir": "/builds/slave/test-pgo", 10:52:31 INFO - "buildnumber": 178, 10:52:31 INFO - "slavename": "talos-linux64-ix-046", 10:52:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:52:31 INFO - "platform": "ubuntu64_hw", 10:52:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:52:31 INFO - "branch": "fx-team", 10:52:31 INFO - "repo_path": "integration/fx-team", 10:52:31 INFO - "revision": "059248332fe762e014889bdd1a34b846e0955e8d", 10:52:31 INFO - "stage_platform": "linux64-pgo", 10:52:31 INFO - "builduid": "56faca9b8a9d427a82568c98a24a4b7f", 10:52:31 INFO - "slavebuilddir": "test" 10:52:31 INFO - } 10:52:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/eg7sY77fSuu7e1mo8IvXWA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:52:31 INFO - Running post-action listener: _resource_record_post_action 10:52:31 INFO - ##### 10:52:31 INFO - ##### Running download-and-extract step. 10:52:31 INFO - ##### 10:52:31 INFO - Running pre-action listener: _resource_record_pre_action 10:52:31 INFO - Running main action method: download_and_extract 10:52:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:31 INFO - https://queue.taskcluster.net/v1/task/eg7sY77fSuu7e1mo8IvXWA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:52:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eg7sY77fSuu7e1mo8IvXWA/artifacts/public/build/test_packages.json 10:52:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eg7sY77fSuu7e1mo8IvXWA/artifacts/public/build/test_packages.json 10:52:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eg7sY77fSuu7e1mo8IvXWA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:52:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eg7sY77fSuu7e1mo8IvXWA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:52:35 INFO - Downloaded 1302 bytes. 10:52:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:52:35 INFO - Using the following test package requirements: 10:52:35 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:52:35 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:52:35 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:35 INFO - u'jsshell-linux-x86_64.zip'], 10:52:35 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:52:35 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:52:35 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:52:35 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:52:35 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:52:35 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:52:35 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:52:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:52:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:52:35 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')]} 10:52:35 INFO - https://queue.taskcluster.net/v1/task/eg7sY77fSuu7e1mo8IvXWA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:52:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eg7sY77fSuu7e1mo8IvXWA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:52:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eg7sY77fSuu7e1mo8IvXWA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:52:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eg7sY77fSuu7e1mo8IvXWA/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 10:52:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eg7sY77fSuu7e1mo8IvXWA/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 10:52:37 INFO - Downloaded 24051286 bytes. 10:52:37 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 10:52:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:52:37 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 10:52:38 INFO - Return code: 0 10:52:38 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 10:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:38 INFO - https://queue.taskcluster.net/v1/task/eg7sY77fSuu7e1mo8IvXWA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:52:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eg7sY77fSuu7e1mo8IvXWA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:52:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eg7sY77fSuu7e1mo8IvXWA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:52:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eg7sY77fSuu7e1mo8IvXWA/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 10:52:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eg7sY77fSuu7e1mo8IvXWA/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 10:52:46 INFO - Downloaded 24051286 bytes. 10:52:46 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 10:52:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:52:46 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 10:52:48 INFO - Return code: 0 10:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:48 INFO - https://queue.taskcluster.net/v1/task/eg7sY77fSuu7e1mo8IvXWA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:52:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eg7sY77fSuu7e1mo8IvXWA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:52:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eg7sY77fSuu7e1mo8IvXWA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:52:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eg7sY77fSuu7e1mo8IvXWA/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 10:52:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eg7sY77fSuu7e1mo8IvXWA/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 10:52:48 INFO - Downloaded 11132285 bytes. 10:52:48 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 10:52:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:52:48 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 10:52:49 INFO - Return code: 0 10:52:49 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')]} 10:52:49 INFO - https://queue.taskcluster.net/v1/task/eg7sY77fSuu7e1mo8IvXWA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:52:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eg7sY77fSuu7e1mo8IvXWA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:52:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eg7sY77fSuu7e1mo8IvXWA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:52:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eg7sY77fSuu7e1mo8IvXWA/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 10:52:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eg7sY77fSuu7e1mo8IvXWA/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 10:52:51 INFO - Downloaded 55010986 bytes. 10:52:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eg7sY77fSuu7e1mo8IvXWA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:52:51 INFO - mkdir: /builds/slave/test-pgo/properties 10:52:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:52:51 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:52:51 INFO - Contents: 10:52:51 INFO - build_url:https://queue.taskcluster.net/v1/task/eg7sY77fSuu7e1mo8IvXWA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:52:51 INFO - Running post-action listener: _resource_record_post_action 10:52:51 INFO - Running post-action listener: set_extra_try_arguments 10:52:51 INFO - ##### 10:52:51 INFO - ##### Running populate-webroot step. 10:52:51 INFO - ##### 10:52:51 INFO - Running pre-action listener: _resource_record_pre_action 10:52:51 INFO - Running main action method: populate_webroot 10:52:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:52:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:52:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:52:51 INFO - '--tppagecycles', 10:52:51 INFO - '7'], 10:52:51 INFO - 'tests': ['tsvgm']}}, 10:52:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:52:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:52:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:52:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:52:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:52:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:52:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:52:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:51 INFO - 'talos_options': ['--e10s'], 10:52:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:52:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:51 INFO - 'tests': ['damp', 'tps']}, 10:52:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:51 INFO - 'talos_options': ['--e10s'], 10:52:51 INFO - 'tests': ['damp', 'tps']}, 10:52:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:52:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:52:51 INFO - 'other': {'tests': ['a11yr', 10:52:51 INFO - 'ts_paint', 10:52:51 INFO - 'tpaint', 10:52:51 INFO - 'sessionrestore', 10:52:51 INFO - 'sessionrestore_no_auto_restore']}, 10:52:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:52:51 INFO - 'tests': ['a11yr', 10:52:51 INFO - 'ts_paint', 10:52:51 INFO - 'tpaint', 10:52:51 INFO - 'sessionrestore', 10:52:51 INFO - 'sessionrestore_no_auto_restore']}, 10:52:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:52:51 INFO - 'tests': ['a11yr', 10:52:51 INFO - 'ts_paint', 10:52:51 INFO - 'tpaint', 10:52:51 INFO - 'sessionrestore', 10:52:51 INFO - 'sessionrestore_no_auto_restore']}, 10:52:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:52:51 INFO - 'tests': ['a11yr', 10:52:51 INFO - 'ts_paint', 10:52:51 INFO - 'tpaint', 10:52:51 INFO - 'sessionrestore', 10:52:51 INFO - 'sessionrestore_no_auto_restore']}, 10:52:51 INFO - 'other_l64': {'tests': ['a11yr', 10:52:51 INFO - 'ts_paint', 10:52:51 INFO - 'tpaint', 10:52:51 INFO - 'sessionrestore', 10:52:51 INFO - 'sessionrestore_no_auto_restore']}, 10:52:51 INFO - 'other_nol64': {'tests': ['a11yr', 10:52:51 INFO - 'ts_paint', 10:52:51 INFO - 'tpaint', 10:52:51 INFO - 'sessionrestore', 10:52:51 INFO - 'sessionrestore_no_auto_restore']}, 10:52:51 INFO - 'svgr': {'tests': ['tsvgx', 10:52:51 INFO - 'tsvgr_opacity', 10:52:51 INFO - 'tart', 10:52:51 INFO - 'tscrollx', 10:52:51 INFO - 'cart']}, 10:52:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:52:51 INFO - 'tests': ['tsvgx', 10:52:51 INFO - 'tsvgr_opacity', 10:52:51 INFO - 'tart', 10:52:51 INFO - 'tscrollx', 10:52:51 INFO - 'cart']}, 10:52:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:51 INFO - 'tests': ['tp5o']}, 10:52:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:51 INFO - 'talos_options': ['--e10s'], 10:52:51 INFO - 'tests': ['tp5o']}, 10:52:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:51 INFO - 'talos_options': ['--xperf_path', 10:52:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:52:51 INFO - 'tests': ['tp5n']}, 10:52:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:52:51 INFO - 'talos_options': ['--e10s', 10:52:51 INFO - '--xperf_path', 10:52:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:52:51 INFO - 'tests': ['tp5n']}}, 10:52:51 INFO - 'talos.zip': {'path': '', 10:52:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:52:51 INFO - Running post-action listener: _resource_record_post_action 10:52:51 INFO - ##### 10:52:51 INFO - ##### Running create-virtualenv step. 10:52:51 INFO - ##### 10:52:51 INFO - Running pre-action listener: _resource_record_pre_action 10:52:51 INFO - Running main action method: create_virtualenv 10:52:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:52:51 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 10:52:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:52:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:52:51 INFO - Using real prefix '/usr' 10:52:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:52:51 INFO - Installing distribute.............................................................................................................................................................................................done. 10:52:53 INFO - Installing pip.................done. 10:52:53 INFO - Return code: 0 10:52:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f33333c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2339560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c8740>, '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 0x23c9640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c9af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452019222.38999-795687543', '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 10:52:53 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 10:52:53 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 10:52:53 INFO - Using env: {'DISPLAY': ':0', 10:52:53 INFO - 'HOME': '/home/cltbld', 10:52:53 INFO - 'LANG': 'en_US.UTF-8', 10:52:53 INFO - 'LANGUAGE': 'en_US:en', 10:52:53 INFO - 'LOGNAME': 'cltbld', 10:52:53 INFO - 'MAIL': '/var/mail/cltbld', 10:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:53 INFO - 'MOZ_NO_REMOTE': '1', 10:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:53 INFO - 'NO_EM_RESTART': '1', 10:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:52:53 INFO - 'PWD': '/builds/slave/test-pgo', 10:52:53 INFO - 'SHELL': '/bin/bash', 10:52:53 INFO - 'SHLVL': '1', 10:52:53 INFO - 'TERM': 'linux', 10:52:53 INFO - 'TMOUT': '86400', 10:52:53 INFO - 'USER': 'cltbld', 10:52:53 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452019222.38999-795687543', 10:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:53 INFO - '_': '/tools/buildbot/bin/python'} 10:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:54 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 10:52:54 INFO - Cleaning up... 10:52:54 INFO - Return code: 0 10:52:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:52: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')]} 10:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52: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')]} 10:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52: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', '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 0x7f33333c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2339560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c8740>, '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 0x23c9640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c9af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452019222.38999-795687543', '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 10:52: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 10:52: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 psutil>=0.7.1 10:52:54 INFO - Using env: {'DISPLAY': ':0', 10:52:54 INFO - 'HOME': '/home/cltbld', 10:52:54 INFO - 'LANG': 'en_US.UTF-8', 10:52:54 INFO - 'LANGUAGE': 'en_US:en', 10:52:54 INFO - 'LOGNAME': 'cltbld', 10:52:54 INFO - 'MAIL': '/var/mail/cltbld', 10:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:54 INFO - 'MOZ_NO_REMOTE': '1', 10:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:54 INFO - 'NO_EM_RESTART': '1', 10:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:52:54 INFO - 'PWD': '/builds/slave/test-pgo', 10:52:54 INFO - 'SHELL': '/bin/bash', 10:52:54 INFO - 'SHLVL': '1', 10:52:54 INFO - 'TERM': 'linux', 10:52:54 INFO - 'TMOUT': '86400', 10:52:54 INFO - 'USER': 'cltbld', 10:52:54 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452019222.38999-795687543', 10:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:54 INFO - '_': '/tools/buildbot/bin/python'} 10:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:54 INFO - Downloading/unpacking psutil>=0.7.1 10:52: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 10:52: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 10:52: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 10:52: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 10:52: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 10:52: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 10:52:56 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:52:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:52:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:52:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:56 INFO - Installing collected packages: psutil 10:52:56 INFO - Running setup.py install for psutil 10:52:56 INFO - building 'psutil._psutil_linux' extension 10:52:56 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 10:52:56 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 10:52:56 INFO - building 'psutil._psutil_posix' extension 10:52:56 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 10:52:56 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 10:52:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:56 INFO - Successfully installed psutil 10:52:56 INFO - Cleaning up... 10:52:56 INFO - Return code: 0 10:52:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:52: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')]} 10:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52: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')]} 10:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52: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', '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 0x7f33333c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2339560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c8740>, '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 0x23c9640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c9af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452019222.38999-795687543', '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 10:52: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:52: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 mozsystemmonitor==0.0.0 10:52:56 INFO - Using env: {'DISPLAY': ':0', 10:52:56 INFO - 'HOME': '/home/cltbld', 10:52:56 INFO - 'LANG': 'en_US.UTF-8', 10:52:56 INFO - 'LANGUAGE': 'en_US:en', 10:52:56 INFO - 'LOGNAME': 'cltbld', 10:52:56 INFO - 'MAIL': '/var/mail/cltbld', 10:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:56 INFO - 'MOZ_NO_REMOTE': '1', 10:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:56 INFO - 'NO_EM_RESTART': '1', 10:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:52:56 INFO - 'PWD': '/builds/slave/test-pgo', 10:52:56 INFO - 'SHELL': '/bin/bash', 10:52:56 INFO - 'SHLVL': '1', 10:52:56 INFO - 'TERM': 'linux', 10:52:56 INFO - 'TMOUT': '86400', 10:52:56 INFO - 'USER': 'cltbld', 10:52:56 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452019222.38999-795687543', 10:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:56 INFO - '_': '/tools/buildbot/bin/python'} 10:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:52: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 10:52: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 10:52: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 10:52: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 10:52: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 10:52: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 10:52:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:52:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:52:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:52:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:52:58 INFO - Installing collected packages: mozsystemmonitor 10:52:58 INFO - Running setup.py install for mozsystemmonitor 10:52:58 INFO - Successfully installed mozsystemmonitor 10:52:58 INFO - Cleaning up... 10:52:58 INFO - Return code: 0 10:52:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:52:58 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')]} 10:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:58 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')]} 10:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:58 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 0x7f33333c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2339560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c8740>, '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 0x23c9640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c9af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452019222.38999-795687543', '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 10:52:58 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 10:52:58 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 10:52:58 INFO - Using env: {'DISPLAY': ':0', 10:52:58 INFO - 'HOME': '/home/cltbld', 10:52:58 INFO - 'LANG': 'en_US.UTF-8', 10:52:58 INFO - 'LANGUAGE': 'en_US:en', 10:52:58 INFO - 'LOGNAME': 'cltbld', 10:52:58 INFO - 'MAIL': '/var/mail/cltbld', 10:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:58 INFO - 'MOZ_NO_REMOTE': '1', 10:52:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:58 INFO - 'NO_EM_RESTART': '1', 10:52:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:52:58 INFO - 'PWD': '/builds/slave/test-pgo', 10:52:58 INFO - 'SHELL': '/bin/bash', 10:52:58 INFO - 'SHLVL': '1', 10:52:58 INFO - 'TERM': 'linux', 10:52:58 INFO - 'TMOUT': '86400', 10:52:58 INFO - 'USER': 'cltbld', 10:52:58 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452019222.38999-795687543', 10:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:58 INFO - '_': '/tools/buildbot/bin/python'} 10:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:59 INFO - Downloading/unpacking blobuploader==1.2.4 10:52: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 10:52: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 10:52: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 10:52: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 10:52: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 10:52: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 10:53:00 INFO - Downloading blobuploader-1.2.4.tar.gz 10:53:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:53:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:53:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:53:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:53:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:01 INFO - Downloading docopt-0.6.1.tar.gz 10:53:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:53:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:53:01 INFO - Installing collected packages: blobuploader, requests, docopt 10:53:01 INFO - Running setup.py install for blobuploader 10:53:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:53:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:53:01 INFO - Running setup.py install for requests 10:53:01 INFO - Running setup.py install for docopt 10:53:01 INFO - Successfully installed blobuploader requests docopt 10:53:01 INFO - Cleaning up... 10:53:02 INFO - Return code: 0 10:53:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:53:02 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')]} 10:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:02 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')]} 10:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:02 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 0x7f33333c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2339560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c8740>, '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 0x23c9640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c9af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452019222.38999-795687543', '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 10:53:02 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 10:53:02 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 10:53:02 INFO - Using env: {'DISPLAY': ':0', 10:53:02 INFO - 'HOME': '/home/cltbld', 10:53:02 INFO - 'LANG': 'en_US.UTF-8', 10:53:02 INFO - 'LANGUAGE': 'en_US:en', 10:53:02 INFO - 'LOGNAME': 'cltbld', 10:53:02 INFO - 'MAIL': '/var/mail/cltbld', 10:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:02 INFO - 'MOZ_NO_REMOTE': '1', 10:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:02 INFO - 'NO_EM_RESTART': '1', 10:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:02 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:02 INFO - 'SHELL': '/bin/bash', 10:53:02 INFO - 'SHLVL': '1', 10:53:02 INFO - 'TERM': 'linux', 10:53:02 INFO - 'TMOUT': '86400', 10:53:02 INFO - 'USER': 'cltbld', 10:53:02 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452019222.38999-795687543', 10:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:02 INFO - '_': '/tools/buildbot/bin/python'} 10:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:53:02 INFO - Running setup.py (path:/tmp/pip-xHWU5b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:53:02 INFO - Running setup.py (path:/tmp/pip-Fq6c_3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:53:02 INFO - Running setup.py (path:/tmp/pip-7KJdUs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:53:02 INFO - Running setup.py (path:/tmp/pip-WOQjvC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:53:02 INFO - Running setup.py (path:/tmp/pip-KapwZR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:53:02 INFO - Running setup.py (path:/tmp/pip-GhVABu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:53:02 INFO - Running setup.py (path:/tmp/pip-9AsZIr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:53:02 INFO - Running setup.py (path:/tmp/pip-NtpmEZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:53:02 INFO - Running setup.py (path:/tmp/pip-DmHj93-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:53:02 INFO - Running setup.py (path:/tmp/pip-CuZPGs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:53:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:53:02 INFO - Running setup.py (path:/tmp/pip-jXxSjm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:53:03 INFO - Running setup.py (path:/tmp/pip-SGXfIR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:53:03 INFO - Running setup.py (path:/tmp/pip-v9FKTh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:53:03 INFO - Running setup.py (path:/tmp/pip-e9iZYT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:53:03 INFO - Running setup.py (path:/tmp/pip-9uqS3k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:53:03 INFO - Running setup.py (path:/tmp/pip-T_Q47R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:53:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:53:03 INFO - Running setup.py (path:/tmp/pip-ZaCt3C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:53:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:53:03 INFO - Running setup.py install for manifestparser 10:53:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:53:03 INFO - Running setup.py install for mozcrash 10:53:03 INFO - Running setup.py install for mozdebug 10:53:03 INFO - Running setup.py install for mozdevice 10:53:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:53:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:53:03 INFO - Running setup.py install for mozfile 10:53:03 INFO - Running setup.py install for mozhttpd 10:53:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:53:04 INFO - Running setup.py install for mozinfo 10:53:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:53:04 INFO - Running setup.py install for mozInstall 10:53:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:53:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:53:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:53:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:53:04 INFO - Running setup.py install for mozleak 10:53:04 INFO - Running setup.py install for mozlog 10:53:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:53:04 INFO - Running setup.py install for moznetwork 10:53:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:53:04 INFO - Running setup.py install for mozprocess 10:53:04 INFO - Running setup.py install for mozprofile 10:53:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:53:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:53:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:53:04 INFO - Running setup.py install for mozrunner 10:53:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:53:04 INFO - Running setup.py install for mozscreenshot 10:53:05 INFO - Running setup.py install for moztest 10:53:05 INFO - Running setup.py install for mozversion 10:53:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:53:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:53:05 INFO - Cleaning up... 10:53:05 INFO - Return code: 0 10:53:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:05 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 0x7f33333c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2339560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c8740>, '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 0x23c9640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c9af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452019222.38999-795687543', '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 10:53:05 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 10:53:05 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 10:53:05 INFO - Using env: {'DISPLAY': ':0', 10:53:05 INFO - 'HOME': '/home/cltbld', 10:53:05 INFO - 'LANG': 'en_US.UTF-8', 10:53:05 INFO - 'LANGUAGE': 'en_US:en', 10:53:05 INFO - 'LOGNAME': 'cltbld', 10:53:05 INFO - 'MAIL': '/var/mail/cltbld', 10:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:05 INFO - 'MOZ_NO_REMOTE': '1', 10:53:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:05 INFO - 'NO_EM_RESTART': '1', 10:53:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:05 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:05 INFO - 'SHELL': '/bin/bash', 10:53:05 INFO - 'SHLVL': '1', 10:53:05 INFO - 'TERM': 'linux', 10:53:05 INFO - 'TMOUT': '86400', 10:53:05 INFO - 'USER': 'cltbld', 10:53:05 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452019222.38999-795687543', 10:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:05 INFO - '_': '/tools/buildbot/bin/python'} 10:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:53:05 INFO - Running setup.py (path:/tmp/pip-8dcb9j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:53:05 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)) 10:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:53:05 INFO - Running setup.py (path:/tmp/pip-erlwtw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:53:05 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)) 10:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:53:05 INFO - Running setup.py (path:/tmp/pip-gboXJi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:53:05 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)) 10:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:53:05 INFO - Running setup.py (path:/tmp/pip-27VKed-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:53:05 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)) 10:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:53:05 INFO - Running setup.py (path:/tmp/pip-vqyVtB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:53:05 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)) 10:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:53:05 INFO - Running setup.py (path:/tmp/pip-9qMkIo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:53:05 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)) 10:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:53:05 INFO - Running setup.py (path:/tmp/pip-fNSOoZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:53:05 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)) 10:53:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:53:05 INFO - Running setup.py (path:/tmp/pip-nIWnUp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:53:06 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)) 10:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:53:06 INFO - Running setup.py (path:/tmp/pip-IGmGE_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:53:06 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)) 10:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:53:06 INFO - Running setup.py (path:/tmp/pip-Sgk6mr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:53:06 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)) 10:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:53:06 INFO - Running setup.py (path:/tmp/pip-2PNoWA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:53:06 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)) 10:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:53:06 INFO - Running setup.py (path:/tmp/pip-hxJ9Ru-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:53:06 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)) 10:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:53:06 INFO - Running setup.py (path:/tmp/pip-DL361G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:53:06 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)) 10:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:53:06 INFO - Running setup.py (path:/tmp/pip-djx91Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:53:06 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)) 10:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:53:06 INFO - Running setup.py (path:/tmp/pip-92y743-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:53:06 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)) 10:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:53:06 INFO - Running setup.py (path:/tmp/pip-0tan_A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:53:06 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)) 10:53:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:53:06 INFO - Running setup.py (path:/tmp/pip-LkvgnC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:53:06 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)) 10:53:06 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)) 10:53:06 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)) 10:53:06 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)) 10:53:06 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)) 10:53:06 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)) 10:53:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:53:06 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 10:53:06 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 10:53:06 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 10:53:06 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 10:53:06 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 10:53:06 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 10:53:08 INFO - Downloading blessings-1.5.1.tar.gz 10:53:08 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 10:53:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:53:08 INFO - Installing collected packages: blessings 10:53:08 INFO - Running setup.py install for blessings 10:53:08 INFO - Successfully installed blessings 10:53:08 INFO - Cleaning up... 10:53:08 INFO - Return code: 0 10:53:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:53:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:53:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:53:08 INFO - Reading from file tmpfile_stdout 10:53:08 INFO - Current package versions: 10:53:08 INFO - argparse == 1.2.1 10:53:08 INFO - blessings == 1.5.1 10:53:08 INFO - blobuploader == 1.2.4 10:53:08 INFO - docopt == 0.6.1 10:53:08 INFO - manifestparser == 1.1 10:53:08 INFO - mozInstall == 1.12 10:53:08 INFO - mozcrash == 0.16 10:53:08 INFO - mozdebug == 0.1 10:53:08 INFO - mozdevice == 0.47 10:53:08 INFO - mozfile == 1.2 10:53:08 INFO - mozhttpd == 0.7 10:53:08 INFO - mozinfo == 0.9 10:53:08 INFO - mozleak == 0.1 10:53:08 INFO - mozlog == 3.1 10:53:08 INFO - moznetwork == 0.27 10:53:08 INFO - mozprocess == 0.22 10:53:08 INFO - mozprofile == 0.28 10:53:08 INFO - mozrunner == 6.11 10:53:08 INFO - mozscreenshot == 0.1 10:53:08 INFO - mozsystemmonitor == 0.0 10:53:08 INFO - moztest == 0.7 10:53:08 INFO - mozversion == 1.4 10:53:08 INFO - psutil == 3.1.1 10:53:08 INFO - requests == 1.2.3 10:53:08 INFO - wsgiref == 0.1.2 10:53:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f33333c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2339560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c8740>, '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 0x23c9640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c9af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452019222.38999-795687543', '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 10:53:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 10:53:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 10:53:08 INFO - Using env: {'DISPLAY': ':0', 10:53:08 INFO - 'HOME': '/home/cltbld', 10:53:08 INFO - 'LANG': 'en_US.UTF-8', 10:53:08 INFO - 'LANGUAGE': 'en_US:en', 10:53:08 INFO - 'LOGNAME': 'cltbld', 10:53:08 INFO - 'MAIL': '/var/mail/cltbld', 10:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:08 INFO - 'MOZ_NO_REMOTE': '1', 10:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:08 INFO - 'NO_EM_RESTART': '1', 10:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:08 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:08 INFO - 'SHELL': '/bin/bash', 10:53:08 INFO - 'SHLVL': '1', 10:53:08 INFO - 'TERM': 'linux', 10:53:08 INFO - 'TMOUT': '86400', 10:53:08 INFO - 'USER': 'cltbld', 10:53:08 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452019222.38999-795687543', 10:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:08 INFO - '_': '/tools/buildbot/bin/python'} 10:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:09 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)) 10:53:09 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)) 10:53:09 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)) 10:53:09 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)) 10:53:09 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)) 10:53:09 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)) 10:53:09 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)) 10:53:09 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)) 10:53:09 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)) 10:53:09 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)) 10:53:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 10:53:09 INFO - Cleaning up... 10:53:09 INFO - Return code: 0 10:53:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:53:09 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')]} 10:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:09 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')]} 10:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:09 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 0x7f33333c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2339560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c8740>, '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 0x23c9640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c9af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452019222.38999-795687543', '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 10:53:09 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 10:53:09 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 10:53:09 INFO - Using env: {'DISPLAY': ':0', 10:53:09 INFO - 'HOME': '/home/cltbld', 10:53:09 INFO - 'LANG': 'en_US.UTF-8', 10:53:09 INFO - 'LANGUAGE': 'en_US:en', 10:53:09 INFO - 'LOGNAME': 'cltbld', 10:53:09 INFO - 'MAIL': '/var/mail/cltbld', 10:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:09 INFO - 'MOZ_NO_REMOTE': '1', 10:53:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:09 INFO - 'NO_EM_RESTART': '1', 10:53:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:09 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:09 INFO - 'SHELL': '/bin/bash', 10:53:09 INFO - 'SHLVL': '1', 10:53:09 INFO - 'TERM': 'linux', 10:53:09 INFO - 'TMOUT': '86400', 10:53:09 INFO - 'USER': 'cltbld', 10:53:09 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452019222.38999-795687543', 10:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:09 INFO - '_': '/tools/buildbot/bin/python'} 10:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:09 INFO - Downloading/unpacking jsonschema 10:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:53:10 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 10:53:10 INFO - Downloading/unpacking functools32 (from jsonschema) 10:53:10 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 10:53:10 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 10:53:10 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 10:53:10 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 10:53:10 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 10:53:10 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 10:53:11 INFO - Downloading functools32-3.2.3-2.tar.gz 10:53:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:53:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:53:11 INFO - warning: no files found matching '*.txt' 10:53:11 INFO - no previously-included directories found matching 'build' 10:53:11 INFO - no previously-included directories found matching 'dist' 10:53:11 INFO - no previously-included directories found matching '.git*' 10:53:11 INFO - Installing collected packages: jsonschema, functools32 10:53:11 INFO - Running setup.py install for functools32 10:53:11 INFO - warning: no files found matching '*.txt' 10:53:11 INFO - no previously-included directories found matching 'build' 10:53:11 INFO - no previously-included directories found matching 'dist' 10:53:11 INFO - no previously-included directories found matching '.git*' 10:53:11 INFO - Successfully installed jsonschema functools32 10:53:11 INFO - Cleaning up... 10:53:11 INFO - Return code: 0 10:53:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f33333c4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2339560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23c8740>, '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 0x23c9640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c9af0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452019222.38999-795687543', '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 10:53:11 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 10:53:11 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 10:53:11 INFO - Using env: {'DISPLAY': ':0', 10:53:11 INFO - 'HOME': '/home/cltbld', 10:53:11 INFO - 'LANG': 'en_US.UTF-8', 10:53:11 INFO - 'LANGUAGE': 'en_US:en', 10:53:11 INFO - 'LOGNAME': 'cltbld', 10:53:11 INFO - 'MAIL': '/var/mail/cltbld', 10:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:11 INFO - 'MOZ_NO_REMOTE': '1', 10:53:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:11 INFO - 'NO_EM_RESTART': '1', 10:53:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:11 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:11 INFO - 'SHELL': '/bin/bash', 10:53:11 INFO - 'SHLVL': '1', 10:53:11 INFO - 'TERM': 'linux', 10:53:11 INFO - 'TMOUT': '86400', 10:53:11 INFO - 'USER': 'cltbld', 10:53:11 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452019222.38999-795687543', 10:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:11 INFO - '_': '/tools/buildbot/bin/python'} 10:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:11 INFO - Downloading/unpacking flake8 10:53:11 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 10:53:11 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 10:53:11 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 10:53:11 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 10:53:11 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 10:53:11 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 10:53:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:53:13 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 10:53:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:53:13 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 10:53:13 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 10:53:13 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 10:53:13 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 10:53:13 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 10:53:13 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 10:53:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:53:13 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 10:53:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:53:13 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 10:53:13 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 10:53:13 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 10:53:13 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 10:53:13 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 10:53:13 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 10:53:13 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 10:53:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:53:13 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 10:53:13 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 10:53:13 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 10:53:13 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 10:53:13 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 10:53:13 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 10:53:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:53:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:53:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:53:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:53:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:53:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:53:13 INFO - no previously-included directories found matching 'docs/_build' 10:53:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:53:14 INFO - Running setup.py install for pep8 10:53:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:53:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:53:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:53:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:53:14 INFO - no previously-included directories found matching 'docs/_build' 10:53:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:53:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:53:14 INFO - Cleaning up... 10:53:14 INFO - Return code: 0 10:53:14 INFO - Running post-action listener: _resource_record_post_action 10:53:14 INFO - Running post-action listener: _start_resource_monitoring 10:53:14 INFO - Starting resource monitoring. 10:53:14 INFO - ##### 10:53:14 INFO - ##### Running install step. 10:53:14 INFO - ##### 10:53:14 INFO - Running pre-action listener: _resource_record_pre_action 10:53:14 INFO - Running main action method: install 10:53:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:53:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:53:14 INFO - Reading from file tmpfile_stdout 10:53:14 INFO - Detecting whether we're running mozinstall >=1.0... 10:53:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:53:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:53:14 INFO - Reading from file tmpfile_stdout 10:53:14 INFO - Output received: 10:53:14 INFO - Usage: mozinstall [options] installer 10:53:14 INFO - Options: 10:53:14 INFO - -h, --help show this help message and exit 10:53:14 INFO - -d DEST, --destination=DEST 10:53:14 INFO - Directory to install application into. [default: 10:53:14 INFO - "/builds/slave/test-pgo"] 10:53:14 INFO - --app=APP Application being installed. [default: firefox] 10:53:14 INFO - mkdir: /builds/slave/test-pgo/build/application 10:53:14 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'] 10:53:14 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 10:53:30 INFO - Reading from file tmpfile_stdout 10:53:30 INFO - Output received: 10:53:30 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:53:30 INFO - Running post-action listener: _resource_record_post_action 10:53:30 INFO - ##### 10:53:30 INFO - ##### Running run-tests step. 10:53:30 INFO - ##### 10:53:30 INFO - Running pre-action listener: _resource_record_pre_action 10:53:30 INFO - Running main action method: run_tests 10:53:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:53:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:53:30 INFO - Python 2.7.3 10:53:30 INFO - Return code: 0 10:53:30 INFO - grabbing minidump binary from tooltool 10:53:30 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')]} 10:53:30 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 0x23c8740>, '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 0x23c9640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23c9af0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:53:30 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 10:53:30 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 10:53:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:53:30 INFO - Return code: 0 10:53:30 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:53:30 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:53:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:53:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:53:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:53:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:53:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:53:31 INFO - Return code: 0 10:53:31 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/eg7sY77fSuu7e1mo8IvXWA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 10:53:31 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/eg7sY77fSuu7e1mo8IvXWA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:53:31 INFO - Using env: {'DISPLAY': ':0', 10:53:31 INFO - 'HOME': '/home/cltbld', 10:53:31 INFO - 'LANG': 'en_US.UTF-8', 10:53:31 INFO - 'LANGUAGE': 'en_US:en', 10:53:31 INFO - 'LOGNAME': 'cltbld', 10:53:31 INFO - 'MAIL': '/var/mail/cltbld', 10:53:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:53:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:31 INFO - 'MOZ_NO_REMOTE': '1', 10:53:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:53:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:31 INFO - 'NO_EM_RESTART': '1', 10:53:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:53:31 INFO - 'PWD': '/builds/slave/test-pgo', 10:53:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:53:31 INFO - 'SHELL': '/bin/bash', 10:53:31 INFO - 'SHLVL': '1', 10:53:31 INFO - 'TERM': 'linux', 10:53:31 INFO - 'TMOUT': '86400', 10:53:31 INFO - 'USER': 'cltbld', 10:53:31 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1452019222.38999-795687543', 10:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:31 INFO - '_': '/tools/buildbot/bin/python'} 10:53:31 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/eg7sY77fSuu7e1mo8IvXWA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:53:31 INFO - mozversion application_buildid: 20160105083117 10:53:31 INFO - mozversion application_changeset: 059248332fe762e014889bdd1a34b846e0955e8d 10:53:31 INFO - mozversion application_display_name: Nightly 10:53:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:53:31 INFO - mozversion application_name: Firefox 10:53:31 INFO - mozversion application_remotingname: firefox 10:53:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:53:31 INFO - mozversion application_vendor: Mozilla 10:53:31 INFO - mozversion application_version: 46.0a1 10:53:31 INFO - mozversion platform_buildid: 20160105083117 10:53:31 INFO - mozversion platform_changeset: 059248332fe762e014889bdd1a34b846e0955e8d 10:53:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:53:31 INFO - mozversion platform_version: 46.0a1 10:53:31 INFO - using testdate: 1452020011 10:53:31 INFO - actual date: 1452020011 10:53:31 INFO - starting webserver on 'localhost:42355' 10:53:31 INFO - SUITE-START | Running 3 tests 10:53:31 INFO - TEST-START | dromaeo_css 10:53:31 INFO - operating with platform_type : linux_ 10:53:31 INFO - Initialising browser for dromaeo_css test... 10:53:31 INFO - TEST-INFO | started process 15738 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMeSkrq/profile http://localhost:42355/getInfo.html) 10:53:36 INFO - PROCESS | 15738 | __metrics Screen width/height:1600/1200 10:53:36 INFO - PROCESS | 15738 | colorDepth:24 10:53:36 INFO - PROCESS | 15738 | Browser inner width/height: 1024/697 10:53:36 INFO - PROCESS | 15738 | __metrics 10:53:36 INFO - PROCESS | 15738 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:53:37 INFO - TEST-INFO | 15738: exit 0 10:53:37 INFO - Browser initialized. 10:53:37 INFO - Running cycle 1/1 for dromaeo_css test... 10:53:37 INFO - TEST-INFO | started process 15874 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMeSkrq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:53:48 INFO - PROCESS | 15874 | RSS: Main: 150728704 10:53:48 INFO - PROCESS | 15874 | 10:54:38 INFO - PROCESS | 15874 | 1452020078562 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] 10:56:47 INFO - PROCESS | 15874 | Cycle 1(1): loaded http://localhost:42355/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42355/tests/dromaeo/cssquery-ext.html) 10:56:48 INFO - PROCESS | 15874 | RSS: Main: 157532160 10:56:48 INFO - PROCESS | 15874 | 10:59:50 INFO - PROCESS | 15874 | Cycle 1(1): loaded http://localhost:42355/tests/dromaeo/cssquery-ext.html (next: http://localhost:42355/tests/dromaeo/cssquery-jquery.html) 10:59:50 INFO - PROCESS | 15874 | RSS: Main: 152879104 10:59:50 INFO - PROCESS | 15874 | 11:02:52 INFO - PROCESS | 15874 | Cycle 1(1): loaded http://localhost:42355/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42355/tests/dromaeo/cssquery-mootools.html) 11:02:52 INFO - PROCESS | 15874 | RSS: Main: 153366528 11:02:52 INFO - PROCESS | 15874 | 11:05:54 INFO - PROCESS | 15874 | Cycle 1(1): loaded http://localhost:42355/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42355/tests/dromaeo/cssquery-prototype.html) 11:05:55 INFO - PROCESS | 15874 | RSS: Main: 152031232 11:05:55 INFO - PROCESS | 15874 | 11:08:57 INFO - PROCESS | 15874 | Cycle 1(1): loaded http://localhost:42355/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42355/tests/dromaeo/cssquery-yui.html) 11:08:58 INFO - PROCESS | 15874 | RSS: Main: 152907776 11:08:58 INFO - PROCESS | 15874 | 11:12:00 INFO - PROCESS | 15874 | Cycle 1(1): loaded http://localhost:42355/tests/dromaeo/cssquery-yui.html (next: http://localhost:42355/tests/dromaeo/cssquery-dojo.html) 11:12:00 INFO - PROCESS | 15874 | RSS: Main: 155037696 11:12:00 INFO - PROCESS | 15874 | 11:12:00 INFO - PROCESS | 15874 | __start_tp_report 11:12:00 INFO - PROCESS | 15874 | _x_x_mozilla_page_load 11:12:00 INFO - PROCESS | 15874 | _x_x_mozilla_page_load_details 11:12:00 INFO - PROCESS | 15874 | |i|pagename|runs| 11:12:00 INFO - PROCESS | 15874 | |0;dojo.html;3148.5749423827783;3194.568733221016;3227.951580726288;3238.109519882032;3238.8380580970947;5286.471352864722;5321.760520776565;5396.136618141099;5402.540784033357;5407.459254074595;5326.147816349385;5328.20076988451;5328.680279183242;5332.520073193412;5337.866553336168;4745.738984355868;4885.682430642015;4901.240307752304;4987.750612469362;5008.073506401327;4918.950810491903;4992.850214493553;5005.5995520358465;5005.724685142316;5039.370078740158;823.4069278301844;4901.338319326881;4912.066707325596;4924.630652701044;4958.132326842788;4945.901081978376;4961.404631444214;4963.280324352984;4965.602751779849;5013.222950442687;4969.105560999019;4986.202207646759;5006.4492905780335;5019.799208031674;5081.644284900059;5085.542301192911;5157.535821776059;5204.76578553966;5221.791128354861;5262.131748261532;5774.82675519735;5806;5824.708764561798;5826.388229235954;5829.300483941912;5755.769769209227;5865.912011319833;5871.383504731984;5880.4119588041285;5890.145928840294;5285.603579731497;5308.628396012242;5404.189371594292;5414;5444.292242008553;5918.408159184133;5965.612235204698;5966.552508561876;5969.015112506475;5981.282246130492;5615.691136987423;5667.914981275284;5692.57305702074;5711.514521265656;5725.255716756795;5767.336756272998;5850.063989761703;5865;5869.383714709894;5903.675297858573;5794.159846822272;5827.067669172912;5829.76680932758;5842.269716285465;5844.094165404369;5458.536024437888;5549.778008879681;5825.0388685866355;5829.708514574254;5829.854253643693;4462.286034234507;4528.818847246139;4544.159330523864;4567.018091110427;4585.037142200175;3965.5439624442984;3973.5231772186944;3974.960250397517;3992.0419099416513;4016.1566071124807;5272.393674727378;5289.259503669489;5392.379876314196;5394.298741163702;5461.344638643309;5742.827715168552;5744.224529688522;5754.367019627837;5771.422857714195;5799.420057994251;5364.544013758796;5388.973055134699;5397.055515284809;5411.9729401353525;5418.106012507971;4842.951570484321;4843.055604157226;4914.140025495595;4945.381827271591;4955.157623204064;5988.9101663475085;6002.09968504719;6013.218281623361;6017.458428741435;6028.57799953999;5737.627054241461;5757.0788673811985;5780.624259423124;5782.537397008314;5789.942100579109;5966.403359663999;5995.310539288038;6065.696715164136;6098.634081955097;6113.174721412553;5674.829755107354;5675.801346952837;5680.630759000652;5686.971565142313;5687.630304030225;5762.463197755743;5774.797882074107;5783.7397317119985;5792.797252096157;5801.042827933513;5645.491905728504;5681.119426488901;5756.395578464201;5758.337791153904;5812.738426770721;5689.1750696148;5704.885902281848;5715.399883012224;5716.342620598684;5731.770729170787;5465.07093794048;5580.972095139498;5611.438856114356;5627.521660658726;5631.915521267102;5577.219189313419;5641.633293835887;5650.971745141248;5653.067243904874;5665.575081868794;5481.643693159932;5491.2312276282155;5497;5503.917441238465;5521.861953451196 11:12:00 INFO - PROCESS | 15874 | |1;ext.html;512.9846104616859;543.5189856976574;581.3895409819688;596.3231731984199;599.0534954771462;27844.164675059754;35615.10962225942;35933.64066359335;36002.63997360026;36084.09789755254;39051.21897562054;39453;39498.40752388717;39526.209475810465;39654.801725991405;8433.114522975091;8440.535770532602;8557.700480483185;8565.614547345353;8606.31149508038;8361.749147525585;8428.620712067972;8505.76666383374;8508.31933445326;8549.358798090168;8491.872621910645;8532.36007299452;8561.48631082134;8571.185737354972;8586;8327.750167494985;8412.789680258013;8463.873041904377;8503.82992340156;8521.744347669579;8312.83374332516;8444.535550544717;8505.659773609048;8509.74470765878;8669.739907802714;38632.61367386347;38652.613473865465;38697.22605547901;38955.61044389576;39109.41335879964;3191.138392633999;3508.7368447366293;3543.3976224041976;3714.628537146291;3951.920961580752;28560.571591426145;28920.855395723098;29423.852880735674;29442.263943401587;29623.70376296231;3726.3851464508325;3766.7551609145316;3804.7907365094907;3869.7484663497066;3875.4380614810693;257556.99999999814;258772;260166;261458;261721;56440;57112.71443642838;57379;57423.71288143533;57468.71265643729;61661;64224.357756422774;65573.34426655673;65597;65626.34373656298;14123.929380353033;14233.715325693429;14318.928405357907;14319.85680143206;14323.856761432253;10599;10649.520771565298;10673.41296228715;10696.41169735672;10703.732406689895;19733.703994440093;19909.601807963758;19925.501862453555;20044.398668039983;20088.296909608092;8012.839743205103;8111.026676798822;8168.305694016075;8195.918040819635;8225;903.8779764731677;936.6066252174103;1018.3940555369543;1043.337480699746;1058.5554067291755;26497.205083847515;26842.32894177622;27147.728522714915;27285;27366.726332736816;1010.0959641121156;1020.6172685243034;1053.947302634865;1108.9279196852178;1176.5293882446917;13840.723185536233;13961.092528985584;14109.365078571283;14457.493987710379;14478.927605361905;310302;311475;316174;316813;317225;51345.486545134074;51711;51820.48179518232;51832.48167518277;52044.739776301634;1302.1340808362522;1304.478208716502;1310.0960337367187;1313.1923866821835;1314.9868501314863;25828.741712582632;25979;26097.869510652326;26459.338516537242;26546.734532654427;45265;45518.77240613776;45627;45791.313130302406;45898.31152532648;286895;287816;287887;288679;289581;32332.83833580817;41582.29715068511;42401.57598423976;42626.78686606547;42755.78622106994;38920.41619375768;39659.405108923966;39899.2020159601;40113.598864010986;40137.598624013386;33776.32447351088;33815.83092084524;34078;34091.318173636886;34642.65357346394;34202.553668023;34550.481742774384;35767.28465430729;36500.63499365078;36918.815405922796;35515.644843551236;35704.64295357013;35774.46338304875;37529.62470375261;38003.809980951024;28720.28199294951;30663;31276.530852036783;31439.37121257608;31515.369692606477;24033.639495407235;26465.603015955163;26560.335991599593;26789;26794.59808102841 11:12:00 INFO - PROCESS | 15874 | |2;jquery.html;339.4467018759423;343.0565943654949;346.2400031929913;346.3540496973145;349.58574089703694;16280.185990700462;16414.917925410373;17198.484045478657;17778.555536111588;18050.4584862454;14403;15119.546413607583;15337.69324613507;15340.69318613627;16161.83838161618;4740.928886066712;4822.638302127337;4845.176320025604;4845.2247640377545;4854;4839.975800120995;4849.296851956464;4867.780949857265;4871.537203965618;4879.804807807701;4847.6121910247275;5076.162433198518;5225.843224703265;5320.441353657869;5330.28041214435;5106.948930510722;5114.462981386938;5180.870478238036;5186.1442861927735;5194.818181363653;5013.674111182761;5229.111051121318;5245.924585459971;5278.313819203518;5288.68267903927;18601;18752.81247187538;18848.434546963614;19132.139053742616;19165.425037248904;2149.1510853212894;2151.8278537716947;2154.353693891826;2224.4994876152896;2258.119333459952;9140.131687489678;9214.078592140731;9350.485723285217;11776.705582360424;12577;1801.3425099838596;1843.0203676105316;1850.4448665400325;1856.9535761605932;1863.9254429822927;58566.9009369156;60906.390936090516;61663;61907.690461547405;61962.76074478485;9855.359401639014;9928.602855885683;10031.648892288735;10065.647702330383;10098.495075246208;13088.149270297401;13115.475380984844;13216.603501894959;13258.801117983237;13302.667433314244;6916.308369163044;6925.549839260532;6948.478864085214;6978.930210697929;6993.300669932966;6442.162518872517;6466.967665161738;6479.8056058318325;6555.6066636002;6555.770548030891;4208.473940757405;4217.481706585627;4224.441482483552;4238.745675259494;4275.3800698898485;1772.7075032619732;1815;1823.3253696132251;1828.5337239003968;1841.8802777819399;425.1263653192719;426.47543521468765;436.54163128715356;443.23099422501934;918.7611221082433;9878.901210987942;10118.443485608215;10172.796544069077;10218.693439196835;10352.585896564204;423.71399305468685;426.47543521468145;432.049491119532;432.2543612268874;433.0797056255457;5592.384837667853;5690.146478028246;5744.971275143681;5756.107803290497;5804.912926306109;520270;523154;536555;547634;550253;40513.18973620511;72050.9192362115;72625;78559.60720196362;79973.60013199897;1159.3855256713787;1166.3701601135463;1189.5479717707217;1198.1253684809963;1224.1736827641307;15712.764308535152;15778.763318550002;15969;16019.35922563131;16190.352385904433;21210;31213.37573248477;35030.64969350274;35543.46684799782;36031.099222519646;45923.77038114788;45994;47168.292475613576;48906;49829;8931.106889311017;8935.597898094471;9022.458652480873;9043.954780226057;9126.954365228132;15900.68198636044;16266.918665406598;16317.673646526766;17555.82444175593;17559.507441867583;11013.033204949534;13213.603591891873;13641.181529108286;13880.722385552433;13981.091229070078;13081.803772943604;13504.392302346221;13743.793843092162;14229.644258893197;14290.42838286457;13734.45062197501;13878.236696981763;14123.43506259738;14282.285885705465;14410.927945360625;8892.77768055778;9026.277897768032;9141.908580914105;9259.76850578741;9430;12946.546870859474;12955.157914735511;12977.545785897448;13710.65723356924;14107.435702571782 11:12:00 INFO - PROCESS | 15874 | |3;mootools.html;1401.6495876030992;1408.43662534986;1529.4111766969713;1702.608400067985;1727.6458326043162;6613.834654133649;6734.090897728805;6990.196127445345;7082.220955694876;7109.6089715065655;6814.420774234183;7050.717971281156;7190.388816950553;7209.927900721004;7250.927490725091;2148.205164089289;2219.6670499425136;2224.510607666311;2234.9888250558724;2237.4853783629774;2203.6914831923546;2230.275160572812;2253.2902135827244;2253.876036817974;2258.1983395894467;2179.574982878339;2179.7384313882358;2200.4168895242774;2209.591225623257;2212.2478357358495;2172.348295511348;2180.5202855371795;2200.3288996855954;2205.889705514726;2211.9778802212013;2173.261091228974;2214.302494714176;2227.599032174208;2229.119497798377;2231.364061242538;7299.598522081284;7315.707371705125;7320.743773967885;7374;7390.3718183954425;4367.628751556122;4403.141387429452;4436.600705936481;4467.620252278561;4484.775761211959;2862.8997985070423;2962.244627619943;2970.2425881400322;2975.866086026134;2992.9551056734167;912.9908700913039;922.1378011559146;922.4834092907993;924.2513564013171;966.1063516247443;9715.951420242924;9762.609495620167;9765.853512197322;9769.951150244204;9789.853152202722;3909.843606255775;3951.269015232191;3973.7019723520275;3992.7803970781306;4002.199560087936;8339.791505212419;8384.496930184208;8408.747737567883;8425.45234559764;8435.283000944866;4433.512313645561;4445.644348452181;4453.4433195850515;4458.910821783546;4462.620677242406;3954.9011274718364;4082.2039702258367;4101.610347017028;4132.318167502389;4154.376843473503;3210.5184222366834;3226.790258633181;3251.7561182911377;3265.151060724229;3267.967320326814;1027.3271007490107;1034.534459493231;1037.896210378956;1039.3971496531992;1042.020500729312;1039.1998161415668;1250.93745312734;1298.9415476303589;1317.328162637062;1321.7620828250815;7035.296470352924;7052.153741551047;7060.6116663584;7077.433805295564;7082.575045497184;450.14247857830884;451.5913098645731;456.9497355290915;463.4947906781624;465.05593644900904;5598.944010559842;5628.240187574625;5636.18275350072;5656.349519805275;5706.400827913092;8625.52559609215;9018.684346047858;9081.863772043425;9092.727218183465;9149.085091490932;8830.381873268938;8839.646414143363;8899.466032038099;8964.641414343354;9002.684906028258;6812.250652428229;6991.825204369829;7033.788986330418;7037.437005039687;7039.190493093258;6894.482913781386;6915.965420172867;6959.7216111357;6964.721411143498;6964.79105626832;7750.7674769756995;7956.2043795619975;8011.118776934416;8019.1579884111325;8136.877946830684;8022.358211342962;8182.590870456334;8216.589170541569;8349.206825351583;8358;5824.184614154106;5938.910916336172;6317.778877739257;6422.165118534561;6575.638339891352;7015.789526314219;7029.332213439715;7084.752033678797;7103.1476222851525;7121.359077683033;6430.164078669743;6586.70359833799;6610.636414997221;6780.660966951731;6886.311368863074;6493.902591461227;6618.6690665467495;6655.668866226871;6705.731770729311;6758.918573028292;6702.564333318319;6745.561538499982;6764.5603035802515;6831.760888368884;6841;6269;6318.6840657965995;6353.301136875032;6377.553571249968;6428.55000149985;6279.780207692709;6325.620462772248;6347.619142851444;6352.205974253218;6373.490120790419 11:12:00 INFO - PROCESS | 15874 | |4;prototype.html;324.3383497664764;331.8274497261424;333.8981610608765;334.22126445382264;337.6100603802609;6264.123022776815;6283.560150789446;6291.559590828644;6304.464120549753;6377.170967774195;6175.413335733109;6183.907241391383;6209.2859321178075;6230.376962303767;6240.84397890053;4697.154512187805;4697.812087516495;4701.78841952113;4708.176069187878;4708.811647534095;4715.646326525507;4716.599089077433;4718.079974404993;4719.221328480814;4730.053989202156;4473.329000649896;4568.908621827562;4612.400387949562;4648.558386953251;4665.253559430492;4597.218472859622;4614.792334344946;4634.0500197459605;4636.652251081183;4638.46657634373;4024.6981476389387;4043.3328500797334;4050.8379664813374;4055.71609987301;4067.1662309226535;5897.587168898179;5920.111983202511;5939.227900372924;5942.197803296543;5949.107633854913;5231.738413079331;5378.91931621026;5394.595405344576;5448.91826622601;5457.263269458612;6544.5746026508605;6561.277070015938;6566.606003639749;6570.901436478457;6572.07990881277;4400.647948164139;4418.955810441887;4420.8452704155525;4431.313146462304;4434.933475997863;6753.3921947025;6823.078884350648;6842.486813488958;6879.346462086144;6889.415434450055;4565.086982603492;4572.748498832596;4574.4739354973935;4574.8791546071425;4579.107074120581;4598.88502787433;4631.444226692751;4632.2125238709505;4638.512956139624;4641.466231383434;5384.757685904144;5386.353637563439;5387.138057910715;5396.9730151348995;5398;6458.192725909262;6554.14796076507;6596;6608.306127856602;6636.270010298863;1616.3938523053855;1629.193549193157;1631.2659303313555;1631.4208455998187;1632.6244963658426;1054.2514814481651;1059.6397224943555;1064.5528877871313;1069.9572017119228;1079.2607064161075;6241.157443745127;6252.374762523711;6281.309056003836;6285.622862628257;6289.874202516015;6763.898541521881;6789.6605169741315;6815.829604259933;6827.351401616838;6848.315168483112;6127.938720612826;6244.906326405107;6257.499400047986;6282.685865706696;6315.273743519462;3718.9442158367647;3736.4021756518828;3741.869034583831;3753.0429740416566;3761.6990640748672;7212.8918066228;7234.348908598251;7246.492745507764;7248.130224373109;7258.383037441771;6959.234484206733;7097.7160913562875;7103.112110986127;7108.36024757764;7118.60847653384;7184.46116541251;7200.459965502609;7209.495335326476;7212.639368031578;7228.783136505808;6853.143357080365;6883.483738719716;6899.6205208714;6902.102726645504;6904.689288982108;6651.26836048044;6746.69639866217;6764.695588698619;6794.456443484608;6816.556923799937;7203.279672032755;7228.4940054197805;7229.891551626624;7243.818904527429;7260.201377848327;4527.683062185615;4596.494385617646;4597.494275629745;4603.700759450625;4611.815527378867;6809.2509823918335;6903.827404314932;6931.272216417204;6988.860222795414;6998;6680.933190668031;6713.899291510729;6722.831929201809;6733.663316834237;6735.528513004043;6521.967390163209;6670.099536562696;6710.530262881747;6727.26000139994;6730.394264516217;6549;6555.2133743949125;6561.1470508835455;6564.212294524687;6566.770163044271;6702.162229721285;6716.361945615159;6717.596944183365;6735.326467353226;6746.4265537429865;6410.839729006626;6450.709718062604;6500.414962653384;6519.706613202512;6532.118164047983 11:12:00 INFO - PROCESS | 15874 | |5;yui.html;772.208486301541;815.6207363575936;848.1518481518482;851.3317046118798;877.8332116897793;13308.866911330908;13373.531926382579;13400.93299533501;13484.393202305895;13504.932475337622;12249.081318901095;12319.938400308009;12335.444904979275;12348.629541113758;12464.750704985894;655.7245956698198;666.6333516565894;794.2057942057942;800.383704547501;810.8094597769519;805.9435839491238;808.8584497712877;813.5240884082818;813.9552324622143;816.8815521749343;852.3436953545767;857.6140736668493;858.5149390594325;861.530465896085;861.5562985062697;849.4478588917223;852.4160949749441;852.846487632226;852.9147085291484;853.4580541356283;614.6189362595175;617.129846915851;622.5206590924962;623.2583225961137;625.8560531077832;13337.066405351628;13548.390322435514;13571.524996625169;13572.864271357259;13589.796153057712;11988.64034078979;12073.879261207363;12102.939485302517;12280.815787763191;12469.875301246962;9701.126898579161;9775.266854985834;9787.510624468749;9792.804143917154;9814.165795907356;3483.5297234873474;3510.5260789793306;3529.364714351416;3534.964650353515;3729.1236559408517;45842.77078614619;45945.770271148765;46174.76912615449;46234.53765462336;46302.53697463016;9890.456024918554;10251.58993640246;10253.384796912209;10390.58437662485;10393.220508461896;18765;18808.529786755167;18810;18849.81150188508;18855.151518181716;7433.070866141732;7636.847263054708;7725.343345815669;7775.533467991939;7799.259070388418;4230.323148296319;4251.107267473865;4274.529801721808;4277.486701595828;4300.204462174508;3066.9079927602206;3075.1543325585644;3084.9691503085132;3085.460044492205;3113.377324535102;522.6576592332028;537.3632245788752;547.6686604604157;547.8657728856376;553.8006317725616;461.1445768100193;521.6140056358344;541.8374487653767;593.0866465642862;620.7238472979673;8250.216229458192;8404.705835295736;8655.567221638892;8905.777355566162;8920.955395222982;453.32454642582314;552.6242155334411;594.3551246897165;607.4472230270433;623.3392603839853;3729.9440508392395;3783;3801.353769859131;3814.370628846265;3901.51231096113;51821.74089129605;52502.73748631309;57231;57358;57435.71282143563;47101.764491177324;48477.51522484801;49050.264246036335;49789.751051244515;51081;44576.33135503035;45328.54671453243;45337.54662453399;45376;45803.541964580596;7701.653425595974;8090.83818323642;8387.790305242417;8396.87404688918;8896.243819275434;34035.65964340325;34479;34735.30529389449;35050.649493505756;35383.11542211465;43406.22531521593;43428.34857477203;44005;44096.55903441053;44243.77878110589;10819.18856085781;10934.507947142556;10952.34285942846;11031.724206894893;11077.612283570037;11891.464884080064;11977.461014254553;12050.397480126134;12084.335361555199;12451.315177665316;11011;11050.778984420427;11326.660200193677;11444.542218311175;11731.120165987415;10822.945885270523;11087.39019353911;11165.49755260999;11507.309561426342;11656.30062196271;10220.948895255477;10473.581056757645;10794;10887.673369798918;11257.774844503228;9029.311608473881;9246.214071803972;9299.86050209261;9554.61781528731;9936.652217172365;8689.217970382695;8701.17338852808;8757.299416046573;9256.398334108262;9449.811003780023 11:12:00 INFO - PROCESS | 15874 | __end_tp_report 11:12:00 INFO - PROCESS | 15874 | __start_cc_report 11:12:00 INFO - PROCESS | 15874 | _x_x_mozilla_cycle_collect,329 11:12:00 INFO - PROCESS | 15874 | __end_cc_report 11:12:00 INFO - PROCESS | 15874 | __startTimestamp1452021120740__endTimestamp 11:12:00 INFO - PROCESS | 15874 | 11:12:00 INFO - PROCESS | 15874 | ------- Summary: start ------- 11:12:00 INFO - PROCESS | 15874 | Number of tests: 6 11:12:00 INFO - PROCESS | 15874 | 11:12:00 INFO - PROCESS | 15874 | [#0] dojo.html Cycles:165 Average:5349.31 Median:5577.22 stddev:693.97 (12.4%) stddev-sans-first:674.29 11:12:00 INFO - PROCESS | 15874 | Values: 3148.6 3194.6 3228.0 3238.1 3238.8 5286.5 5321.8 5396.1 5402.5 5407.5 5326.1 5328.2 5328.7 5332.5 5337.9 4745.7 4885.7 4901.2 4987.8 5008.1 4919.0 4992.9 5005.6 5005.7 5039.4 823.4 4901.3 4912.1 4924.6 4958.1 4945.9 4961.4 4963.3 4965.6 5013.2 4969.1 4986.2 5006.4 5019.8 5081.6 5085.5 5157.5 5204.8 5221.8 5262.1 5774.8 5806.0 5824.7 5826.4 5829.3 5755.8 5865.9 5871.4 5880.4 5890.1 5285.6 5308.6 5404.2 5414.0 5444.3 5918.4 5965.6 5966.6 5969.0 5981.3 5615.7 5667.9 5692.6 5711.5 5725.3 5767.3 5850.1 5865.0 5869.4 5903.7 5794.2 5827.1 5829.8 5842.3 5844.1 5458.5 5549.8 5825.0 5829.7 5829.9 4462.3 4528.8 4544.2 4567.0 4585.0 3965.5 3973.5 3975.0 3992.0 4016.2 5272.4 5289.3 5392.4 5394.3 5461.3 5742.8 5744.2 5754.4 5771.4 5799.4 5364.5 5389.0 5397.1 5412.0 5418.1 4843.0 4843.1 4914.1 4945.4 4955.2 5988.9 6002.1 6013.2 6017.5 6028.6 5737.6 5757.1 5780.6 5782.5 5789.9 5966.4 5995.3 6065.7 6098.6 6113.2 5674.8 5675.8 5680.6 5687.0 5687.6 5762.5 5774.8 5783.7 5792.8 5801.0 5645.5 5681.1 5756.4 5758.3 5812.7 5689.2 5704.9 5715.4 5716.3 5731.8 5465.1 5581.0 5611.4 5627.5 5631.9 5577.2 5641.6 5651.0 5653.1 5665.6 5481.6 5491.2 5497.0 5503.9 5521.9 11:12:00 INFO - PROCESS | 15874 | 11:12:00 INFO - PROCESS | 15874 | [#1] ext.html Cycles:180 Average:45572.85 Median:35968.14 stddev:75376.16 (209.6%) stddev-sans-first:75511.68 11:12:00 INFO - PROCESS | 15874 | Values: 513.0 543.5 581.4 596.3 599.1 27844.2 35615.1 35933.6 36002.6 36084.1 39051.2 39453.0 39498.4 39526.2 39654.8 8433.1 8440.5 8557.7 8565.6 8606.3 8361.7 8428.6 8505.8 8508.3 8549.4 8491.9 8532.4 8561.5 8571.2 8586.0 8327.8 8412.8 8463.9 8503.8 8521.7 8312.8 8444.5 8505.7 8509.7 8669.7 38632.6 38652.6 38697.2 38955.6 39109.4 3191.1 3508.7 3543.4 3714.6 3951.9 28560.6 28920.9 29423.9 29442.3 29623.7 3726.4 3766.8 3804.8 3869.7 3875.4 257557.0 258772.0 260166.0 261458.0 261721.0 56440.0 57112.7 57379.0 57423.7 57468.7 61661.0 64224.4 65573.3 65597.0 65626.3 14123.9 14233.7 14318.9 14319.9 14323.9 10599.0 10649.5 10673.4 10696.4 10703.7 19733.7 19909.6 19925.5 20044.4 20088.3 8012.8 8111.0 8168.3 8195.9 8225.0 903.9 936.6 1018.4 1043.3 1058.6 26497.2 26842.3 27147.7 27285.0 27366.7 1010.1 1020.6 1053.9 1108.9 1176.5 13840.7 13961.1 14109.4 14457.5 14478.9 310302.0 311475.0 316174.0 316813.0 317225.0 51345.5 51711.0 51820.5 51832.5 52044.7 1302.1 1304.5 1310.1 1313.2 1315.0 25828.7 25979.0 26097.9 26459.3 26546.7 45265.0 45518.8 45627.0 45791.3 45898.3 286895.0 287816.0 287887.0 288679.0 289581.0 32332.8 41582.3 42401.6 42626.8 42755.8 38920.4 39659.4 39899.2 40113.6 40137.6 33776.3 33815.8 34078.0 34091.3 34642.7 34202.6 34550.5 35767.3 36500.6 36918.8 35515.6 35704.6 35774.5 37529.6 38003.8 28720.3 30663.0 31276.5 31439.4 31515.4 24033.6 26465.6 26560.3 26789.0 26794.6 11:12:00 INFO - PROCESS | 15874 | 11:12:00 INFO - PROCESS | 15874 | [#2] jquery.html Cycles:180 Average:27829.70 Median:4212.98 stddev:87511.60 (2077.2%) stddev-sans-first:87732.75 11:12:00 INFO - PROCESS | 15874 | Values: 339.4 343.1 346.2 346.4 349.6 16280.2 16414.9 17198.5 17778.6 18050.5 14403.0 15119.5 15337.7 15340.7 16161.8 4740.9 4822.6 4845.2 4845.2 4854.0 4840.0 4849.3 4867.8 4871.5 4879.8 4847.6 5076.2 5225.8 5320.4 5330.3 5106.9 5114.5 5180.9 5186.1 5194.8 5013.7 5229.1 5245.9 5278.3 5288.7 18601.0 18752.8 18848.4 19132.1 19165.4 2149.2 2151.8 2154.4 2224.5 2258.1 9140.1 9214.1 9350.5 11776.7 12577.0 1801.3 1843.0 1850.4 1857.0 1863.9 58566.9 60906.4 61663.0 61907.7 61962.8 9855.4 9928.6 10031.6 10065.6 10098.5 13088.1 13115.5 13216.6 13258.8 13302.7 6916.3 6925.5 6948.5 6978.9 6993.3 6442.2 6467.0 6479.8 6555.6 6555.8 4208.5 4217.5 4224.4 4238.7 4275.4 1772.7 1815.0 1823.3 1828.5 1841.9 425.1 426.5 436.5 443.2 918.8 9878.9 10118.4 10172.8 10218.7 10352.6 423.7 426.5 432.0 432.3 433.1 5592.4 5690.1 5745.0 5756.1 5804.9 520270.0 523154.0 536555.0 547634.0 550253.0 40513.2 72050.9 72625.0 78559.6 79973.6 1159.4 1166.4 1189.5 1198.1 1224.2 15712.8 15778.8 15969.0 16019.4 16190.4 21210.0 31213.4 35030.6 35543.5 36031.1 45923.8 45994.0 47168.3 48906.0 49829.0 8931.1 8935.6 9022.5 9044.0 9127.0 15900.7 16266.9 16317.7 17555.8 17559.5 11013.0 13213.6 13641.2 13880.7 13981.1 13081.8 13504.4 13743.8 14229.6 14290.4 13734.5 13878.2 14123.4 14282.3 14410.9 8892.8 9026.3 9141.9 9259.8 9430.0 12946.5 12955.2 12977.5 13710.7 14107.4 11:12:00 INFO - PROCESS | 15874 | 11:12:00 INFO - PROCESS | 15874 | [#3] mootools.html Cycles:180 Average:5158.53 Median:6375.52 stddev:2671.76 (41.9%) stddev-sans-first:2664.33 11:12:00 INFO - PROCESS | 15874 | Values: 1401.6 1408.4 1529.4 1702.6 1727.6 6613.8 6734.1 6990.2 7082.2 7109.6 6814.4 7050.7 7190.4 7209.9 7250.9 2148.2 2219.7 2224.5 2235.0 2237.5 2203.7 2230.3 2253.3 2253.9 2258.2 2179.6 2179.7 2200.4 2209.6 2212.2 2172.3 2180.5 2200.3 2205.9 2212.0 2173.3 2214.3 2227.6 2229.1 2231.4 7299.6 7315.7 7320.7 7374.0 7390.4 4367.6 4403.1 4436.6 4467.6 4484.8 2862.9 2962.2 2970.2 2975.9 2993.0 913.0 922.1 922.5 924.3 966.1 9716.0 9762.6 9765.9 9770.0 9789.9 3909.8 3951.3 3973.7 3992.8 4002.2 8339.8 8384.5 8408.7 8425.5 8435.3 4433.5 4445.6 4453.4 4458.9 4462.6 3954.9 4082.2 4101.6 4132.3 4154.4 3210.5 3226.8 3251.8 3265.2 3268.0 1027.3 1034.5 1037.9 1039.4 1042.0 1039.2 1250.9 1298.9 1317.3 1321.8 7035.3 7052.2 7060.6 7077.4 7082.6 450.1 451.6 456.9 463.5 465.1 5598.9 5628.2 5636.2 5656.3 5706.4 8625.5 9018.7 9081.9 9092.7 9149.1 8830.4 8839.6 8899.5 8964.6 9002.7 6812.3 6991.8 7033.8 7037.4 7039.2 6894.5 6916.0 6959.7 6964.7 6964.8 7750.8 7956.2 8011.1 8019.2 8136.9 8022.4 8182.6 8216.6 8349.2 8358.0 5824.2 5938.9 6317.8 6422.2 6575.6 7015.8 7029.3 7084.8 7103.1 7121.4 6430.2 6586.7 6610.6 6780.7 6886.3 6493.9 6618.7 6655.7 6705.7 6758.9 6702.6 6745.6 6764.6 6831.8 6841.0 6269.0 6318.7 6353.3 6377.6 6428.6 6279.8 6325.6 6347.6 6352.2 6373.5 11:12:00 INFO - PROCESS | 15874 | 11:12:00 INFO - PROCESS | 15874 | [#4] prototype.html Cycles:180 Average:5518.36 Median:6272.72 stddev:1710.45 (27.3%) stddev-sans-first:1670.23 11:12:00 INFO - PROCESS | 15874 | Values: 324.3 331.8 333.9 334.2 337.6 6264.1 6283.6 6291.6 6304.5 6377.2 6175.4 6183.9 6209.3 6230.4 6240.8 4697.2 4697.8 4701.8 4708.2 4708.8 4715.6 4716.6 4718.1 4719.2 4730.1 4473.3 4568.9 4612.4 4648.6 4665.3 4597.2 4614.8 4634.1 4636.7 4638.5 4024.7 4043.3 4050.8 4055.7 4067.2 5897.6 5920.1 5939.2 5942.2 5949.1 5231.7 5378.9 5394.6 5448.9 5457.3 6544.6 6561.3 6566.6 6570.9 6572.1 4400.6 4419.0 4420.8 4431.3 4434.9 6753.4 6823.1 6842.5 6879.3 6889.4 4565.1 4572.7 4574.5 4574.9 4579.1 4598.9 4631.4 4632.2 4638.5 4641.5 5384.8 5386.4 5387.1 5397.0 5398.0 6458.2 6554.1 6596.0 6608.3 6636.3 1616.4 1629.2 1631.3 1631.4 1632.6 1054.3 1059.6 1064.6 1070.0 1079.3 6241.2 6252.4 6281.3 6285.6 6289.9 6763.9 6789.7 6815.8 6827.4 6848.3 6127.9 6244.9 6257.5 6282.7 6315.3 3718.9 3736.4 3741.9 3753.0 3761.7 7212.9 7234.3 7246.5 7248.1 7258.4 6959.2 7097.7 7103.1 7108.4 7118.6 7184.5 7200.5 7209.5 7212.6 7228.8 6853.1 6883.5 6899.6 6902.1 6904.7 6651.3 6746.7 6764.7 6794.5 6816.6 7203.3 7228.5 7229.9 7243.8 7260.2 4527.7 4596.5 4597.5 4603.7 4611.8 6809.3 6903.8 6931.3 6988.9 6998.0 6680.9 6713.9 6722.8 6733.7 6735.5 6522.0 6670.1 6710.5 6727.3 6730.4 6549.0 6555.2 6561.1 6564.2 6566.8 6702.2 6716.4 6717.6 6735.3 6746.4 6410.8 6450.7 6500.4 6519.7 6532.1 11:12:00 INFO - PROCESS | 15874 | 11:12:00 INFO - PROCESS | 15874 | [#5] yui.html Cycles:180 Average:13473.19 Median:45894.27 stddev:15435.15 (33.6%) stddev-sans-first:15448.98 11:12:00 INFO - PROCESS | 15874 | Values: 772.2 815.6 848.2 851.3 877.8 13308.9 13373.5 13400.9 13484.4 13504.9 12249.1 12319.9 12335.4 12348.6 12464.8 655.7 666.6 794.2 800.4 810.8 805.9 808.9 813.5 814.0 816.9 852.3 857.6 858.5 861.5 861.6 849.4 852.4 852.8 852.9 853.5 614.6 617.1 622.5 623.3 625.9 13337.1 13548.4 13571.5 13572.9 13589.8 11988.6 12073.9 12102.9 12280.8 12469.9 9701.1 9775.3 9787.5 9792.8 9814.2 3483.5 3510.5 3529.4 3535.0 3729.1 45842.8 45945.8 46174.8 46234.5 46302.5 9890.5 10251.6 10253.4 10390.6 10393.2 18765.0 18808.5 18810.0 18849.8 18855.2 7433.1 7636.8 7725.3 7775.5 7799.3 4230.3 4251.1 4274.5 4277.5 4300.2 3066.9 3075.2 3085.0 3085.5 3113.4 522.7 537.4 547.7 547.9 553.8 461.1 521.6 541.8 593.1 620.7 8250.2 8404.7 8655.6 8905.8 8921.0 453.3 552.6 594.4 607.4 623.3 3729.9 3783.0 3801.4 3814.4 3901.5 51821.7 52502.7 57231.0 57358.0 57435.7 47101.8 48477.5 49050.3 49789.8 51081.0 44576.3 45328.5 45337.5 45376.0 45803.5 7701.7 8090.8 8387.8 8396.9 8896.2 34035.7 34479.0 34735.3 35050.6 35383.1 43406.2 43428.3 44005.0 44096.6 44243.8 10819.2 10934.5 10952.3 11031.7 11077.6 11891.5 11977.5 12050.4 12084.3 12451.3 11011.0 11050.8 11326.7 11444.5 11731.1 10822.9 11087.4 11165.5 11507.3 11656.3 10220.9 10473.6 10794.0 10887.7 11257.8 9029.3 9246.2 9299.9 9554.6 9936.7 8689.2 8701.2 8757.3 9256.4 9449.8 11:12:00 INFO - PROCESS | 15874 | -------- Summary: end -------- 11:12:00 INFO - PROCESS | 15874 | 11:12:01 INFO - TEST-INFO | 15874: exit 0 11:12:01 INFO - TEST-OK | dromaeo_css | took 1109814ms 11:12:01 INFO - TEST-START | kraken 11:12:01 INFO - operating with platform_type : linux_ 11:12:01 INFO - Initialising browser for kraken test... 11:12:01 INFO - TEST-INFO | started process 16114 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSrCUv5/profile http://localhost:42355/getInfo.html) 11:12:05 INFO - PROCESS | 16114 | __metrics Screen width/height:1600/1200 11:12:05 INFO - PROCESS | 16114 | colorDepth:24 11:12:05 INFO - PROCESS | 16114 | Browser inner width/height: 1024/697 11:12:05 INFO - PROCESS | 16114 | __metrics 11:12:06 INFO - PROCESS | 16114 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:12:07 INFO - TEST-INFO | 16114: exit 0 11:12:07 INFO - Browser initialized. 11:12:07 INFO - Running cycle 1/1 for kraken test... 11:12:07 INFO - TEST-INFO | started process 16236 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSrCUv5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:12:18 INFO - PROCESS | 16236 | RSS: Main: 150249472 11:12:18 INFO - PROCESS | 16236 | 11:12:21 INFO - PROCESS | 16236 | Cycle 1(1): loaded http://localhost:42355/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42355/tests/kraken/driver.html?testName=audio-beat-detection) 11:12:21 INFO - PROCESS | 16236 | RSS: Main: 151871488 11:12:21 INFO - PROCESS | 16236 | 11:12:24 INFO - PROCESS | 16236 | Cycle 1(1): loaded http://localhost:42355/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42355/tests/kraken/driver.html?testName=audio-dft) 11:12:25 INFO - PROCESS | 16236 | RSS: Main: 151601152 11:12:25 INFO - PROCESS | 16236 | 11:12:28 INFO - PROCESS | 16236 | Cycle 1(1): loaded http://localhost:42355/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42355/tests/kraken/driver.html?testName=audio-fft) 11:12:28 INFO - PROCESS | 16236 | RSS: Main: 146833408 11:12:28 INFO - PROCESS | 16236 | 11:12:30 INFO - PROCESS | 16236 | Cycle 1(1): loaded http://localhost:42355/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42355/tests/kraken/driver.html?testName=audio-oscillator) 11:12:31 INFO - PROCESS | 16236 | RSS: Main: 146358272 11:12:31 INFO - PROCESS | 16236 | 11:12:33 INFO - PROCESS | 16236 | Cycle 1(1): loaded http://localhost:42355/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42355/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:12:34 INFO - PROCESS | 16236 | RSS: Main: 147025920 11:12:34 INFO - PROCESS | 16236 | 11:12:37 INFO - PROCESS | 16236 | Cycle 1(1): loaded http://localhost:42355/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42355/tests/kraken/driver.html?testName=imaging-darkroom) 11:12:37 INFO - PROCESS | 16236 | RSS: Main: 147886080 11:12:37 INFO - PROCESS | 16236 | 11:12:41 INFO - PROCESS | 16236 | Cycle 1(1): loaded http://localhost:42355/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42355/tests/kraken/driver.html?testName=imaging-desaturate) 11:12:41 INFO - PROCESS | 16236 | RSS: Main: 148930560 11:12:41 INFO - PROCESS | 16236 | 11:12:44 INFO - PROCESS | 16236 | Cycle 1(1): loaded http://localhost:42355/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42355/tests/kraken/driver.html?testName=json-parse-financial) 11:12:44 INFO - PROCESS | 16236 | RSS: Main: 149045248 11:12:44 INFO - PROCESS | 16236 | 11:12:46 INFO - PROCESS | 16236 | Cycle 1(1): loaded http://localhost:42355/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42355/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:12:47 INFO - PROCESS | 16236 | RSS: Main: 148393984 11:12:47 INFO - PROCESS | 16236 | 11:12:49 INFO - PROCESS | 16236 | Cycle 1(1): loaded http://localhost:42355/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42355/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:12:49 INFO - PROCESS | 16236 | RSS: Main: 149131264 11:12:49 INFO - PROCESS | 16236 | 11:12:51 INFO - PROCESS | 16236 | Cycle 1(1): loaded http://localhost:42355/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42355/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:12:52 INFO - PROCESS | 16236 | RSS: Main: 148963328 11:12:52 INFO - PROCESS | 16236 | 11:12:54 INFO - PROCESS | 16236 | Cycle 1(1): loaded http://localhost:42355/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42355/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:12:55 INFO - PROCESS | 16236 | RSS: Main: 148951040 11:12:55 INFO - PROCESS | 16236 | 11:12:57 INFO - PROCESS | 16236 | Cycle 1(1): loaded http://localhost:42355/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42355/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:12:58 INFO - PROCESS | 16236 | RSS: Main: 147304448 11:12:58 INFO - PROCESS | 16236 | 11:13:00 INFO - PROCESS | 16236 | Cycle 1(1): loaded http://localhost:42355/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42355/tests/kraken/driver.html?testName=ai-astar) 11:13:00 INFO - PROCESS | 16236 | RSS: Main: 149602304 11:13:00 INFO - PROCESS | 16236 | 11:13:00 INFO - PROCESS | 16236 | __start_tp_report 11:13:00 INFO - PROCESS | 16236 | _x_x_mozilla_page_load 11:13:00 INFO - PROCESS | 16236 | _x_x_mozilla_page_load_details 11:13:00 INFO - PROCESS | 16236 | |i|pagename|runs| 11:13:00 INFO - PROCESS | 16236 | |0;ai-astar;110;106;111;111;111;121;110;110;112;112 11:13:00 INFO - PROCESS | 16236 | |1;audio-beat-detection;149;127;156;164;133;154;152;127;176;128 11:13:00 INFO - PROCESS | 16236 | |2;audio-dft;163;164;163;164;164;162;162;167;168;163 11:13:00 INFO - PROCESS | 16236 | |3;audio-fft;73;75;74;75;76;73;137;71;72;75 11:13:00 INFO - PROCESS | 16236 | |4;audio-oscillator;96;96;149;96;95;96;134;96;96;144 11:13:00 INFO - PROCESS | 16236 | |5;imaging-gaussian-blur;109;111;111;110;110;110;110;110;110;111 11:13:00 INFO - PROCESS | 16236 | |6;imaging-darkroom;150;147;147;147;147;147;148;148;147;148 11:13:00 INFO - PROCESS | 16236 | |7;imaging-desaturate;96;96;97;97;96;96;96;96;96;96 11:13:00 INFO - PROCESS | 16236 | |8;json-parse-financial;63;65;63;63;64;64;64;64;64;62 11:13:00 INFO - PROCESS | 16236 | |9;json-stringify-tinderbox;67;68;69;69;69;69;69;69;68;68 11:13:00 INFO - PROCESS | 16236 | |10;stanford-crypto-aes;85;92;85;85;98;84;87;86;89;87 11:13:00 INFO - PROCESS | 16236 | |11;stanford-crypto-ccm;123;125;124;128;130;117;135;124;127;119 11:13:00 INFO - PROCESS | 16236 | |12;stanford-crypto-pbkdf2;140;152;149;152;145;150;151;149;150;143 11:13:00 INFO - PROCESS | 16236 | |13;stanford-crypto-sha256-iterative;68;68;68;76;70;68;68;71;69;69 11:13:00 INFO - PROCESS | 16236 | __end_tp_report 11:13:00 INFO - PROCESS | 16236 | __start_cc_report 11:13:00 INFO - PROCESS | 16236 | _x_x_mozilla_cycle_collect,743 11:13:00 INFO - PROCESS | 16236 | __end_cc_report 11:13:00 INFO - PROCESS | 16236 | __startTimestamp1452021180511__endTimestamp 11:13:00 INFO - PROCESS | 16236 | 11:13:00 INFO - PROCESS | 16236 | ------- Summary: start ------- 11:13:00 INFO - PROCESS | 16236 | Number of tests: 14 11:13:00 INFO - PROCESS | 16236 | 11:13:00 INFO - PROCESS | 16236 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.00 stddev:3.78 (3.4%) stddev-sans-first:3.97 11:13:00 INFO - PROCESS | 16236 | Values: 110.0 106.0 111.0 111.0 111.0 121.0 110.0 110.0 112.0 112.0 11:13:00 INFO - PROCESS | 16236 | 11:13:00 INFO - PROCESS | 16236 | [#1] audio-beat-detection Cycles:10 Average:146.60 Median:153.00 stddev:17.14 (11.2%) stddev-sans-first:18.16 11:13:00 INFO - PROCESS | 16236 | Values: 149.0 127.0 156.0 164.0 133.0 154.0 152.0 127.0 176.0 128.0 11:13:00 INFO - PROCESS | 16236 | 11:13:00 INFO - PROCESS | 16236 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:2.00 (1.2%) stddev-sans-first:2.09 11:13:00 INFO - PROCESS | 16236 | Values: 163.0 164.0 163.0 164.0 164.0 162.0 162.0 167.0 168.0 163.0 11:13:00 INFO - PROCESS | 16236 | 11:13:00 INFO - PROCESS | 16236 | [#3] audio-fft Cycles:10 Average:80.10 Median:74.50 stddev:20.05 (26.9%) stddev-sans-first:21.10 11:13:00 INFO - PROCESS | 16236 | Values: 73.0 75.0 74.0 75.0 76.0 73.0 137.0 71.0 72.0 75.0 11:13:00 INFO - PROCESS | 16236 | 11:13:00 INFO - PROCESS | 16236 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:96.00 stddev:22.74 (23.7%) stddev-sans-first:23.56 11:13:00 INFO - PROCESS | 16236 | Values: 96.0 96.0 149.0 96.0 95.0 96.0 134.0 96.0 96.0 144.0 11:13:00 INFO - PROCESS | 16236 | 11:13:00 INFO - PROCESS | 16236 | [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.50 11:13:00 INFO - PROCESS | 16236 | Values: 109.0 111.0 111.0 110.0 110.0 110.0 110.0 110.0 110.0 111.0 11:13:00 INFO - PROCESS | 16236 | 11:13:00 INFO - PROCESS | 16236 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:0.97 (0.7%) stddev-sans-first:0.50 11:13:00 INFO - PROCESS | 16236 | Values: 150.0 147.0 147.0 147.0 147.0 147.0 148.0 148.0 147.0 148.0 11:13:00 INFO - PROCESS | 16236 | 11:13:00 INFO - PROCESS | 16236 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:13:00 INFO - PROCESS | 16236 | Values: 96.0 96.0 97.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 11:13:00 INFO - PROCESS | 16236 | 11:13:00 INFO - PROCESS | 16236 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:64.00 stddev:0.84 (1.3%) stddev-sans-first:0.87 11:13:00 INFO - PROCESS | 16236 | Values: 63.0 65.0 63.0 63.0 64.0 64.0 64.0 64.0 64.0 62.0 11:13:00 INFO - PROCESS | 16236 | 11:13:00 INFO - PROCESS | 16236 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.71 (1.0%) stddev-sans-first:0.50 11:13:00 INFO - PROCESS | 16236 | Values: 67.0 68.0 69.0 69.0 69.0 69.0 69.0 69.0 68.0 68.0 11:13:00 INFO - PROCESS | 16236 | 11:13:00 INFO - PROCESS | 16236 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:87.00 stddev:4.29 (4.9%) stddev-sans-first:4.43 11:13:00 INFO - PROCESS | 16236 | Values: 85.0 92.0 85.0 85.0 98.0 84.0 87.0 86.0 89.0 87.0 11:13:00 INFO - PROCESS | 16236 | 11:13:00 INFO - PROCESS | 16236 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:126.00 stddev:5.20 (4.1%) stddev-sans-first:5.46 11:13:00 INFO - PROCESS | 16236 | Values: 123.0 125.0 124.0 128.0 130.0 117.0 135.0 124.0 127.0 119.0 11:13:00 INFO - PROCESS | 16236 | 11:13:00 INFO - PROCESS | 16236 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.10 Median:150.00 stddev:4.07 (2.7%) stddev-sans-first:3.08 11:13:00 INFO - PROCESS | 16236 | Values: 140.0 152.0 149.0 152.0 145.0 150.0 151.0 149.0 150.0 143.0 11:13:00 INFO - PROCESS | 16236 | 11:13:00 INFO - PROCESS | 16236 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.00 stddev:2.51 (3.6%) stddev-sans-first:2.60 11:13:00 INFO - PROCESS | 16236 | Values: 68.0 68.0 68.0 76.0 70.0 68.0 68.0 71.0 69.0 69.0 11:13:00 INFO - PROCESS | 16236 | -------- Summary: end -------- 11:13:00 INFO - PROCESS | 16236 | 11:13:01 INFO - TEST-INFO | 16236: exit 0 11:13:01 INFO - TEST-OK | kraken | took 59996ms 11:13:01 INFO - TEST-START | v8_7 11:13:01 INFO - operating with platform_type : linux_ 11:13:01 INFO - Initialising browser for v8_7 test... 11:13:01 INFO - TEST-INFO | started process 16526 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp00HOwd/profile http://localhost:42355/getInfo.html) 11:13:05 INFO - PROCESS | 16526 | __metrics Screen width/height:1600/1200 11:13:05 INFO - PROCESS | 16526 | colorDepth:24 11:13:05 INFO - PROCESS | 16526 | Browser inner width/height: 1024/697 11:13:05 INFO - PROCESS | 16526 | __metrics 11:13:06 INFO - PROCESS | 16526 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:13:07 INFO - TEST-INFO | 16526: exit 0 11:13:07 INFO - Browser initialized. 11:13:07 INFO - Running cycle 1/1 for v8_7 test... 11:13:07 INFO - TEST-INFO | started process 16648 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp00HOwd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:13:18 INFO - PROCESS | 16648 | RSS: Main: 150495232 11:13:18 INFO - PROCESS | 16648 | 11:13:40 INFO - PROCESS | 16648 | Cycle 1(1): loaded http://localhost:42355/tests/v8_7/run.html (next: http://localhost:42355/tests/v8_7/run.html) 11:13:40 INFO - PROCESS | 16648 | RSS: Main: 146251776 11:13:40 INFO - PROCESS | 16648 | 11:13:40 INFO - PROCESS | 16648 | __start_tp_report 11:13:40 INFO - PROCESS | 16648 | _x_x_mozilla_page_load 11:13:40 INFO - PROCESS | 16648 | _x_x_mozilla_page_load_details 11:13:40 INFO - PROCESS | 16648 | |i|pagename|runs| 11:13:40 INFO - PROCESS | 16648 | |0;Richards;167.22408026755852 11:13:40 INFO - PROCESS | 16648 | |1;DeltaBlue;189.75332068311195 11:13:40 INFO - PROCESS | 16648 | |2;Encrypt;281.5315315315315 11:13:40 INFO - PROCESS | 16648 | |3;Decrypt;5246.073298429319 11:13:40 INFO - PROCESS | 16648 | |4;RayTrace;1058.2010582010582 11:13:40 INFO - PROCESS | 16648 | |5;Earley;709.2198581560284 11:13:40 INFO - PROCESS | 16648 | |6;Boyer;12304.878048780487 11:13:40 INFO - PROCESS | 16648 | |7;RegExp;25743.589743589742 11:13:40 INFO - PROCESS | 16648 | |8;Splay;616.5228113440197 11:13:40 INFO - PROCESS | 16648 | |9;NavierStokes;4850.241545893719 11:13:40 INFO - PROCESS | 16648 | __end_tp_report 11:13:40 INFO - PROCESS | 16648 | __startTimestamp1452021220489__endTimestamp 11:13:40 INFO - PROCESS | 16648 | 11:13:40 INFO - PROCESS | 16648 | ------- Summary: start ------- 11:13:40 INFO - PROCESS | 16648 | Number of tests: 10 11:13:40 INFO - PROCESS | 16648 | 11:13:40 INFO - PROCESS | 16648 | [#0] Richards Cycles:1 Average:167.22 Median:167.22 stddev:0.00 (0.0%) 11:13:40 INFO - PROCESS | 16648 | Values: 167.2 11:13:40 INFO - PROCESS | 16648 | 11:13:40 INFO - PROCESS | 16648 | [#1] DeltaBlue Cycles:1 Average:189.75 Median:189.75 stddev:0.00 (0.0%) 11:13:40 INFO - PROCESS | 16648 | Values: 189.8 11:13:40 INFO - PROCESS | 16648 | 11:13:40 INFO - PROCESS | 16648 | [#2] Encrypt Cycles:1 Average:281.53 Median:281.53 stddev:0.00 (0.0%) 11:13:40 INFO - PROCESS | 16648 | Values: 281.5 11:13:40 INFO - PROCESS | 16648 | 11:13:40 INFO - PROCESS | 16648 | [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 11:13:40 INFO - PROCESS | 16648 | Values: 5246.1 11:13:40 INFO - PROCESS | 16648 | 11:13:40 INFO - PROCESS | 16648 | [#4] RayTrace Cycles:1 Average:1058.20 Median:1058.20 stddev:0.00 (0.0%) 11:13:40 INFO - PROCESS | 16648 | Values: 1058.2 11:13:40 INFO - PROCESS | 16648 | 11:13:40 INFO - PROCESS | 16648 | [#5] Earley Cycles:1 Average:709.22 Median:709.22 stddev:0.00 (0.0%) 11:13:40 INFO - PROCESS | 16648 | Values: 709.2 11:13:40 INFO - PROCESS | 16648 | 11:13:40 INFO - PROCESS | 16648 | [#6] Boyer Cycles:1 Average:12304.88 Median:12304.88 stddev:0.00 (0.0%) 11:13:40 INFO - PROCESS | 16648 | Values: 12304.9 11:13:40 INFO - PROCESS | 16648 | 11:13:40 INFO - PROCESS | 16648 | [#7] RegExp Cycles:1 Average:25743.59 Median:25743.59 stddev:0.00 (0.0%) 11:13:40 INFO - PROCESS | 16648 | Values: 25743.6 11:13:40 INFO - PROCESS | 16648 | 11:13:40 INFO - PROCESS | 16648 | [#8] Splay Cycles:1 Average:616.52 Median:616.52 stddev:0.00 (0.0%) 11:13:40 INFO - PROCESS | 16648 | Values: 616.5 11:13:40 INFO - PROCESS | 16648 | 11:13:40 INFO - PROCESS | 16648 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 11:13:40 INFO - PROCESS | 16648 | Values: 4850.2 11:13:40 INFO - PROCESS | 16648 | -------- Summary: end -------- 11:13:40 INFO - PROCESS | 16648 | 11:13:41 INFO - TEST-INFO | 16648: exit 0 11:13:41 INFO - TEST-OK | v8_7 | took 39936ms 11:13:41 INFO - SUITE-END | took 1209s 11:13:41 INFO - Completed test suite (00:20:09) 11:13:41 INFO - Working with test: dromaeo_css 11:13:41 INFO - Generating results file: dromaeo_css 11:13:41 INFO - Working with test: kraken 11:13:41 INFO - Generating results file: kraken 11:13:41 INFO - javascript benchmark 11:13:41 INFO - Working with test: v8_7 11:13:41 INFO - Generating results file: v8_7 11:13:41 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:13:41 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 11:13:41 INFO - process_Request line: dromaeo_css 6799.97 graph.html#tests=[[72,64,43]] 11:13:41 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:13:41 INFO - process_Request line: kraken 1528.60 graph.html#tests=[[232,64,43]] 11:13:41 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:13:41 INFO - process_Request line: v8_7 21243.72 graph.html#tests=[[230,64,43]] 11:13:41 INFO - RETURN: dromaeo_css: 6799.97 11:13:41 INFO - RETURN: kraken: 1528.60 11:13:41 INFO - RETURN: v8_7: 21243.72 11:13:41 INFO - javascript benchmark 11:13:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3148.5749423827783, 3194.568733221016, 3227.951580726288, 3238.109519882032, 3238.8380580970947, 5286.471352864722, 5321.760520776565, 5396.136618141099, 5402.540784033357, 5407.459254074595, 5326.147816349385, 5328.20076988451, 5328.680279183242, 5332.520073193412, 5337.866553336168, 4745.738984355868, 4885.682430642015, 4901.240307752304, 4987.750612469362, 5008.073506401327, 4918.950810491903, 4992.850214493553, 5005.5995520358465, 5005.724685142316, 5039.370078740158, 823.4069278301844, 4901.338319326881, 4912.066707325596, 4924.630652701044, 4958.132326842788, 4945.901081978376, 4961.404631444214, 4963.280324352984, 4965.602751779849, 5013.222950442687, 4969.105560999019, 4986.202207646759, 5006.4492905780335, 5019.799208031674, 5081.644284900059, 5085.542301192911, 5157.535821776059, 5204.76578553966, 5221.791128354861, 5262.131748261532, 5774.82675519735, 5806.0, 5824.708764561798, 5826.388229235954, 5829.300483941912, 5755.769769209227, 5865.912011319833, 5871.383504731984, 5880.4119588041285, 5890.145928840294, 5285.603579731497, 5308.628396012242, 5404.189371594292, 5414.0, 5444.292242008553, 5918.408159184133, 5965.612235204698, 5966.552508561876, 5969.015112506475, 5981.282246130492, 5615.691136987423, 5667.914981275284, 5692.57305702074, 5711.514521265656, 5725.255716756795, 5767.336756272998, 5850.063989761703, 5865.0, 5869.383714709894, 5903.675297858573, 5794.159846822272, 5827.067669172912, 5829.76680932758, 5842.269716285465, 5844.094165404369, 5458.536024437888, 5549.778008879681, 5825.0388685866355, 5829.708514574254, 5829.854253643693, 4462.286034234507, 4528.818847246139, 4544.159330523864, 4567.018091110427, 4585.037142200175, 3965.5439624442984, 3973.5231772186944, 3974.960250397517, 3992.0419099416513, 4016.1566071124807, 5272.393674727378, 5289.259503669489, 5392.379876314196, 5394.298741163702, 5461.344638643309, 5742.827715168552, 5744.224529688522, 5754.367019627837, 5771.422857714195, 5799.420057994251, 5364.544013758796, 5388.973055134699, 5397.055515284809, 5411.9729401353525, 5418.106012507971, 4842.951570484321, 4843.055604157226, 4914.140025495595, 4945.381827271591, 4955.157623204064, 5988.9101663475085, 6002.09968504719, 6013.218281623361, 6017.458428741435, 6028.57799953999, 5737.627054241461, 5757.0788673811985, 5780.624259423124, 5782.537397008314, 5789.942100579109, 5966.403359663999, 5995.310539288038, 6065.696715164136, 6098.634081955097, 6113.174721412553, 5674.829755107354, 5675.801346952837, 5680.630759000652, 5686.971565142313, 5687.630304030225, 5762.463197755743, 5774.797882074107, 5783.7397317119985, 5792.797252096157, 5801.042827933513, 5645.491905728504, 5681.119426488901, 5756.395578464201, 5758.337791153904, 5812.738426770721, 5689.1750696148, 5704.885902281848, 5715.399883012224, 5716.342620598684, 5731.770729170787, 5465.07093794048, 5580.972095139498, 5611.438856114356, 5627.521660658726, 5631.915521267102, 5577.219189313419, 5641.633293835887, 5650.971745141248, 5653.067243904874, 5665.575081868794, 5481.643693159932, 5491.2312276282155, 5497.0, 5503.917441238465, 5521.861953451196], "unit": "score", "name": "dojo.html", "value": 5305.917718857843}, {"lowerIsBetter": false, "replicates": [512.9846104616859, 543.5189856976574, 581.3895409819688, 596.3231731984199, 599.0534954771462, 27844.164675059754, 35615.10962225942, 35933.64066359335, 36002.63997360026, 36084.09789755254, 39051.21897562054, 39453.0, 39498.40752388717, 39526.209475810465, 39654.801725991405, 8433.114522975091, 8440.535770532602, 8557.700480483185, 8565.614547345353, 8606.31149508038, 8361.749147525585, 8428.620712067972, 8505.76666383374, 8508.31933445326, 8549.358798090168, 8491.872621910645, 8532.36007299452, 8561.48631082134, 8571.185737354972, 8586.0, 8327.750167494985, 8412.789680258013, 8463.873041904377, 8503.82992340156, 8521.744347669579, 8312.83374332516, 8444.535550544717, 8505.659773609048, 8509.74470765878, 8669.739907802714, 38632.61367386347, 38652.613473865465, 38697.22605547901, 38955.61044389576, 39109.41335879964, 3191.138392633999, 3508.7368447366293, 3543.3976224041976, 3714.628537146291, 3951.920961580752, 28560.571591426145, 28920.855395723098, 29423.852880735674, 29442.263943401587, 29623.70376296231, 3726.3851464508325, 3766.7551609145316, 3804.7907365094907, 3869.7484663497066, 3875.4380614810693, 257556.99999999814, 258772.0, 260166.0, 261458.0, 261721.0, 56440.0, 57112.71443642838, 57379.0, 57423.71288143533, 57468.71265643729, 61661.0, 64224.357756422774, 65573.34426655673, 65597.0, 65626.34373656298, 14123.929380353033, 14233.715325693429, 14318.928405357907, 14319.85680143206, 14323.856761432253, 10599.0, 10649.520771565298, 10673.41296228715, 10696.41169735672, 10703.732406689895, 19733.703994440093, 19909.601807963758, 19925.501862453555, 20044.398668039983, 20088.296909608092, 8012.839743205103, 8111.026676798822, 8168.305694016075, 8195.918040819635, 8225.0, 903.8779764731677, 936.6066252174103, 1018.3940555369543, 1043.337480699746, 1058.5554067291755, 26497.205083847515, 26842.32894177622, 27147.728522714915, 27285.0, 27366.726332736816, 1010.0959641121156, 1020.6172685243034, 1053.947302634865, 1108.9279196852178, 1176.5293882446917, 13840.723185536233, 13961.092528985584, 14109.365078571283, 14457.493987710379, 14478.927605361905, 310302.0, 311475.0, 316174.0, 316813.0, 317225.0, 51345.486545134074, 51711.0, 51820.48179518232, 51832.48167518277, 52044.739776301634, 1302.1340808362522, 1304.478208716502, 1310.0960337367187, 1313.1923866821835, 1314.9868501314863, 25828.741712582632, 25979.0, 26097.869510652326, 26459.338516537242, 26546.734532654427, 45265.0, 45518.77240613776, 45627.0, 45791.313130302406, 45898.31152532648, 286895.0, 287816.0, 287887.0, 288679.0, 289581.0, 32332.83833580817, 41582.29715068511, 42401.57598423976, 42626.78686606547, 42755.78622106994, 38920.41619375768, 39659.405108923966, 39899.2020159601, 40113.598864010986, 40137.598624013386, 33776.32447351088, 33815.83092084524, 34078.0, 34091.318173636886, 34642.65357346394, 34202.553668023, 34550.481742774384, 35767.28465430729, 36500.63499365078, 36918.815405922796, 35515.644843551236, 35704.64295357013, 35774.46338304875, 37529.62470375261, 38003.809980951024, 28720.28199294951, 30663.0, 31276.530852036783, 31439.37121257608, 31515.369692606477, 24033.639495407235, 26465.603015955163, 26560.335991599593, 26789.0, 26794.59808102841], "unit": "score", "name": "ext.html", "value": 18159.186479169795}, {"lowerIsBetter": false, "replicates": [339.4467018759423, 343.0565943654949, 346.2400031929913, 346.3540496973145, 349.58574089703694, 16280.185990700462, 16414.917925410373, 17198.484045478657, 17778.555536111588, 18050.4584862454, 14403.0, 15119.546413607583, 15337.69324613507, 15340.69318613627, 16161.83838161618, 4740.928886066712, 4822.638302127337, 4845.176320025604, 4845.2247640377545, 4854.0, 4839.975800120995, 4849.296851956464, 4867.780949857265, 4871.537203965618, 4879.804807807701, 4847.6121910247275, 5076.162433198518, 5225.843224703265, 5320.441353657869, 5330.28041214435, 5106.948930510722, 5114.462981386938, 5180.870478238036, 5186.1442861927735, 5194.818181363653, 5013.674111182761, 5229.111051121318, 5245.924585459971, 5278.313819203518, 5288.68267903927, 18601.0, 18752.81247187538, 18848.434546963614, 19132.139053742616, 19165.425037248904, 2149.1510853212894, 2151.8278537716947, 2154.353693891826, 2224.4994876152896, 2258.119333459952, 9140.131687489678, 9214.078592140731, 9350.485723285217, 11776.705582360424, 12577.0, 1801.3425099838596, 1843.0203676105316, 1850.4448665400325, 1856.9535761605932, 1863.9254429822927, 58566.9009369156, 60906.390936090516, 61663.0, 61907.690461547405, 61962.76074478485, 9855.359401639014, 9928.602855885683, 10031.648892288735, 10065.647702330383, 10098.495075246208, 13088.149270297401, 13115.475380984844, 13216.603501894959, 13258.801117983237, 13302.667433314244, 6916.308369163044, 6925.549839260532, 6948.478864085214, 6978.930210697929, 6993.300669932966, 6442.162518872517, 6466.967665161738, 6479.8056058318325, 6555.6066636002, 6555.770548030891, 4208.473940757405, 4217.481706585627, 4224.441482483552, 4238.745675259494, 4275.3800698898485, 1772.7075032619732, 1815.0, 1823.3253696132251, 1828.5337239003968, 1841.8802777819399, 425.1263653192719, 426.47543521468765, 436.54163128715356, 443.23099422501934, 918.7611221082433, 9878.901210987942, 10118.443485608215, 10172.796544069077, 10218.693439196835, 10352.585896564204, 423.71399305468685, 426.47543521468145, 432.049491119532, 432.2543612268874, 433.0797056255457, 5592.384837667853, 5690.146478028246, 5744.971275143681, 5756.107803290497, 5804.912926306109, 520270.0, 523154.0, 536555.0, 547634.0, 550253.0, 40513.18973620511, 72050.9192362115, 72625.0, 78559.60720196362, 79973.60013199897, 1159.3855256713787, 1166.3701601135463, 1189.5479717707217, 1198.1253684809963, 1224.1736827641307, 15712.764308535152, 15778.763318550002, 15969.0, 16019.35922563131, 16190.352385904433, 21210.0, 31213.37573248477, 35030.64969350274, 35543.46684799782, 36031.099222519646, 45923.77038114788, 45994.0, 47168.292475613576, 48906.0, 49829.0, 8931.106889311017, 8935.597898094471, 9022.458652480873, 9043.954780226057, 9126.954365228132, 15900.68198636044, 16266.918665406598, 16317.673646526766, 17555.82444175593, 17559.507441867583, 11013.033204949534, 13213.603591891873, 13641.181529108286, 13880.722385552433, 13981.091229070078, 13081.803772943604, 13504.392302346221, 13743.793843092162, 14229.644258893197, 14290.42838286457, 13734.45062197501, 13878.236696981763, 14123.43506259738, 14282.285885705465, 14410.927945360625, 8892.77768055778, 9026.277897768032, 9141.908580914105, 9259.76850578741, 9430.0, 12946.546870859474, 12955.157914735511, 12977.545785897448, 13710.65723356924, 14107.435702571782], "unit": "score", "name": "jquery.html", "value": 8062.044437808385}, {"lowerIsBetter": false, "replicates": [1401.6495876030992, 1408.43662534986, 1529.4111766969713, 1702.608400067985, 1727.6458326043162, 6613.834654133649, 6734.090897728805, 6990.196127445345, 7082.220955694876, 7109.6089715065655, 6814.420774234183, 7050.717971281156, 7190.388816950553, 7209.927900721004, 7250.927490725091, 2148.205164089289, 2219.6670499425136, 2224.510607666311, 2234.9888250558724, 2237.4853783629774, 2203.6914831923546, 2230.275160572812, 2253.2902135827244, 2253.876036817974, 2258.1983395894467, 2179.574982878339, 2179.7384313882358, 2200.4168895242774, 2209.591225623257, 2212.2478357358495, 2172.348295511348, 2180.5202855371795, 2200.3288996855954, 2205.889705514726, 2211.9778802212013, 2173.261091228974, 2214.302494714176, 2227.599032174208, 2229.119497798377, 2231.364061242538, 7299.598522081284, 7315.707371705125, 7320.743773967885, 7374.0, 7390.3718183954425, 4367.628751556122, 4403.141387429452, 4436.600705936481, 4467.620252278561, 4484.775761211959, 2862.8997985070423, 2962.244627619943, 2970.2425881400322, 2975.866086026134, 2992.9551056734167, 912.9908700913039, 922.1378011559146, 922.4834092907993, 924.2513564013171, 966.1063516247443, 9715.951420242924, 9762.609495620167, 9765.853512197322, 9769.951150244204, 9789.853152202722, 3909.843606255775, 3951.269015232191, 3973.7019723520275, 3992.7803970781306, 4002.199560087936, 8339.791505212419, 8384.496930184208, 8408.747737567883, 8425.45234559764, 8435.283000944866, 4433.512313645561, 4445.644348452181, 4453.4433195850515, 4458.910821783546, 4462.620677242406, 3954.9011274718364, 4082.2039702258367, 4101.610347017028, 4132.318167502389, 4154.376843473503, 3210.5184222366834, 3226.790258633181, 3251.7561182911377, 3265.151060724229, 3267.967320326814, 1027.3271007490107, 1034.534459493231, 1037.896210378956, 1039.3971496531992, 1042.020500729312, 1039.1998161415668, 1250.93745312734, 1298.9415476303589, 1317.328162637062, 1321.7620828250815, 7035.296470352924, 7052.153741551047, 7060.6116663584, 7077.433805295564, 7082.575045497184, 450.14247857830884, 451.5913098645731, 456.9497355290915, 463.4947906781624, 465.05593644900904, 5598.944010559842, 5628.240187574625, 5636.18275350072, 5656.349519805275, 5706.400827913092, 8625.52559609215, 9018.684346047858, 9081.863772043425, 9092.727218183465, 9149.085091490932, 8830.381873268938, 8839.646414143363, 8899.466032038099, 8964.641414343354, 9002.684906028258, 6812.250652428229, 6991.825204369829, 7033.788986330418, 7037.437005039687, 7039.190493093258, 6894.482913781386, 6915.965420172867, 6959.7216111357, 6964.721411143498, 6964.79105626832, 7750.7674769756995, 7956.2043795619975, 8011.118776934416, 8019.1579884111325, 8136.877946830684, 8022.358211342962, 8182.590870456334, 8216.589170541569, 8349.206825351583, 8358.0, 5824.184614154106, 5938.910916336172, 6317.778877739257, 6422.165118534561, 6575.638339891352, 7015.789526314219, 7029.332213439715, 7084.752033678797, 7103.1476222851525, 7121.359077683033, 6430.164078669743, 6586.70359833799, 6610.636414997221, 6780.660966951731, 6886.311368863074, 6493.902591461227, 6618.6690665467495, 6655.668866226871, 6705.731770729311, 6758.918573028292, 6702.564333318319, 6745.561538499982, 6764.5603035802515, 6831.760888368884, 6841.0, 6269.0, 6318.6840657965995, 6353.301136875032, 6377.553571249968, 6428.55000149985, 6279.780207692709, 6325.620462772248, 6347.619142851444, 6352.205974253218, 6373.490120790419], "unit": "score", "name": "mootools.html", "value": 4174.8946482232595}, {"lowerIsBetter": false, "replicates": [324.3383497664764, 331.8274497261424, 333.8981610608765, 334.22126445382264, 337.6100603802609, 6264.123022776815, 6283.560150789446, 6291.559590828644, 6304.464120549753, 6377.170967774195, 6175.413335733109, 6183.907241391383, 6209.2859321178075, 6230.376962303767, 6240.84397890053, 4697.154512187805, 4697.812087516495, 4701.78841952113, 4708.176069187878, 4708.811647534095, 4715.646326525507, 4716.599089077433, 4718.079974404993, 4719.221328480814, 4730.053989202156, 4473.329000649896, 4568.908621827562, 4612.400387949562, 4648.558386953251, 4665.253559430492, 4597.218472859622, 4614.792334344946, 4634.0500197459605, 4636.652251081183, 4638.46657634373, 4024.6981476389387, 4043.3328500797334, 4050.8379664813374, 4055.71609987301, 4067.1662309226535, 5897.587168898179, 5920.111983202511, 5939.227900372924, 5942.197803296543, 5949.107633854913, 5231.738413079331, 5378.91931621026, 5394.595405344576, 5448.91826622601, 5457.263269458612, 6544.5746026508605, 6561.277070015938, 6566.606003639749, 6570.901436478457, 6572.07990881277, 4400.647948164139, 4418.955810441887, 4420.8452704155525, 4431.313146462304, 4434.933475997863, 6753.3921947025, 6823.078884350648, 6842.486813488958, 6879.346462086144, 6889.415434450055, 4565.086982603492, 4572.748498832596, 4574.4739354973935, 4574.8791546071425, 4579.107074120581, 4598.88502787433, 4631.444226692751, 4632.2125238709505, 4638.512956139624, 4641.466231383434, 5384.757685904144, 5386.353637563439, 5387.138057910715, 5396.9730151348995, 5398.0, 6458.192725909262, 6554.14796076507, 6596.0, 6608.306127856602, 6636.270010298863, 1616.3938523053855, 1629.193549193157, 1631.2659303313555, 1631.4208455998187, 1632.6244963658426, 1054.2514814481651, 1059.6397224943555, 1064.5528877871313, 1069.9572017119228, 1079.2607064161075, 6241.157443745127, 6252.374762523711, 6281.309056003836, 6285.622862628257, 6289.874202516015, 6763.898541521881, 6789.6605169741315, 6815.829604259933, 6827.351401616838, 6848.315168483112, 6127.938720612826, 6244.906326405107, 6257.499400047986, 6282.685865706696, 6315.273743519462, 3718.9442158367647, 3736.4021756518828, 3741.869034583831, 3753.0429740416566, 3761.6990640748672, 7212.8918066228, 7234.348908598251, 7246.492745507764, 7248.130224373109, 7258.383037441771, 6959.234484206733, 7097.7160913562875, 7103.112110986127, 7108.36024757764, 7118.60847653384, 7184.46116541251, 7200.459965502609, 7209.495335326476, 7212.639368031578, 7228.783136505808, 6853.143357080365, 6883.483738719716, 6899.6205208714, 6902.102726645504, 6904.689288982108, 6651.26836048044, 6746.69639866217, 6764.695588698619, 6794.456443484608, 6816.556923799937, 7203.279672032755, 7228.4940054197805, 7229.891551626624, 7243.818904527429, 7260.201377848327, 4527.683062185615, 4596.494385617646, 4597.494275629745, 4603.700759450625, 4611.815527378867, 6809.2509823918335, 6903.827404314932, 6931.272216417204, 6988.860222795414, 6998.0, 6680.933190668031, 6713.899291510729, 6722.831929201809, 6733.663316834237, 6735.528513004043, 6521.967390163209, 6670.099536562696, 6710.530262881747, 6727.26000139994, 6730.394264516217, 6549.0, 6555.2133743949125, 6561.1470508835455, 6564.212294524687, 6566.770163044271, 6702.162229721285, 6716.361945615159, 6717.596944183365, 6735.326467353226, 6746.4265537429865, 6410.839729006626, 6450.709718062604, 6500.414962653384, 6519.706613202512, 6532.118164047983], "unit": "score", "name": "prototype.html", "value": 4953.018723096114}, {"lowerIsBetter": false, "replicates": [772.208486301541, 815.6207363575936, 848.1518481518482, 851.3317046118798, 877.8332116897793, 13308.866911330908, 13373.531926382579, 13400.93299533501, 13484.393202305895, 13504.932475337622, 12249.081318901095, 12319.938400308009, 12335.444904979275, 12348.629541113758, 12464.750704985894, 655.7245956698198, 666.6333516565894, 794.2057942057942, 800.383704547501, 810.8094597769519, 805.9435839491238, 808.8584497712877, 813.5240884082818, 813.9552324622143, 816.8815521749343, 852.3436953545767, 857.6140736668493, 858.5149390594325, 861.530465896085, 861.5562985062697, 849.4478588917223, 852.4160949749441, 852.846487632226, 852.9147085291484, 853.4580541356283, 614.6189362595175, 617.129846915851, 622.5206590924962, 623.2583225961137, 625.8560531077832, 13337.066405351628, 13548.390322435514, 13571.524996625169, 13572.864271357259, 13589.796153057712, 11988.64034078979, 12073.879261207363, 12102.939485302517, 12280.815787763191, 12469.875301246962, 9701.126898579161, 9775.266854985834, 9787.510624468749, 9792.804143917154, 9814.165795907356, 3483.5297234873474, 3510.5260789793306, 3529.364714351416, 3534.964650353515, 3729.1236559408517, 45842.77078614619, 45945.770271148765, 46174.76912615449, 46234.53765462336, 46302.53697463016, 9890.456024918554, 10251.58993640246, 10253.384796912209, 10390.58437662485, 10393.220508461896, 18765.0, 18808.529786755167, 18810.0, 18849.81150188508, 18855.151518181716, 7433.070866141732, 7636.847263054708, 7725.343345815669, 7775.533467991939, 7799.259070388418, 4230.323148296319, 4251.107267473865, 4274.529801721808, 4277.486701595828, 4300.204462174508, 3066.9079927602206, 3075.1543325585644, 3084.9691503085132, 3085.460044492205, 3113.377324535102, 522.6576592332028, 537.3632245788752, 547.6686604604157, 547.8657728856376, 553.8006317725616, 461.1445768100193, 521.6140056358344, 541.8374487653767, 593.0866465642862, 620.7238472979673, 8250.216229458192, 8404.705835295736, 8655.567221638892, 8905.777355566162, 8920.955395222982, 453.32454642582314, 552.6242155334411, 594.3551246897165, 607.4472230270433, 623.3392603839853, 3729.9440508392395, 3783.0, 3801.353769859131, 3814.370628846265, 3901.51231096113, 51821.74089129605, 52502.73748631309, 57231.0, 57358.0, 57435.71282143563, 47101.764491177324, 48477.51522484801, 49050.264246036335, 49789.751051244515, 51081.0, 44576.33135503035, 45328.54671453243, 45337.54662453399, 45376.0, 45803.541964580596, 7701.653425595974, 8090.83818323642, 8387.790305242417, 8396.87404688918, 8896.243819275434, 34035.65964340325, 34479.0, 34735.30529389449, 35050.649493505756, 35383.11542211465, 43406.22531521593, 43428.34857477203, 44005.0, 44096.55903441053, 44243.77878110589, 10819.18856085781, 10934.507947142556, 10952.34285942846, 11031.724206894893, 11077.612283570037, 11891.464884080064, 11977.461014254553, 12050.397480126134, 12084.335361555199, 12451.315177665316, 11011.0, 11050.778984420427, 11326.660200193677, 11444.542218311175, 11731.120165987415, 10822.945885270523, 11087.39019353911, 11165.49755260999, 11507.309561426342, 11656.30062196271, 10220.948895255477, 10473.581056757645, 10794.0, 10887.673369798918, 11257.774844503228, 9029.311608473881, 9246.214071803972, 9299.86050209261, 9554.61781528731, 9936.652217172365, 8689.217970382695, 8701.17338852808, 8757.299416046573, 9256.398334108262, 9449.811003780023], "unit": "score", "name": "yui.html", "value": 6154.421988322393}], "name": "dromaeo_css", "value": 6799.974085333979}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 106.0, 111.0, 111.0, 111.0, 121.0, 110.0, 110.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [149.0, 127.0, 156.0, 164.0, 133.0, 154.0, 152.0, 127.0, 176.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 146.6}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 163.0, 164.0, 164.0, 162.0, 162.0, 167.0, 168.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 74.0, 75.0, 76.0, 73.0, 137.0, 71.0, 72.0, 75.0], "unit": "score", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 149.0, 96.0, 95.0, 96.0, 134.0, 96.0, 96.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [109.0, 111.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [150.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 63.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 62.0], "unit": "score", "name": "json-parse-financial", "value": 63.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [85.0, 92.0, 85.0, 85.0, 98.0, 84.0, 87.0, 86.0, 89.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.8}, {"lowerIsBetter": true, "replicates": [123.0, 125.0, 124.0, 128.0, 130.0, 117.0, 135.0, 124.0, 127.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.2}, {"lowerIsBetter": true, "replicates": [140.0, 152.0, 149.0, 152.0, 145.0, 150.0, 151.0, 149.0, 150.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 76.0, 70.0, 68.0, 68.0, 71.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.5}], "name": "kraken", "value": 1528.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.22408026755852], "unit": "score", "name": "Richards", "value": 211.10596}, {"lowerIsBetter": false, "replicates": [189.75332068311195], "unit": "score", "name": "DeltaBlue", "value": 348.44186000000013}, {"lowerIsBetter": false, "replicates": [281.5315315315315], "unit": "score", "name": "Encrypt", "value": 945.4749119999998}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [1058.2010582010582], "unit": "score", "name": "RayTrace", "value": 699.2896049999997}, {"lowerIsBetter": false, "replicates": [709.2198581560284], "unit": "score", "name": "Earley", "value": 939.71283}, {"lowerIsBetter": false, "replicates": [12304.878048780487], "unit": "score", "name": "Boyer", "value": 54.16250346878094}, {"lowerIsBetter": false, "replicates": [25743.589743589742], "unit": "score", "name": "RegExp", "value": 35.38686752988046}, {"lowerIsBetter": false, "replicates": [616.5228113440197], "unit": "score", "name": "Splay", "value": 132.17840199999998}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 21243.71704962951}]} 11:13:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21243.72"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1528.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6799.97"}}} 11:13:41 INFO - Return code: 0 11:13:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:13:41 INFO - # TBPL SUCCESS # 11:13:41 INFO - Running post-action listener: _resource_record_post_action 11:13:41 INFO - Running post-run listener: _resource_record_post_run 11:13:42 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 558600192; Read time: 0; Write time: 486168 11:13:42 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 238010368; Read time: 0; Write time: 258368 11:13:42 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 0; Write bytes: 320589824; Read time: 0; Write time: 227800 11:13:42 INFO - Running post-run listener: _upload_blobber_files 11:13:42 INFO - Blob upload gear active. 11:13:42 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:13:42 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 11:13:42 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'] 11:13:42 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 11:13:43 INFO - (blobuploader) - INFO - Open directory for files ... 11:13:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:13:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:13:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:13:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:13:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:13:44 INFO - (blobuploader) - INFO - Done attempting. 11:13:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:13:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:13:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:13:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:13:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:13:45 INFO - (blobuploader) - INFO - Done attempting. 11:13:45 INFO - (blobuploader) - INFO - Iteration through files over. 11:13:45 INFO - Return code: 0 11:13:45 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:13:45 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:13:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/763063a8936c65f2c6e3bc10b09f8c335df1848aa5382f52ca6289208413f43ae144644dc92829c27f7176f505879b506d8aa7bb5725c143135e74509bbbb668", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bc77962ac29690c0caf7952b165d55aad5a7700edb9a6c8f901d10e680b02750f7d3b568ec325e97787042be76aea638bf290aa253f2b73b89ea121ecc949b67"} 11:13:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:13:45 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:13:45 INFO - Contents: 11:13:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/763063a8936c65f2c6e3bc10b09f8c335df1848aa5382f52ca6289208413f43ae144644dc92829c27f7176f505879b506d8aa7bb5725c143135e74509bbbb668", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bc77962ac29690c0caf7952b165d55aad5a7700edb9a6c8f901d10e680b02750f7d3b568ec325e97787042be76aea638bf290aa253f2b73b89ea121ecc949b67"} 11:13:45 INFO - Copying logs to upload dir... 11:13:45 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1274.294727 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-05 11:13:44.838360) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 11:13:44.841819) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1452019222.38999-795687543 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/763063a8936c65f2c6e3bc10b09f8c335df1848aa5382f52ca6289208413f43ae144644dc92829c27f7176f505879b506d8aa7bb5725c143135e74509bbbb668", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bc77962ac29690c0caf7952b165d55aad5a7700edb9a6c8f901d10e680b02750f7d3b568ec325e97787042be76aea638bf290aa253f2b73b89ea121ecc949b67"} build_url:https://queue.taskcluster.net/v1/task/eg7sY77fSuu7e1mo8IvXWA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011454 build_url: 'https://queue.taskcluster.net/v1/task/eg7sY77fSuu7e1mo8IvXWA/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/763063a8936c65f2c6e3bc10b09f8c335df1848aa5382f52ca6289208413f43ae144644dc92829c27f7176f505879b506d8aa7bb5725c143135e74509bbbb668", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bc77962ac29690c0caf7952b165d55aad5a7700edb9a6c8f901d10e680b02750f7d3b568ec325e97787042be76aea638bf290aa253f2b73b89ea121ecc949b67"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 11:13:44.866952) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 11:13:44.867294) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1452019222.38999-795687543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 11:13:44.952474) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 11:13:44.952833) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 11:13:44.953185) ========= ========= Total master_lag: 0.29 =========