builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-054 starttime: 1451447309.24 results: success (0) buildid: 20151229173003 builduid: c7485194aa5f4040a0b0b223930eed9f revision: e873ef1df11f7c0538ec2dd5f53a6568c4bb7005 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:29.245234) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:29.245940) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:29.246265) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1451441964.903238-1452020180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006315 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:29.270481) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:29.270828) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:29.313050) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:29.313347) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1451441964.903238-1452020180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024185 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:29.362402) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:29.362722) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:29.363163) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:29.363498) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1451441964.903238-1452020180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-29 19:48:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.3M=0s 2015-12-29 19:48:29 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160928 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:29.538562) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:29.538882) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1451441964.903238-1452020180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.154020 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:29.705075) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:29.705472) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e873ef1df11f7c0538ec2dd5f53a6568c4bb7005 --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 e873ef1df11f7c0538ec2dd5f53a6568c4bb7005 --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=752f8c75933e5bfb3b8f10bb000001ce-1451441964.903238-1452020180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-29 19:48:29,933 truncating revision to first 12 chars 2015-12-29 19:48:29,933 Setting DEBUG logging. 2015-12-29 19:48:29,933 attempt 1/10 2015-12-29 19:48:29,933 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e873ef1df11f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-29 19:48:30,160 unpacking tar archive at: fx-team-e873ef1df11f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.522566 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:30.242601) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:30.242933) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:30.269125) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:30.269764) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 19:48:30.270264) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-29 19:48:30.270619) ========= /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=752f8c75933e5bfb3b8f10bb000001ce-1451441964.903238-1452020180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:48:30 INFO - MultiFileLogger online at 20151229 19:48:30 in /builds/slave/test-pgo 19:48:30 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 19:48:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:48:30 INFO - {'append_to_log': False, 19:48:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:48:30 INFO - 'blob_upload_branch': 'Fx-Team', 19:48:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:48:30 INFO - 'branch': 'Fx-Team', 19:48:30 INFO - 'buildbot_json_path': 'buildprops.json', 19:48:30 INFO - 'config_files': ('talos/linux_config.py',), 19:48:30 INFO - 'default_actions': ('clobber', 19:48:30 INFO - 'read-buildbot-config', 19:48:30 INFO - 'download-and-extract', 19:48:30 INFO - 'populate-webroot', 19:48:30 INFO - 'create-virtualenv', 19:48:30 INFO - 'install', 19:48:30 INFO - 'run-tests'), 19:48:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:48:30 INFO - 'download_minidump_stackwalk': True, 19:48:30 INFO - 'download_symbols': 'ondemand', 19:48:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:48:30 INFO - 'tooltool.py': '/tools/tooltool.py', 19:48:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:48:30 INFO - '/tools/misc-python/virtualenv.py')}, 19:48:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:48:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:48:30 INFO - 'installer_path': 'installer.exe', 19:48:30 INFO - 'log_level': 'info', 19:48:30 INFO - 'log_name': 'talos', 19:48:30 INFO - 'log_to_console': True, 19:48:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:48:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:48:30 INFO - 'opt_config_files': (), 19:48:30 INFO - 'pip_index': False, 19:48:30 INFO - 'sps_profile': False, 19:48:30 INFO - 'sps_profile_interval': 0, 19:48:30 INFO - 'suite': 'dromaeojs-e10s', 19:48:30 INFO - 'system_bits': '32', 19:48:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:48:30 INFO - 'title': 'talos-linux64-ix-054', 19:48:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:48:30 INFO - 'use_talos_json': True, 19:48:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:48:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:48:30 INFO - 'work_dir': 'build'} 19:48:30 INFO - ##### 19:48:30 INFO - ##### Running clobber step. 19:48:30 INFO - ##### 19:48:30 INFO - Running pre-action listener: _resource_record_pre_action 19:48:30 INFO - Running main action method: clobber 19:48:30 INFO - rmtree: /builds/slave/test-pgo/build 19:48:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:48:35 INFO - Running post-action listener: _resource_record_post_action 19:48:35 INFO - ##### 19:48:35 INFO - ##### Running read-buildbot-config step. 19:48:35 INFO - ##### 19:48:35 INFO - Running pre-action listener: _resource_record_pre_action 19:48:35 INFO - Running main action method: read_buildbot_config 19:48:35 INFO - Using buildbot properties: 19:48:35 INFO - { 19:48:35 INFO - "project": "", 19:48:35 INFO - "product": "firefox", 19:48:35 INFO - "script_repo_revision": "production", 19:48:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:48:35 INFO - "repository": "", 19:48:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 19:48:35 INFO - "buildid": "20151229173003", 19:48:35 INFO - "pgo_build": "True", 19:48:35 INFO - "basedir": "/builds/slave/test-pgo", 19:48:35 INFO - "buildnumber": 163, 19:48:35 INFO - "slavename": "talos-linux64-ix-054", 19:48:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:48:35 INFO - "platform": "ubuntu64_hw", 19:48:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:48:35 INFO - "branch": "fx-team", 19:48:35 INFO - "repo_path": "integration/fx-team", 19:48:35 INFO - "revision": "e873ef1df11f7c0538ec2dd5f53a6568c4bb7005", 19:48:35 INFO - "stage_platform": "linux64-pgo", 19:48:35 INFO - "builduid": "c7485194aa5f4040a0b0b223930eed9f", 19:48:35 INFO - "slavebuilddir": "test" 19:48:35 INFO - } 19:48:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:48:35 INFO - Running post-action listener: _resource_record_post_action 19:48:35 INFO - ##### 19:48:35 INFO - ##### Running download-and-extract step. 19:48:35 INFO - ##### 19:48:35 INFO - Running pre-action listener: _resource_record_pre_action 19:48:35 INFO - Running main action method: download_and_extract 19:48:35 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:48: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')]} 19:48:35 INFO - https://queue.taskcluster.net/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:48:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/test_packages.json 19:48:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/test_packages.json 19:48:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:48:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:48:35 INFO - Downloaded 1302 bytes. 19:48:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:48:35 INFO - Using the following test package requirements: 19:48:35 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:48:35 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:48:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:48:35 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:48:35 INFO - u'jsshell-linux-x86_64.zip'], 19:48:35 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:48:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:48:35 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:48:35 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:48:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:48:35 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:48:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:48:35 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:48:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:48:35 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:48:35 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:48:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:48:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:48: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')]} 19:48:35 INFO - https://queue.taskcluster.net/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:48:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:48:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:48:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/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 19:48:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/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 19:48:37 INFO - Downloaded 23192308 bytes. 19:48: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 19:48:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:48: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 19:48:38 INFO - Return code: 0 19:48: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 19:48: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')]} 19:48:38 INFO - https://queue.taskcluster.net/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:48:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:48:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:48:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/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 19:48:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/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 19:48:41 INFO - Downloaded 23192308 bytes. 19:48:41 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 19:48:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:48:41 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 19:48:43 INFO - Return code: 0 19:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:43 INFO - https://queue.taskcluster.net/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:48:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:48:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:48:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/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 19:48:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/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 19:48:44 INFO - Downloaded 11132270 bytes. 19:48:44 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 19:48:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:48:44 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 19:48:44 INFO - Return code: 0 19:48:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:44 INFO - https://queue.taskcluster.net/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:48:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:48:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:48:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/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 19:48:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UAvIM4l2SL6IUTky90yILg/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 19:48:46 INFO - Downloaded 54900623 bytes. 19:48:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:48:46 INFO - mkdir: /builds/slave/test-pgo/properties 19:48:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:48:46 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:48:46 INFO - Contents: 19:48:46 INFO - build_url:https://queue.taskcluster.net/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:48:46 INFO - Running post-action listener: _resource_record_post_action 19:48:46 INFO - Running post-action listener: set_extra_try_arguments 19:48:46 INFO - ##### 19:48:46 INFO - ##### Running populate-webroot step. 19:48:46 INFO - ##### 19:48:46 INFO - Running pre-action listener: _resource_record_pre_action 19:48:46 INFO - Running main action method: populate_webroot 19:48:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:48:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:48:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:48:46 INFO - '--tppagecycles', 19:48:46 INFO - '7'], 19:48:46 INFO - 'tests': ['tsvgm']}}, 19:48:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:48:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:48:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:48:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:48:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:48:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:48:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:48:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:46 INFO - 'talos_options': ['--e10s'], 19:48:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:48:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:46 INFO - 'tests': ['damp', 'tps']}, 19:48:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:46 INFO - 'talos_options': ['--e10s'], 19:48:46 INFO - 'tests': ['damp', 'tps']}, 19:48:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:48:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:48:46 INFO - 'other': {'tests': ['a11yr', 19:48:46 INFO - 'ts_paint', 19:48:46 INFO - 'tpaint', 19:48:46 INFO - 'sessionrestore', 19:48:46 INFO - 'sessionrestore_no_auto_restore']}, 19:48:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:48:46 INFO - 'tests': ['a11yr', 19:48:46 INFO - 'ts_paint', 19:48:46 INFO - 'tpaint', 19:48:46 INFO - 'sessionrestore', 19:48:46 INFO - 'sessionrestore_no_auto_restore']}, 19:48:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:48:46 INFO - 'tests': ['a11yr', 19:48:46 INFO - 'ts_paint', 19:48:46 INFO - 'tpaint', 19:48:46 INFO - 'sessionrestore', 19:48:46 INFO - 'sessionrestore_no_auto_restore']}, 19:48:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:48:46 INFO - 'tests': ['a11yr', 19:48:46 INFO - 'ts_paint', 19:48:46 INFO - 'tpaint', 19:48:46 INFO - 'sessionrestore', 19:48:46 INFO - 'sessionrestore_no_auto_restore']}, 19:48:46 INFO - 'other_l64': {'tests': ['a11yr', 19:48:46 INFO - 'ts_paint', 19:48:46 INFO - 'tpaint', 19:48:46 INFO - 'sessionrestore', 19:48:46 INFO - 'sessionrestore_no_auto_restore']}, 19:48:46 INFO - 'other_nol64': {'tests': ['a11yr', 19:48:46 INFO - 'ts_paint', 19:48:46 INFO - 'tpaint', 19:48:46 INFO - 'sessionrestore', 19:48:46 INFO - 'sessionrestore_no_auto_restore']}, 19:48:46 INFO - 'svgr': {'tests': ['tsvgx', 19:48:46 INFO - 'tsvgr_opacity', 19:48:46 INFO - 'tart', 19:48:46 INFO - 'tscrollx', 19:48:46 INFO - 'cart']}, 19:48:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:48:46 INFO - 'tests': ['tsvgx', 19:48:46 INFO - 'tsvgr_opacity', 19:48:46 INFO - 'tart', 19:48:46 INFO - 'tscrollx', 19:48:46 INFO - 'cart']}, 19:48:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:46 INFO - 'tests': ['tp5o']}, 19:48:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:46 INFO - 'talos_options': ['--e10s'], 19:48:46 INFO - 'tests': ['tp5o']}, 19:48:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:46 INFO - 'talos_options': ['--xperf_path', 19:48:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:48:46 INFO - 'tests': ['tp5n']}, 19:48:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:46 INFO - 'talos_options': ['--e10s', 19:48:46 INFO - '--xperf_path', 19:48:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:48:46 INFO - 'tests': ['tp5n']}}, 19:48:46 INFO - 'talos.zip': {'path': '', 19:48:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:48:46 INFO - Running post-action listener: _resource_record_post_action 19:48:46 INFO - ##### 19:48:46 INFO - ##### Running create-virtualenv step. 19:48:46 INFO - ##### 19:48:46 INFO - Running pre-action listener: _resource_record_pre_action 19:48:46 INFO - Running main action method: create_virtualenv 19:48:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:48:46 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 19:48:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:48:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:48:46 INFO - Using real prefix '/usr' 19:48:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:48:47 INFO - Installing distribute.............................................................................................................................................................................................done. 19:48:49 INFO - Installing pip.................done. 19:48:49 INFO - Return code: 0 19:48:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:48: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')]} 19:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48: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')]} 19:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:49 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 0x7f15734b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ee630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217f840>, '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 0x20ec6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ecb60>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1451441964.903238-1452020180', '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 19:48:49 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 19:48:49 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 19:48:49 INFO - Using env: {'DISPLAY': ':0', 19:48:49 INFO - 'HOME': '/home/cltbld', 19:48:49 INFO - 'LANG': 'en_US.UTF-8', 19:48:49 INFO - 'LANGUAGE': 'en_US:en', 19:48:49 INFO - 'LOGNAME': 'cltbld', 19:48:49 INFO - 'MAIL': '/var/mail/cltbld', 19:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:49 INFO - 'MOZ_NO_REMOTE': '1', 19:48:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:48:49 INFO - 'NO_EM_RESTART': '1', 19:48:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:48:49 INFO - 'PWD': '/builds/slave/test-pgo', 19:48:49 INFO - 'SHELL': '/bin/bash', 19:48:49 INFO - 'SHLVL': '1', 19:48:49 INFO - 'TERM': 'linux', 19:48:49 INFO - 'TMOUT': '86400', 19:48:49 INFO - 'USER': 'cltbld', 19:48:49 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451441964.903238-1452020180', 19:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:49 INFO - '_': '/tools/buildbot/bin/python'} 19:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:49 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 19:48:49 INFO - Cleaning up... 19:48:49 INFO - Return code: 0 19:48:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:48: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')]} 19:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48: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')]} 19:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:49 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 0x7f15734b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ee630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217f840>, '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 0x20ec6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ecb60>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1451441964.903238-1452020180', '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 19:48:49 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 19:48:49 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 19:48:49 INFO - Using env: {'DISPLAY': ':0', 19:48:49 INFO - 'HOME': '/home/cltbld', 19:48:49 INFO - 'LANG': 'en_US.UTF-8', 19:48:49 INFO - 'LANGUAGE': 'en_US:en', 19:48:49 INFO - 'LOGNAME': 'cltbld', 19:48:49 INFO - 'MAIL': '/var/mail/cltbld', 19:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:49 INFO - 'MOZ_NO_REMOTE': '1', 19:48:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:48:49 INFO - 'NO_EM_RESTART': '1', 19:48:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:48:49 INFO - 'PWD': '/builds/slave/test-pgo', 19:48:49 INFO - 'SHELL': '/bin/bash', 19:48:49 INFO - 'SHLVL': '1', 19:48:49 INFO - 'TERM': 'linux', 19:48:49 INFO - 'TMOUT': '86400', 19:48:49 INFO - 'USER': 'cltbld', 19:48:49 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451441964.903238-1452020180', 19:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:49 INFO - '_': '/tools/buildbot/bin/python'} 19:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:49 INFO - Downloading/unpacking psutil>=0.7.1 19:48:49 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 19:48:49 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 19:48:49 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 19:48:49 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 19:48:49 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 19:48:49 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 19:48:51 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:48:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:48:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:48:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:48:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:48:51 INFO - Installing collected packages: psutil 19:48:51 INFO - Running setup.py install for psutil 19:48:51 INFO - building 'psutil._psutil_linux' extension 19:48:51 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 19:48:51 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 19:48:51 INFO - building 'psutil._psutil_posix' extension 19:48:51 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 19:48:51 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 19:48:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:48:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:48:51 INFO - Successfully installed psutil 19:48:51 INFO - Cleaning up... 19:48:51 INFO - Return code: 0 19:48:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:48:51 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')]} 19:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:51 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')]} 19:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:51 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 0x7f15734b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ee630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217f840>, '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 0x20ec6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ecb60>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1451441964.903238-1452020180', '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 19:48:51 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 19:48:51 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 19:48:51 INFO - Using env: {'DISPLAY': ':0', 19:48:51 INFO - 'HOME': '/home/cltbld', 19:48:51 INFO - 'LANG': 'en_US.UTF-8', 19:48:51 INFO - 'LANGUAGE': 'en_US:en', 19:48:51 INFO - 'LOGNAME': 'cltbld', 19:48:51 INFO - 'MAIL': '/var/mail/cltbld', 19:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:51 INFO - 'MOZ_NO_REMOTE': '1', 19:48:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:48:51 INFO - 'NO_EM_RESTART': '1', 19:48:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:48:51 INFO - 'PWD': '/builds/slave/test-pgo', 19:48:51 INFO - 'SHELL': '/bin/bash', 19:48:51 INFO - 'SHLVL': '1', 19:48:51 INFO - 'TERM': 'linux', 19:48:51 INFO - 'TMOUT': '86400', 19:48:51 INFO - 'USER': 'cltbld', 19:48:51 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451441964.903238-1452020180', 19:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:51 INFO - '_': '/tools/buildbot/bin/python'} 19:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:48:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:48:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:48:53 INFO - Installing collected packages: mozsystemmonitor 19:48:53 INFO - Running setup.py install for mozsystemmonitor 19:48:53 INFO - Successfully installed mozsystemmonitor 19:48:53 INFO - Cleaning up... 19:48:53 INFO - Return code: 0 19:48:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:48: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')]} 19:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48: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')]} 19:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48: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', '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 0x7f15734b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ee630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217f840>, '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 0x20ec6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ecb60>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1451441964.903238-1452020180', '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 19:48: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:48: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 blobuploader==1.2.4 19:48:53 INFO - Using env: {'DISPLAY': ':0', 19:48:53 INFO - 'HOME': '/home/cltbld', 19:48:53 INFO - 'LANG': 'en_US.UTF-8', 19:48:53 INFO - 'LANGUAGE': 'en_US:en', 19:48:53 INFO - 'LOGNAME': 'cltbld', 19:48:53 INFO - 'MAIL': '/var/mail/cltbld', 19:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:53 INFO - 'MOZ_NO_REMOTE': '1', 19:48:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:48:53 INFO - 'NO_EM_RESTART': '1', 19:48:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:48:53 INFO - 'PWD': '/builds/slave/test-pgo', 19:48:53 INFO - 'SHELL': '/bin/bash', 19:48:53 INFO - 'SHLVL': '1', 19:48:53 INFO - 'TERM': 'linux', 19:48:53 INFO - 'TMOUT': '86400', 19:48:53 INFO - 'USER': 'cltbld', 19:48:53 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451441964.903238-1452020180', 19:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:53 INFO - '_': '/tools/buildbot/bin/python'} 19:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:54 INFO - Downloading/unpacking blobuploader==1.2.4 19:48: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 19:48: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 19:48: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 19:48: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 19:48: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 19:48: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 19:48:55 INFO - Downloading blobuploader-1.2.4.tar.gz 19:48:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:48:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:48:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:48:55 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 19:48:55 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 19:48:55 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 19:48:55 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 19:48:55 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 19:48:55 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 19:48:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:48:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:48:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:48: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 19:48: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 19:48: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 19:48: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 19:48: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 19:48: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 19:48:56 INFO - Downloading docopt-0.6.1.tar.gz 19:48:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:48:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:48:56 INFO - Installing collected packages: blobuploader, requests, docopt 19:48:56 INFO - Running setup.py install for blobuploader 19:48:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:48:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:48:56 INFO - Running setup.py install for requests 19:48:56 INFO - Running setup.py install for docopt 19:48:57 INFO - Successfully installed blobuploader requests docopt 19:48:57 INFO - Cleaning up... 19:48:57 INFO - Return code: 0 19:48:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:48:57 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')]} 19:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:57 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')]} 19:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:57 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 0x7f15734b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ee630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217f840>, '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 0x20ec6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ecb60>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1451441964.903238-1452020180', '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 19:48:57 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 19:48:57 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 19:48:57 INFO - Using env: {'DISPLAY': ':0', 19:48:57 INFO - 'HOME': '/home/cltbld', 19:48:57 INFO - 'LANG': 'en_US.UTF-8', 19:48:57 INFO - 'LANGUAGE': 'en_US:en', 19:48:57 INFO - 'LOGNAME': 'cltbld', 19:48:57 INFO - 'MAIL': '/var/mail/cltbld', 19:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:57 INFO - 'MOZ_NO_REMOTE': '1', 19:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:48:57 INFO - 'NO_EM_RESTART': '1', 19:48:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:48:57 INFO - 'PWD': '/builds/slave/test-pgo', 19:48:57 INFO - 'SHELL': '/bin/bash', 19:48:57 INFO - 'SHLVL': '1', 19:48:57 INFO - 'TERM': 'linux', 19:48:57 INFO - 'TMOUT': '86400', 19:48:57 INFO - 'USER': 'cltbld', 19:48:57 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451441964.903238-1452020180', 19:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:57 INFO - '_': '/tools/buildbot/bin/python'} 19:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:48:57 INFO - Running setup.py (path:/tmp/pip-ShZ_68-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:48:57 INFO - Running setup.py (path:/tmp/pip-77Nd1Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:48:57 INFO - Running setup.py (path:/tmp/pip-A3NbQB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:48:57 INFO - Running setup.py (path:/tmp/pip-UNwm9w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:48:57 INFO - Running setup.py (path:/tmp/pip-XQQ6MP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:48:57 INFO - Running setup.py (path:/tmp/pip-GNQtyM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:48:57 INFO - Running setup.py (path:/tmp/pip-BIxG1_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:48:57 INFO - Running setup.py (path:/tmp/pip-umscRo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:48:57 INFO - Running setup.py (path:/tmp/pip-Uidj0L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:48:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:48:57 INFO - Running setup.py (path:/tmp/pip-a7JVpE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:48:58 INFO - Running setup.py (path:/tmp/pip-l4nnir-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:48:58 INFO - Running setup.py (path:/tmp/pip-7CCSDq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:48:58 INFO - Running setup.py (path:/tmp/pip-N1vPYw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:48:58 INFO - Running setup.py (path:/tmp/pip-QZWKQX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:48:58 INFO - Running setup.py (path:/tmp/pip-CsdLTb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:48:58 INFO - Running setup.py (path:/tmp/pip-29T5gm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:48:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:48:58 INFO - Running setup.py (path:/tmp/pip-SqBwHF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:48:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:48:58 INFO - Running setup.py install for manifestparser 19:48:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:48:58 INFO - Running setup.py install for mozcrash 19:48:58 INFO - Running setup.py install for mozdebug 19:48:58 INFO - Running setup.py install for mozdevice 19:48:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:48:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:48:58 INFO - Running setup.py install for mozfile 19:48:59 INFO - Running setup.py install for mozhttpd 19:48:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:48:59 INFO - Running setup.py install for mozinfo 19:48:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:48:59 INFO - Running setup.py install for mozInstall 19:48:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:48:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:48:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:48:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:48:59 INFO - Running setup.py install for mozleak 19:48:59 INFO - Running setup.py install for mozlog 19:48:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:48:59 INFO - Running setup.py install for moznetwork 19:48:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:48:59 INFO - Running setup.py install for mozprocess 19:48:59 INFO - Running setup.py install for mozprofile 19:48:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:48:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:48:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:48:59 INFO - Running setup.py install for mozrunner 19:48:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:48:59 INFO - Running setup.py install for mozscreenshot 19:49:00 INFO - Running setup.py install for moztest 19:49:00 INFO - Running setup.py install for mozversion 19:49:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:49:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:49:00 INFO - Cleaning up... 19:49:00 INFO - Return code: 0 19:49:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:00 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 0x7f15734b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ee630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217f840>, '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 0x20ec6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ecb60>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1451441964.903238-1452020180', '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 19:49:00 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 19:49:00 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 19:49:00 INFO - Using env: {'DISPLAY': ':0', 19:49:00 INFO - 'HOME': '/home/cltbld', 19:49:00 INFO - 'LANG': 'en_US.UTF-8', 19:49:00 INFO - 'LANGUAGE': 'en_US:en', 19:49:00 INFO - 'LOGNAME': 'cltbld', 19:49:00 INFO - 'MAIL': '/var/mail/cltbld', 19:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:00 INFO - 'MOZ_NO_REMOTE': '1', 19:49:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:00 INFO - 'NO_EM_RESTART': '1', 19:49:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:00 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:00 INFO - 'SHELL': '/bin/bash', 19:49:00 INFO - 'SHLVL': '1', 19:49:00 INFO - 'TERM': 'linux', 19:49:00 INFO - 'TMOUT': '86400', 19:49:00 INFO - 'USER': 'cltbld', 19:49:00 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451441964.903238-1452020180', 19:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:00 INFO - '_': '/tools/buildbot/bin/python'} 19:49:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:49:00 INFO - Running setup.py (path:/tmp/pip-wBPBha-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:49:00 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)) 19:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:49:00 INFO - Running setup.py (path:/tmp/pip-LW2aD_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:49:00 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)) 19:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:49:00 INFO - Running setup.py (path:/tmp/pip-n0Lf1f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:49:00 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)) 19:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:49:00 INFO - Running setup.py (path:/tmp/pip-TXzrKx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:49:00 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)) 19:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:49:00 INFO - Running setup.py (path:/tmp/pip-wArLMX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:49:00 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)) 19:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:49:00 INFO - Running setup.py (path:/tmp/pip-QcArsH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:49:00 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)) 19:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:49:00 INFO - Running setup.py (path:/tmp/pip-Je0BPX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:49:00 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)) 19:49:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:49:01 INFO - Running setup.py (path:/tmp/pip-umoggx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:49:01 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)) 19:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:49:01 INFO - Running setup.py (path:/tmp/pip-y20t96-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:49:01 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)) 19:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:49:01 INFO - Running setup.py (path:/tmp/pip-Z59vhh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:49:01 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)) 19:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:49:01 INFO - Running setup.py (path:/tmp/pip-5ULWlp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:49:01 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)) 19:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:49:01 INFO - Running setup.py (path:/tmp/pip-UrM3FR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:49:01 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)) 19:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:49:01 INFO - Running setup.py (path:/tmp/pip-KyKKFd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:49:01 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)) 19:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:49:01 INFO - Running setup.py (path:/tmp/pip-pRXLWL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:49:01 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)) 19:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:49:01 INFO - Running setup.py (path:/tmp/pip-yrYVqa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:49:01 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)) 19:49:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:49:02 INFO - Running setup.py (path:/tmp/pip-vY0Olq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:49:02 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)) 19:49:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:49:02 INFO - Running setup.py (path:/tmp/pip-N8Qvhm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:49:02 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)) 19:49:02 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)) 19:49:02 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)) 19:49:02 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)) 19:49:02 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)) 19:49:02 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)) 19:49:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:04 INFO - Downloading blessings-1.5.1.tar.gz 19:49:04 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 19:49:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:49:04 INFO - Installing collected packages: blessings 19:49:04 INFO - Running setup.py install for blessings 19:49:04 INFO - Successfully installed blessings 19:49:04 INFO - Cleaning up... 19:49:04 INFO - Return code: 0 19:49:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:49:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:49:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:49:04 INFO - Reading from file tmpfile_stdout 19:49:04 INFO - Current package versions: 19:49:04 INFO - argparse == 1.2.1 19:49:04 INFO - blessings == 1.5.1 19:49:04 INFO - blobuploader == 1.2.4 19:49:04 INFO - docopt == 0.6.1 19:49:04 INFO - manifestparser == 1.1 19:49:04 INFO - mozInstall == 1.12 19:49:04 INFO - mozcrash == 0.16 19:49:04 INFO - mozdebug == 0.1 19:49:04 INFO - mozdevice == 0.47 19:49:04 INFO - mozfile == 1.2 19:49:04 INFO - mozhttpd == 0.7 19:49:04 INFO - mozinfo == 0.9 19:49:04 INFO - mozleak == 0.1 19:49:04 INFO - mozlog == 3.1 19:49:04 INFO - moznetwork == 0.27 19:49:04 INFO - mozprocess == 0.22 19:49:04 INFO - mozprofile == 0.28 19:49:04 INFO - mozrunner == 6.11 19:49:04 INFO - mozscreenshot == 0.1 19:49:04 INFO - mozsystemmonitor == 0.0 19:49:04 INFO - moztest == 0.7 19:49:04 INFO - mozversion == 1.4 19:49:04 INFO - psutil == 3.1.1 19:49:04 INFO - requests == 1.2.3 19:49:04 INFO - wsgiref == 0.1.2 19:49:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:49:04 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')]} 19:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:04 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')]} 19:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:04 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 0x7f15734b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ee630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217f840>, '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 0x20ec6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ecb60>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1451441964.903238-1452020180', '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 19:49:04 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 19:49:04 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 19:49:04 INFO - Using env: {'DISPLAY': ':0', 19:49:04 INFO - 'HOME': '/home/cltbld', 19:49:04 INFO - 'LANG': 'en_US.UTF-8', 19:49:04 INFO - 'LANGUAGE': 'en_US:en', 19:49:04 INFO - 'LOGNAME': 'cltbld', 19:49:04 INFO - 'MAIL': '/var/mail/cltbld', 19:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:04 INFO - 'MOZ_NO_REMOTE': '1', 19:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:04 INFO - 'NO_EM_RESTART': '1', 19:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:04 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:04 INFO - 'SHELL': '/bin/bash', 19:49:04 INFO - 'SHLVL': '1', 19:49:04 INFO - 'TERM': 'linux', 19:49:04 INFO - 'TMOUT': '86400', 19:49:04 INFO - 'USER': 'cltbld', 19:49:04 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451441964.903238-1452020180', 19:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:04 INFO - '_': '/tools/buildbot/bin/python'} 19:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:04 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)) 19:49:04 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)) 19:49:04 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)) 19:49:04 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)) 19:49:04 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)) 19:49:04 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)) 19:49:04 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)) 19:49:04 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)) 19:49:04 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)) 19:49:04 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)) 19:49:04 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)) 19:49:04 INFO - Cleaning up... 19:49:04 INFO - Return code: 0 19:49:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:49:04 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')]} 19:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:04 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')]} 19:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:04 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 0x7f15734b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ee630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217f840>, '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 0x20ec6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ecb60>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1451441964.903238-1452020180', '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 19:49:04 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 19:49:04 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 19:49:04 INFO - Using env: {'DISPLAY': ':0', 19:49:04 INFO - 'HOME': '/home/cltbld', 19:49:04 INFO - 'LANG': 'en_US.UTF-8', 19:49:04 INFO - 'LANGUAGE': 'en_US:en', 19:49:04 INFO - 'LOGNAME': 'cltbld', 19:49:04 INFO - 'MAIL': '/var/mail/cltbld', 19:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:04 INFO - 'MOZ_NO_REMOTE': '1', 19:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:04 INFO - 'NO_EM_RESTART': '1', 19:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:04 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:04 INFO - 'SHELL': '/bin/bash', 19:49:04 INFO - 'SHLVL': '1', 19:49:04 INFO - 'TERM': 'linux', 19:49:04 INFO - 'TMOUT': '86400', 19:49:04 INFO - 'USER': 'cltbld', 19:49:04 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451441964.903238-1452020180', 19:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:04 INFO - '_': '/tools/buildbot/bin/python'} 19:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:04 INFO - Downloading/unpacking jsonschema 19:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:49:06 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 19:49:06 INFO - Downloading/unpacking functools32 (from jsonschema) 19:49: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 19:49: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 19:49: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 19:49: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 19:49: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 19:49: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 19:49:06 INFO - Downloading functools32-3.2.3-2.tar.gz 19:49:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:49:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:49:06 INFO - warning: no files found matching '*.txt' 19:49:06 INFO - no previously-included directories found matching 'build' 19:49:06 INFO - no previously-included directories found matching 'dist' 19:49:06 INFO - no previously-included directories found matching '.git*' 19:49:06 INFO - Installing collected packages: jsonschema, functools32 19:49:06 INFO - Running setup.py install for functools32 19:49:06 INFO - warning: no files found matching '*.txt' 19:49:06 INFO - no previously-included directories found matching 'build' 19:49:06 INFO - no previously-included directories found matching 'dist' 19:49:06 INFO - no previously-included directories found matching '.git*' 19:49:07 INFO - Successfully installed jsonschema functools32 19:49:07 INFO - Cleaning up... 19:49:07 INFO - Return code: 0 19:49:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:07 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 0x7f15734b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x201e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ee630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x217f840>, '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 0x20ec6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ecb60>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1451441964.903238-1452020180', '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 19:49:07 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 19:49:07 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 19:49:07 INFO - Using env: {'DISPLAY': ':0', 19:49:07 INFO - 'HOME': '/home/cltbld', 19:49:07 INFO - 'LANG': 'en_US.UTF-8', 19:49:07 INFO - 'LANGUAGE': 'en_US:en', 19:49:07 INFO - 'LOGNAME': 'cltbld', 19:49:07 INFO - 'MAIL': '/var/mail/cltbld', 19:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:07 INFO - 'MOZ_NO_REMOTE': '1', 19:49:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:07 INFO - 'NO_EM_RESTART': '1', 19:49:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:07 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:07 INFO - 'SHELL': '/bin/bash', 19:49:07 INFO - 'SHLVL': '1', 19:49:07 INFO - 'TERM': 'linux', 19:49:07 INFO - 'TMOUT': '86400', 19:49:07 INFO - 'USER': 'cltbld', 19:49:07 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451441964.903238-1452020180', 19:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:07 INFO - '_': '/tools/buildbot/bin/python'} 19:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:07 INFO - Downloading/unpacking flake8 19:49:07 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 19:49:07 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 19:49:07 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 19:49:07 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 19:49:07 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 19:49:07 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 19:49:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:49:08 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 19:49:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:49:08 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 19:49:08 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 19:49:08 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 19:49:08 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 19:49:08 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 19:49:08 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 19:49:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:49:09 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 19:49:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:49: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 19:49: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 19:49: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 19:49: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 19:49: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 19:49: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 19:49:09 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 19:49:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:49: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 19:49: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 19:49: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 19:49: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 19:49: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 19:49: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 19:49:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:49:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:49:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:49:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:49:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:49:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:49:09 INFO - no previously-included directories found matching 'docs/_build' 19:49:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:49:09 INFO - Running setup.py install for pep8 19:49:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:49:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:49:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:49:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:49:09 INFO - no previously-included directories found matching 'docs/_build' 19:49:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:49:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:49:09 INFO - Cleaning up... 19:49:09 INFO - Return code: 0 19:49:09 INFO - Running post-action listener: _resource_record_post_action 19:49:09 INFO - Running post-action listener: _start_resource_monitoring 19:49:09 INFO - Starting resource monitoring. 19:49:09 INFO - ##### 19:49:09 INFO - ##### Running install step. 19:49:09 INFO - ##### 19:49:09 INFO - Running pre-action listener: _resource_record_pre_action 19:49:09 INFO - Running main action method: install 19:49:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:49:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:49:10 INFO - Reading from file tmpfile_stdout 19:49:10 INFO - Detecting whether we're running mozinstall >=1.0... 19:49:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:49:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:49:10 INFO - Reading from file tmpfile_stdout 19:49:10 INFO - Output received: 19:49:10 INFO - Usage: mozinstall [options] installer 19:49:10 INFO - Options: 19:49:10 INFO - -h, --help show this help message and exit 19:49:10 INFO - -d DEST, --destination=DEST 19:49:10 INFO - Directory to install application into. [default: 19:49:10 INFO - "/builds/slave/test-pgo"] 19:49:10 INFO - --app=APP Application being installed. [default: firefox] 19:49:10 INFO - mkdir: /builds/slave/test-pgo/build/application 19:49:10 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'] 19:49:10 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 19:49:25 INFO - Reading from file tmpfile_stdout 19:49:25 INFO - Output received: 19:49:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:49:25 INFO - Running post-action listener: _resource_record_post_action 19:49:25 INFO - ##### 19:49:25 INFO - ##### Running run-tests step. 19:49:25 INFO - ##### 19:49:25 INFO - Running pre-action listener: _resource_record_pre_action 19:49:25 INFO - Running main action method: run_tests 19:49:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:49:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:49:25 INFO - Python 2.7.3 19:49:25 INFO - Return code: 0 19:49:25 INFO - grabbing minidump binary from tooltool 19:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:25 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 0x217f840>, '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 0x20ec6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20ecb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:49:25 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 19:49:25 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 19:49:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:49:25 INFO - Return code: 0 19:49:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:49:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:49:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:49:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:49:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:49:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:49:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:49:26 INFO - Return code: 0 19:49:26 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/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 19:49:26 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/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 19:49:26 INFO - Using env: {'DISPLAY': ':0', 19:49:26 INFO - 'HOME': '/home/cltbld', 19:49:26 INFO - 'LANG': 'en_US.UTF-8', 19:49:26 INFO - 'LANGUAGE': 'en_US:en', 19:49:26 INFO - 'LOGNAME': 'cltbld', 19:49:26 INFO - 'MAIL': '/var/mail/cltbld', 19:49:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:49:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:26 INFO - 'MOZ_NO_REMOTE': '1', 19:49:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:49:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:26 INFO - 'NO_EM_RESTART': '1', 19:49:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:26 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:49:26 INFO - 'SHELL': '/bin/bash', 19:49:26 INFO - 'SHLVL': '1', 19:49:26 INFO - 'TERM': 'linux', 19:49:26 INFO - 'TMOUT': '86400', 19:49:26 INFO - 'USER': 'cltbld', 19:49:26 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451441964.903238-1452020180', 19:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:26 INFO - '_': '/tools/buildbot/bin/python'} 19:49:26 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/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 19:49:27 INFO - mozversion application_buildid: 20151229173003 19:49:27 INFO - mozversion application_changeset: e873ef1df11f7c0538ec2dd5f53a6568c4bb7005 19:49:27 INFO - mozversion application_display_name: Nightly 19:49:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:49:27 INFO - mozversion application_name: Firefox 19:49:27 INFO - mozversion application_remotingname: firefox 19:49:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:49:27 INFO - mozversion application_vendor: Mozilla 19:49:27 INFO - mozversion application_version: 46.0a1 19:49:27 INFO - mozversion platform_buildid: 20151229173003 19:49:27 INFO - mozversion platform_changeset: e873ef1df11f7c0538ec2dd5f53a6568c4bb7005 19:49:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:49:27 INFO - mozversion platform_version: 46.0a1 19:49:27 INFO - using testdate: 1451447367 19:49:27 INFO - actual date: 1451447367 19:49:27 INFO - starting webserver on 'localhost:59500' 19:49:27 INFO - SUITE-START | Running 3 tests 19:49:27 INFO - TEST-START | dromaeo_css 19:49:27 INFO - operating with platform_type : linux_ 19:49:27 INFO - Initialising browser for dromaeo_css test... 19:49:27 INFO - TEST-INFO | started process 30008 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqks5S9/profile http://localhost:59500/getInfo.html) 19:49:31 INFO - PROCESS | 30008 | __metrics Screen width/height:1600/1200 19:49:31 INFO - PROCESS | 30008 | colorDepth:24 19:49:31 INFO - PROCESS | 30008 | Browser inner width/height: 1024/697 19:49:31 INFO - PROCESS | 30008 | __metrics 19:49:31 INFO - PROCESS | 30008 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:49:32 INFO - TEST-INFO | 30008: exit 0 19:49:32 INFO - Browser initialized. 19:49:32 INFO - Running cycle 1/1 for dromaeo_css test... 19:49:32 INFO - TEST-INFO | started process 30144 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqks5S9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:49:44 INFO - PROCESS | 30144 | RSS: Main: 150269952 19:49:44 INFO - PROCESS | 30144 | 19:50:34 INFO - PROCESS | 30144 | 1451447434091 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] 19:52:42 INFO - PROCESS | 30144 | Cycle 1(1): loaded http://localhost:59500/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59500/tests/dromaeo/cssquery-ext.html) 19:52:43 INFO - PROCESS | 30144 | RSS: Main: 158347264 19:52:43 INFO - PROCESS | 30144 | 19:55:45 INFO - PROCESS | 30144 | Cycle 1(1): loaded http://localhost:59500/tests/dromaeo/cssquery-ext.html (next: http://localhost:59500/tests/dromaeo/cssquery-jquery.html) 19:55:46 INFO - PROCESS | 30144 | RSS: Main: 152354816 19:55:46 INFO - PROCESS | 30144 | 19:58:47 INFO - PROCESS | 30144 | Cycle 1(1): loaded http://localhost:59500/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59500/tests/dromaeo/cssquery-mootools.html) 19:58:48 INFO - PROCESS | 30144 | RSS: Main: 153690112 19:58:48 INFO - PROCESS | 30144 | 20:01:50 INFO - PROCESS | 30144 | Cycle 1(1): loaded http://localhost:59500/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59500/tests/dromaeo/cssquery-prototype.html) 20:01:50 INFO - PROCESS | 30144 | RSS: Main: 151511040 20:01:50 INFO - PROCESS | 30144 | 20:04:53 INFO - PROCESS | 30144 | Cycle 1(1): loaded http://localhost:59500/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59500/tests/dromaeo/cssquery-yui.html) 20:04:53 INFO - PROCESS | 30144 | RSS: Main: 153378816 20:04:53 INFO - PROCESS | 30144 | 20:07:56 INFO - PROCESS | 30144 | Cycle 1(1): loaded http://localhost:59500/tests/dromaeo/cssquery-yui.html (next: http://localhost:59500/tests/dromaeo/cssquery-dojo.html) 20:07:56 INFO - PROCESS | 30144 | RSS: Main: 155058176 20:07:56 INFO - PROCESS | 30144 | 20:07:56 INFO - PROCESS | 30144 | __start_tp_report 20:07:56 INFO - PROCESS | 30144 | _x_x_mozilla_page_load 20:07:56 INFO - PROCESS | 30144 | _x_x_mozilla_page_load_details 20:07:56 INFO - PROCESS | 30144 | |i|pagename|runs| 20:07:56 INFO - PROCESS | 30144 | |0;dojo.html;3121.7814752967292;3155.274286914011;3167.1132083016764;3201.135693362791;3208.7914285571437;5175.948240517594;5232.581393488521;5261.86845328867;5263.894722105556;5266.499682530163;5216.9478305216935;5250.789968401259;5272.973635131819;5342.813001544947;5353.116735738598;4497.415336006315;4792.376990991166;4907.681000734959;4927.778249978742;4928.531789480012;4731.929021064687;4858.392700912386;4884.023195360942;4905.215165573509;4907.852764417074;4761.619070474354;4793.041391721669;4826.710397376133;4850.490698476662;4883.8779030524165;4785.258284965801;4796.2326027835725;4813.278008298783;4819.2530157825595;4846.491118432549;4736.8578942631775;4798.424189097295;4801.399825021872;4834.226523756182;4864.0515099555605;5073.974630126826;5077.771500282459;5083.466236045199;5119.539241468286;5139.306193663882;5648.124540696199;5651.547876169897;5664.886702265972;5668.829935101953;5682.119271512922;5562.721863906829;5721.370649228582;5722.656640601535;5725.799597014126;5732.684702341369;5273.789048438058;5301.363836339626;5359.5712343012465;5366.597505187087;5400.864978375572;5819.709014549256;5819.88360232793;5852.531797456193;5854.2096816930025;5879.353271140171;5434.212039254286;5521.089020311684;5648.51987581052;5661.830145095653;5663.716814159276;5686.289213848269;5773.249477567973;5774.711264436762;5776.624519406225;5813.505852002542;5594.440555944373;5631.605787594829;5636.577256705764;5651.208830763697;5651.350094739076;5505.174223866452;5551.9722401387735;5606;5635.436456354331;5679.346875109332;4411.735295882258;4416.4037854889175;4421.447319085114;4457.8439754608435;4462.955370446319;3954.169624378855;3958.3072962231495;3959.1883663848844;3966.900827479278;3981.3828856527284;5213.087709650796;5320.787168513216;5328.706921119376;5329.227262046981;5434.266374039454;5683.857903552444;5694.373618901917;5699.5725320600295;5701.458361455655;5708.771649133988;5310.495502927216;5350.073295505496;5350.892982140335;5356.7321633918145;5400.4599540046465;4805.879853003633;4894.11905856942;4908.9263661045115;4915.95084049155;4992.500749924979;5959.344472108065;5965.671888046112;5969.492593129633;5973.761049557969;5990.281166260077;5761.135829625589;5761.222234998306;5763.279590051244;5769.682667453162;5771.59598828078;5716.514096301861;5743.310802703535;5841.532677385714;5851.795187168429;5959.284885813557;5529.115341545334;5561.082421400423;5565.972170139124;5573.972130139324;5583.4416558345465;5536.197251398606;5644.745986430538;5695.373508914099;5699.487046165865;5699.572532060195;5502.0921547944145;5562.16567514876;5628.296462942132;5650.773969041356;5691.231683722644;5494.2857428534035;5516.586256030733;5531.751071201886;5545.112781954868;5546.306711661043;5348.171033489815;5445.101558243004;5464.535514481314;5467.425920278313;5523.309586301712;5555.722213889208;5609.80365687199;5622.634528755618;5628.690422026664;5633.0987042073075;5395.730213489232;5428.647137936022;5437.945620543902;5440.047991601375;5446.019716451076 20:07:56 INFO - PROCESS | 30144 | |1;ext.html;479.21887323662423;517.0150862606733;534.0467265930314;550.7191332420466;577.1775220311056;28973.420531589356;37430.62569374305;37606.62393376065;37975.24049519008;38083.047923801954;40376.79811600938;41046.179076418455;41109;41109;41141.38287925684;8614.612342444605;8748.60631271591;8760.4305720128;8775.341849361323;8786.912130878705;8448.23965843074;8566.18621230982;8568.314534837198;8576.914230857705;8578.699745508908;8566.957165214166;8592.699255526059;8619.741407757745;8647.092055334193;8650.697225597105;8441.57792110392;8493.787655308604;8506.064332923374;8512.021117571465;8535.445196062266;8475.830483390358;8616;8644.308455323622;8652.394332396734;8805.383623146383;39796;39929.40105898414;40327;40422.79788601038;40461.39307910384;3278.2132288250887;3463.428534291839;3516.9120771980906;3692.6307369263127;3892.6107389260847;27366;28329;28447.71552284471;28479.145625631263;28935.855320723473;3521.29574085184;3553.342631613134;3722.050877026341;3726.2174943261675;3831.597682243352;264823;270144;270340.999999998;270632;271051;55997.72001139968;57091.71454142703;60765.69617151886;63715.902727781664;65339.34660653428;57462.42537574654;57502.13746793802;57594;57635.42364576385;57723;15573.688526229413;15604.765928511082;15715.371385144696;15718.528444146694;15771.684566308839;11934.820977685342;11948.701282467833;11963.46164422603;11993.460294286779;12237.510499580096;20775.480612984495;21069.578608427746;21149.894250528956;21179.8941005294;21199.576008479744;7995.360371170293;8224.241183139937;8356.832863342699;8472.44929079608;8484.575771211537;967.192394350711;992.6972273456665;997.6607953295769;1053.984190237147;1198.6523908066738;31001.844990775353;32577.511337329957;32669.92412505468;34246.48630270548;34526.13684657904;1069.005824583145;1076.1982323169289;1077.7251800790748;1077.8598782158426;1086.1419478611965;14149.85850141506;14149.929250353682;14363.353649085817;14382.208978506073;14427.567172984827;530201;537991;543044;543234;544707;51878.74060629673;52082;52107.73946130245;52171.30458258775;52320.73839630854;1339.8861096806686;1345.0987838148465;1345.1122259308809;1358.5584684977619;1371.1087792934673;28709.42581148407;30780.23049423782;33295.83352083224;34010.31979360349;34374.48438273478;51298.48701512937;51869.48130518646;51879;52082.21876671777;52100.739496302274;293992;296323;297225;297407;297670;41962.79018604887;43078.56921430871;43512.56487435085;44579.777101115586;44755;39068.804655976535;39800.2039959205;40048.599514005655;40132.59867401405;40731.38902916518;33428.832855835564;35221.82389088141;36953.44569831401;37430.812845935594;38133.237335253696;36758.63241367552;37015.81492092522;38831.61168388393;39695.60304396919;40455.79772101121;33448;33571.664283356855;33842.830785845916;33903;38917.80541097277;29076.820920931976;30183.245418864703;31724.20689482689;31857.522137168424;31858.20354491156;25035.248942531754;25314.493710126062;25486.74513254918;25571.105011324515;25620.359491012874 20:07:56 INFO - PROCESS | 30144 | |2;jquery.html;349.36415723383453;349.3798507648923;349.48974497234036;349.6241540344129;355.10159296978645;16421.917890410547;16683.749743753855;17341.65316693667;17455.21451534681;18142.18360173792;10747.731306717336;11585.942070289637;15786.684266314667;15802.288896999635;15820.129892855888;4518.638508919287;5031.748412579356;5150.922736158961;5186.299849520305;5193.662411943212;5133.743312834362;5137;5152.381714194302;5473.7263136843;5954.642721436706;3669.1377526281435;3771.4908487354132;5890.5582081343855;5892.587518873681;5892.587518873681;5167.922481162766;5264.052470555299;5265.131253343194;5273.288106105684;5335.519803217729;5112.18205087188;5136.43499215086;5144.948550514484;5145;5248.343957005374;12264.570740024146;12662.240265584094;12685.365731713377;13468;20827.8958605206;2114.3551216878845;2122.681597760333;2171.576542574199;2197.088208393515;2272.8977196026217;9533.47565883876;9573.28200384974;9628.759281017961;11396;13182.472701091945;1838.5679365349133;1843.64970655575;1843.8199552286546;1846.6675998320297;1863.18951256204;59041.40958590402;59878.10182847261;60357.698211508665;61010.694946524985;63079.68460157716;9973.30186886911;10194.133498652698;10201.540930658139;10215.599334156468;10253.794924101476;13121.868781312065;13142.802857957138;13166.144200626928;13194.868051319556;13224.743649353297;7278.126624805057;7287;7332.96333518329;7346.853062938711;7363.852722945619;6670.633115178614;6671.232808227019;6791.762288319885;6799.898001529981;6822.931770682229;4170.791460426966;4216.683748718859;4230.259704551752;4241.3637954307105;4251.234777739975;1820.8452281555951;1854.3417086934214;1872.2510995601867;1886.141805478504;1888.4051523770243;426.2008733624454;428.4301878501585;865.8831057807241;958.6261358070358;1068.4283908109123;9985.500724963722;10249.12882405004;10393.688189354332;10494.108000819862;10599.523021464052;440.20762627270784;441.62682533259346;450.16494402882836;451.4650139584537;455.1307003623064;5715.228444159985;5744.425557444306;5751.741171647286;5753.88492230153;5803.477687008105;569454;570730;580216;583290;588447;78565.60717196377;81405.59297203594;82834;83977.58011210027;84896.57551712202;1177.617274385811;1182.320165904591;1191.2733232728028;1203.789336866045;1217.4825699078033;15637.687246255238;15648.687026259639;15659.982101163389;15862.920685396499;15967.20163991819;34533;34843;35140.12149696176;35982;36084.45873311955;46242.30636540522;46694;48001.51998479971;48193;51484;9312.906870931474;9471.905280947103;9560.28297877648;9573.617055317987;9586.28102892272;11268.83096753533;11348.319100853974;11417.600383986854;11510.59712910044;11542.596009139976;13915;14408;14480.058796178215;14824.555263342118;14923.626909327353;13748.243846588533;14295.499657511937;14336.283185840875;14412.927935360256;14632.195229262066;14622.34199461048;14712.04371715835;14764.040337378035;14790.11259324444;15012.324445399765;8910.821783564423;9263.397879137834;9327.067293270618;9336.533173341442;9456.858147127661;10109.64616238428;12920.806187907001;14194.43222271139;14541.78187327212;15228.314725837143 20:07:56 INFO - PROCESS | 30144 | |3;mootools.html;1434.84216736159;1445.8409574946754;1599.2723310893546;1742.7385892116174;1764.541219282986;6616.867662646744;6731.999999999994;6735.663216839163;6773.322667733224;6833.726650933957;6753.223379311381;6760.66196690166;6821.1132552768195;6825.795226143211;6860.108185935821;2110.187577782553;2148.892555372233;2155.558110587334;2156.4069880782754;2161.7838216178334;2112.42964399612;2146.399008277685;2149.451889768107;2165.7942495462985;2176.4450065233423;2066.7829877862832;2094.507790669199;2105.3052492677457;2148.5380643161716;2156.3423155937435;2096.1929657082055;2099.1078791513546;2127.3405244374294;2131.8614290071096;2132.2856842957626;2111.5882402931434;2120.363890832744;2124.575084982994;2135.231316725977;2136.77563855796;6936.930630693679;6969.58182509046;6996.510244282902;7002.229754726976;7029.683664235071;4267.701260911737;4279.079997800457;4333.609975102256;4338.197433474817;4339.435873336446;2773.071021207898;2783.151138902634;2810.8313501189996;2820.210341104494;2836.9432611347866;877.7191298784392;930.5440334236243;935.6210734652477;953.6137864165024;992.3053862296422;8966.282697384258;8981.05698901619;8999.370044096915;9000.729978100668;9015.684451044182;3632.5277713897553;3649.2154186849425;3818.121831978605;3825.0628595993603;3841.539015318124;7521.4734968551675;7547.962260188664;7564;7565.546067235983;7570.356519695777;4250.149970006011;4265.7440553566885;4279.315309550457;4284;4289.378040184156;3937.8031098444962;3939.803009849496;3946.092398748304;3947.0527073502153;3972.3842804365368;3123.687631236858;3175.5712978747574;3184.6815318467966;3185.904422867318;3198.200449887528;932.883389576303;950.3632566180676;951.9143277104955;952.7570469530225;954.0650162840456;1009.3287963504188;1040.8126537223372;1043.9634612788516;1135.6271872538548;1251.6870782304425;6331.430171284606;6395.072714456378;6434.517411194179;6462;6469.5794773339585;1128.954841806335;1140.8745038045975;1152.8616566011965;1160.6460029691025;1171.9531218751154;5267.631265811433;5281.815136470205;5293.682379057269;5296.417394086648;5306.8407947761625;7700.422468314899;7831.373490120891;7842.764717058498;7907.2488113629115;7920.168382319889;7811.414143939227;7889.21107889218;7931.048274207132;7936.920630793734;7944.920550794418;6273.937260627426;6289.622622642748;6360.045993101072;6369.426751592379;6381.904271435932;6211.720472578835;6222.253329600477;6226.221722284715;6230.43926046658;6230.626162430269;6894.724211031703;6954.408875245661;7105.467089968376;7175.138983322035;7182.17404998411;7078.93815927615;7232.493725439169;7261.346478816932;7263.273672632695;7279.235680253497;6244.281907580505;6310.589811662411;6338.334474880256;6354.6822658867795;6369.20384951881;6578.80263592093;6672.8999065013095;6674.9332506676255;6704.932950670431;6775.4240889524945;6100.328963814066;6196.938030619816;6214.689265536615;6350.333215012357;6371.649559274099;5568.832935011957;5640.689762062962;5728.369879313189;5926.199963005111;6330;6051.0923361496125;6101.481374083075;6115.84710382244;6132.9080063799975;6137.1101190328045;5698.145278208136;5720.656760594377;5816.098504731774;5905.704714764159;5924.822255332347;5870.26621672291;5892.2929248488745;5908.350081490947;5913.91129133072;5928.881422371443 20:07:56 INFO - PROCESS | 30144 | |4;prototype.html;327.13962279205685;332.36352385182374;336.67847205918343;337.642099374663;343.0908093552088;6223.719932603032;6225.657588832618;6248.593841400318;6254.812355629327;6354.904676429857;6120.602160859552;6194.287656919456;6205;6225.5953363031485;6267.968660156705;4747.833825816106;4757.476677565465;4757.976210118944;4759.071980963713;4761.4763275751775;4760.976195119037;4767.404074490689;4770.284457331393;4775.617950563947;4776.379070720802;4592.517785632511;4662.114198302312;4669.556392142758;4704.835330763424;4717.339572459841;4675.018246168309;4680.625549955996;4703.647226457995;4705.952940470585;4713.1987562114355;4084.4894388201474;4097.057676734368;4100.036491424513;4109.383592461125;4121.773302468363;5957.404259574051;5964.254468191476;5984.922713911495;6000.099985002241;6013.128096426038;5362.410134885159;5404.810831620914;5450.618456708032;5453.890922181534;5474.042042642522;6545.509086818508;6573.57271777333;6581.506387020992;6586.604803711744;6597.670116494156;4518.209313370147;4522.728636281834;4526.366308716782;4529.954700452986;4530.954690453086;6746.59520428771;6823.761168359133;6880.380765731108;6895.55178913364;6907.930920690779;4561.817527298871;4562.8631141065825;4563.269876819693;4567.840125595588;4571.22289210835;4614.054118905617;4617.399738034102;4619.838305659353;4626.676132670748;4627.95372046282;5384.78460861569;5394.62237643369;5397.433269506645;5400.756965936543;5404.513593776579;6470.741170353133;6509.1863517060365;6627.10534077903;6628.801135965929;6654.50091243149;1638.0744879143247;1660.5516510542086;1660.8173100958884;1660.8671306295466;1662.9750553741703;1091.6343025086526;1094.715374002749;1105.3699391346854;1108.1024370260116;1119.9496022679;6253.812385628438;6290.968545157245;6304.054391841169;6323.336049714714;6335.239771227482;6752.155980502437;6825.215100263533;6854.588724676535;6856.897146542706;6857.142857142857;6252.374762523711;6304.65324407162;6316.747330106836;6354.650494222862;6390.329015453311;3729.1609387887506;3742.2702572998546;3753.9436908446396;3765.755225910362;3767.1900541383734;7169.89245161323;7175.928240717526;7204.351608355273;7213.062301900719;7251.1661158966335;6948.444124470131;7054.047703560056;7083.716651333992;7113.181984071794;7115.71537138519;7161.89257161143;7208.495405321577;7211.855762884713;7214.855702885913;7241.058662373857;6846.931530684629;6878.174619045746;6899.241083480913;6910.067140935909;6913.2049814272;6716.462682985447;6830.18037835443;6834;6835.487338449537;6836.863262734618;7014.193367762568;7027.489089845503;7033.085698859116;7038.40173585251;7046.859062818818;4608.815647374202;4640.930386044144;4641.466231383434;4652.697574657636;4657.184992626209;6713.530052896251;6918.342757438036;6945.652717364213;6946.652667366712;6947.617881016593;6724.193096828412;6729.226138994079;6737.797866064026;6738.764143254963;6754.12196414463;6571.047198156145;6687.230968438497;6717.462602991651;6721.260661327348;6725;6574.342565743387;6579.605223686594;6592.2089349276475;6593.80218593443;6619.966900165468;6735.865282694221;6742;6762.661866906733;6762.932370676427;6772.729090836311;6456.548041637228;6581.177352830896;6588;6592.505562082767;6596.67016649156 20:07:56 INFO - PROCESS | 30144 | |5;yui.html;832.1096426823294;841.0874201491382;855.2217482091296;856.6915910272305;865.2306034160146;13180.934095329521;13547.796783048263;13572.864271357295;13574.253416062113;13605.727885442286;12568.622941311774;12952.611421657366;12953.22280663161;12955.935220323885;13015.154014989042;814.1898810683364;834.2325060943916;838.053000109875;839.0895877972407;840.5083026429546;833.2500749325595;839.039300001498;840.7141571865565;842.2756429470651;843.3337663246028;864.6584599083359;871.0549054276119;872;872.8079822439054;874.8993865705462;861.719941019165;866.2982983783156;869.826034793044;870.0777176193192;871.5293741379647;629.7764293675725;637.0476138173414;638.1544453598954;638.8977763557808;640.4844100499097;13661.248631325274;13718.38267277965;13779.104358216784;13788.241646709426;13842.031057825956;11914.344711040889;11917.880821191764;12372.690682732913;12387.318697471635;12548.874511254862;10191.184705223564;10414.218933580012;10483.528241229164;10568.418736969541;10683.305585137019;3613.8193090345376;3674.669279764834;3704.4072948328408;3724.366857634209;3781.867634632802;44180.779096104314;44775;44812.327815083125;44887;45135.322970155474;9584.952075239578;9819.006095958035;9836.21287833032;9902.257330700226;9929.65246216379;17018.74471882898;17031.744523832152;17140.742888856676;17172;17260.74108888368;7571.772846814604;7689.846203075907;7719.961400192963;7787.610619469004;7845.921540784633;4276.743395396286;4324.070324880166;4328.870133895988;4336.739795612273;4353.608175264241;3088.722015018659;3100.5814215081127;3124.515700066448;3126.218445388653;3135.451296023187;576.4869266352949;581.3866370978574;590.1590233916652;593.5785592229565;597.0059850349206;578.8494991302292;583.4369833111068;674.6896427643339;680.7072958627838;695.6382681005949;7997;8622.741317760478;8668.306535477146;8670.089640587774;8691.652333906699;658.2101478226148;662.2053535757111;686.3856848120904;705.6683358821346;718.5257729898242;3700.9444858327147;3739.3456145174487;3751.4747935289083;3817.2174704185577;3948.072203032285;55727;55910.44089559134;56003.71998139983;56472.71763641156;56854.43145568574;49240.261396079084;50475.24287135696;50724.492755072715;50958.23562646489;51376.74311628418;44871.55128448739;45354.77322613366;45515.54484455179;45579.544204558195;45837;8076.676932922617;8219.589020549069;8288.58557072132;8385.161483851565;8395.790105247417;33787.83106084454;33811.323773524884;33954;34026.14934626654;34599.4810077844;39559.60440395674;43405.78297108494;44085.11829763323;44506;44626.330605040304;9926.851097233692;10036.698899033041;10227.181825453798;10761.192910531585;10762.816090230224;12320.383980801103;12373.62879113628;12448.502059917502;12911.354432278536;13249.337533123113;10672.733181670521;10803.459827008775;10916.399598022184;10961.232713710282;11028.724281893017;10898.400587967737;11024.062954648623;11026.062784663072;11641.47613357384;12042.578509752468;10768;11115.277506962022;11149.665510034712;11166.88833111691;11381;9643.855342169732;9644.662436814679;9649.903500965182;9650.517474126405;10079.193664506969;8646.43798153118;8906.643734250558;8985.191332780081;9046.864297035418;9239.614057891371 20:07:56 INFO - PROCESS | 30144 | __end_tp_report 20:07:56 INFO - PROCESS | 30144 | __start_cc_report 20:07:56 INFO - PROCESS | 30144 | _x_x_mozilla_cycle_collect,313 20:07:56 INFO - PROCESS | 30144 | __end_cc_report 20:07:56 INFO - PROCESS | 30144 | __startTimestamp1451448476517__endTimestamp 20:07:56 INFO - PROCESS | 30144 | 20:07:56 INFO - PROCESS | 30144 | ------- Summary: start ------- 20:07:56 INFO - PROCESS | 30144 | Number of tests: 6 20:07:56 INFO - PROCESS | 30144 | 20:07:56 INFO - PROCESS | 30144 | [#0] dojo.html Cycles:165 Average:5275.98 Median:5446.02 stddev:582.98 (10.7%) stddev-sans-first:559.74 20:07:56 INFO - PROCESS | 30144 | Values: 3121.8 3155.3 3167.1 3201.1 3208.8 5175.9 5232.6 5261.9 5263.9 5266.5 5216.9 5250.8 5273.0 5342.8 5353.1 4497.4 4792.4 4907.7 4927.8 4928.5 4731.9 4858.4 4884.0 4905.2 4907.9 4761.6 4793.0 4826.7 4850.5 4883.9 4785.3 4796.2 4813.3 4819.3 4846.5 4736.9 4798.4 4801.4 4834.2 4864.1 5074.0 5077.8 5083.5 5119.5 5139.3 5648.1 5651.5 5664.9 5668.8 5682.1 5562.7 5721.4 5722.7 5725.8 5732.7 5273.8 5301.4 5359.6 5366.6 5400.9 5819.7 5819.9 5852.5 5854.2 5879.4 5434.2 5521.1 5648.5 5661.8 5663.7 5686.3 5773.2 5774.7 5776.6 5813.5 5594.4 5631.6 5636.6 5651.2 5651.4 5505.2 5552.0 5606.0 5635.4 5679.3 4411.7 4416.4 4421.4 4457.8 4463.0 3954.2 3958.3 3959.2 3966.9 3981.4 5213.1 5320.8 5328.7 5329.2 5434.3 5683.9 5694.4 5699.6 5701.5 5708.8 5310.5 5350.1 5350.9 5356.7 5400.5 4805.9 4894.1 4908.9 4916.0 4992.5 5959.3 5965.7 5969.5 5973.8 5990.3 5761.1 5761.2 5763.3 5769.7 5771.6 5716.5 5743.3 5841.5 5851.8 5959.3 5529.1 5561.1 5566.0 5574.0 5583.4 5536.2 5644.7 5695.4 5699.5 5699.6 5502.1 5562.2 5628.3 5650.8 5691.2 5494.3 5516.6 5531.8 5545.1 5546.3 5348.2 5445.1 5464.5 5467.4 5523.3 5555.7 5609.8 5622.6 5628.7 5633.1 5395.7 5428.6 5437.9 5440.0 5446.0 20:07:56 INFO - PROCESS | 30144 | 20:07:56 INFO - PROCESS | 30144 | [#1] ext.html Cycles:180 Average:53156.60 Median:20982.42 stddev:103135.63 (491.5%) stddev-sans-first:103349.12 20:07:56 INFO - PROCESS | 30144 | Values: 479.2 517.0 534.0 550.7 577.2 28973.4 37430.6 37606.6 37975.2 38083.0 40376.8 41046.2 41109.0 41109.0 41141.4 8614.6 8748.6 8760.4 8775.3 8786.9 8448.2 8566.2 8568.3 8576.9 8578.7 8567.0 8592.7 8619.7 8647.1 8650.7 8441.6 8493.8 8506.1 8512.0 8535.4 8475.8 8616.0 8644.3 8652.4 8805.4 39796.0 39929.4 40327.0 40422.8 40461.4 3278.2 3463.4 3516.9 3692.6 3892.6 27366.0 28329.0 28447.7 28479.1 28935.9 3521.3 3553.3 3722.1 3726.2 3831.6 264823.0 270144.0 270341.0 270632.0 271051.0 55997.7 57091.7 60765.7 63715.9 65339.3 57462.4 57502.1 57594.0 57635.4 57723.0 15573.7 15604.8 15715.4 15718.5 15771.7 11934.8 11948.7 11963.5 11993.5 12237.5 20775.5 21069.6 21149.9 21179.9 21199.6 7995.4 8224.2 8356.8 8472.4 8484.6 967.2 992.7 997.7 1054.0 1198.7 31001.8 32577.5 32669.9 34246.5 34526.1 1069.0 1076.2 1077.7 1077.9 1086.1 14149.9 14149.9 14363.4 14382.2 14427.6 530201.0 537991.0 543044.0 543234.0 544707.0 51878.7 52082.0 52107.7 52171.3 52320.7 1339.9 1345.1 1345.1 1358.6 1371.1 28709.4 30780.2 33295.8 34010.3 34374.5 51298.5 51869.5 51879.0 52082.2 52100.7 293992.0 296323.0 297225.0 297407.0 297670.0 41962.8 43078.6 43512.6 44579.8 44755.0 39068.8 39800.2 40048.6 40132.6 40731.4 33428.8 35221.8 36953.4 37430.8 38133.2 36758.6 37015.8 38831.6 39695.6 40455.8 33448.0 33571.7 33842.8 33903.0 38917.8 29076.8 30183.2 31724.2 31857.5 31858.2 25035.2 25314.5 25486.7 25571.1 25620.4 20:07:56 INFO - PROCESS | 30144 | 20:07:56 INFO - PROCESS | 30144 | [#2] jquery.html Cycles:180 Average:29338.18 Median:19876.80 stddev:94626.96 (476.1%) stddev-sans-first:94867.38 20:07:56 INFO - PROCESS | 30144 | Values: 349.4 349.4 349.5 349.6 355.1 16421.9 16683.7 17341.7 17455.2 18142.2 10747.7 11585.9 15786.7 15802.3 15820.1 4518.6 5031.7 5150.9 5186.3 5193.7 5133.7 5137.0 5152.4 5473.7 5954.6 3669.1 3771.5 5890.6 5892.6 5892.6 5167.9 5264.1 5265.1 5273.3 5335.5 5112.2 5136.4 5144.9 5145.0 5248.3 12264.6 12662.2 12685.4 13468.0 20827.9 2114.4 2122.7 2171.6 2197.1 2272.9 9533.5 9573.3 9628.8 11396.0 13182.5 1838.6 1843.6 1843.8 1846.7 1863.2 59041.4 59878.1 60357.7 61010.7 63079.7 9973.3 10194.1 10201.5 10215.6 10253.8 13121.9 13142.8 13166.1 13194.9 13224.7 7278.1 7287.0 7333.0 7346.9 7363.9 6670.6 6671.2 6791.8 6799.9 6822.9 4170.8 4216.7 4230.3 4241.4 4251.2 1820.8 1854.3 1872.3 1886.1 1888.4 426.2 428.4 865.9 958.6 1068.4 9985.5 10249.1 10393.7 10494.1 10599.5 440.2 441.6 450.2 451.5 455.1 5715.2 5744.4 5751.7 5753.9 5803.5 569454.0 570730.0 580216.0 583290.0 588447.0 78565.6 81405.6 82834.0 83977.6 84896.6 1177.6 1182.3 1191.3 1203.8 1217.5 15637.7 15648.7 15660.0 15862.9 15967.2 34533.0 34843.0 35140.1 35982.0 36084.5 46242.3 46694.0 48001.5 48193.0 51484.0 9312.9 9471.9 9560.3 9573.6 9586.3 11268.8 11348.3 11417.6 11510.6 11542.6 13915.0 14408.0 14480.1 14824.6 14923.6 13748.2 14295.5 14336.3 14412.9 14632.2 14622.3 14712.0 14764.0 14790.1 15012.3 8910.8 9263.4 9327.1 9336.5 9456.9 10109.6 12920.8 14194.4 14541.8 15228.3 20:07:56 INFO - PROCESS | 30144 | 20:07:56 INFO - PROCESS | 30144 | [#3] mootools.html Cycles:180 Average:4803.79 Median:6100.91 stddev:2361.33 (38.7%) stddev-sans-first:2354.37 20:07:56 INFO - PROCESS | 30144 | Values: 1434.8 1445.8 1599.3 1742.7 1764.5 6616.9 6732.0 6735.7 6773.3 6833.7 6753.2 6760.7 6821.1 6825.8 6860.1 2110.2 2148.9 2155.6 2156.4 2161.8 2112.4 2146.4 2149.5 2165.8 2176.4 2066.8 2094.5 2105.3 2148.5 2156.3 2096.2 2099.1 2127.3 2131.9 2132.3 2111.6 2120.4 2124.6 2135.2 2136.8 6936.9 6969.6 6996.5 7002.2 7029.7 4267.7 4279.1 4333.6 4338.2 4339.4 2773.1 2783.2 2810.8 2820.2 2836.9 877.7 930.5 935.6 953.6 992.3 8966.3 8981.1 8999.4 9000.7 9015.7 3632.5 3649.2 3818.1 3825.1 3841.5 7521.5 7548.0 7564.0 7565.5 7570.4 4250.1 4265.7 4279.3 4284.0 4289.4 3937.8 3939.8 3946.1 3947.1 3972.4 3123.7 3175.6 3184.7 3185.9 3198.2 932.9 950.4 951.9 952.8 954.1 1009.3 1040.8 1044.0 1135.6 1251.7 6331.4 6395.1 6434.5 6462.0 6469.6 1129.0 1140.9 1152.9 1160.6 1172.0 5267.6 5281.8 5293.7 5296.4 5306.8 7700.4 7831.4 7842.8 7907.2 7920.2 7811.4 7889.2 7931.0 7936.9 7944.9 6273.9 6289.6 6360.0 6369.4 6381.9 6211.7 6222.3 6226.2 6230.4 6230.6 6894.7 6954.4 7105.5 7175.1 7182.2 7078.9 7232.5 7261.3 7263.3 7279.2 6244.3 6310.6 6338.3 6354.7 6369.2 6578.8 6672.9 6674.9 6704.9 6775.4 6100.3 6196.9 6214.7 6350.3 6371.6 5568.8 5640.7 5728.4 5926.2 6330.0 6051.1 6101.5 6115.8 6132.9 6137.1 5698.1 5720.7 5816.1 5905.7 5924.8 5870.3 5892.3 5908.4 5913.9 5928.9 20:07:56 INFO - PROCESS | 30144 | 20:07:56 INFO - PROCESS | 30144 | [#4] prototype.html Cycles:180 Average:5537.78 Median:6279.47 stddev:1697.18 (27.0%) stddev-sans-first:1656.26 20:07:56 INFO - PROCESS | 30144 | Values: 327.1 332.4 336.7 337.6 343.1 6223.7 6225.7 6248.6 6254.8 6354.9 6120.6 6194.3 6205.0 6225.6 6268.0 4747.8 4757.5 4758.0 4759.1 4761.5 4761.0 4767.4 4770.3 4775.6 4776.4 4592.5 4662.1 4669.6 4704.8 4717.3 4675.0 4680.6 4703.6 4706.0 4713.2 4084.5 4097.1 4100.0 4109.4 4121.8 5957.4 5964.3 5984.9 6000.1 6013.1 5362.4 5404.8 5450.6 5453.9 5474.0 6545.5 6573.6 6581.5 6586.6 6597.7 4518.2 4522.7 4526.4 4530.0 4531.0 6746.6 6823.8 6880.4 6895.6 6907.9 4561.8 4562.9 4563.3 4567.8 4571.2 4614.1 4617.4 4619.8 4626.7 4628.0 5384.8 5394.6 5397.4 5400.8 5404.5 6470.7 6509.2 6627.1 6628.8 6654.5 1638.1 1660.6 1660.8 1660.9 1663.0 1091.6 1094.7 1105.4 1108.1 1119.9 6253.8 6291.0 6304.1 6323.3 6335.2 6752.2 6825.2 6854.6 6856.9 6857.1 6252.4 6304.7 6316.7 6354.7 6390.3 3729.2 3742.3 3753.9 3765.8 3767.2 7169.9 7175.9 7204.4 7213.1 7251.2 6948.4 7054.0 7083.7 7113.2 7115.7 7161.9 7208.5 7211.9 7214.9 7241.1 6846.9 6878.2 6899.2 6910.1 6913.2 6716.5 6830.2 6834.0 6835.5 6836.9 7014.2 7027.5 7033.1 7038.4 7046.9 4608.8 4640.9 4641.5 4652.7 4657.2 6713.5 6918.3 6945.7 6946.7 6947.6 6724.2 6729.2 6737.8 6738.8 6754.1 6571.0 6687.2 6717.5 6721.3 6725.0 6574.3 6579.6 6592.2 6593.8 6620.0 6735.9 6742.0 6762.7 6762.9 6772.7 6456.5 6581.2 6588.0 6592.5 6596.7 20:07:56 INFO - PROCESS | 30144 | 20:07:56 INFO - PROCESS | 30144 | [#5] yui.html Cycles:180 Average:13480.08 Median:45245.05 stddev:15439.39 (34.1%) stddev-sans-first:15453.48 20:07:56 INFO - PROCESS | 30144 | Values: 832.1 841.1 855.2 856.7 865.2 13180.9 13547.8 13572.9 13574.3 13605.7 12568.6 12952.6 12953.2 12955.9 13015.2 814.2 834.2 838.1 839.1 840.5 833.3 839.0 840.7 842.3 843.3 864.7 871.1 872.0 872.8 874.9 861.7 866.3 869.8 870.1 871.5 629.8 637.0 638.2 638.9 640.5 13661.2 13718.4 13779.1 13788.2 13842.0 11914.3 11917.9 12372.7 12387.3 12548.9 10191.2 10414.2 10483.5 10568.4 10683.3 3613.8 3674.7 3704.4 3724.4 3781.9 44180.8 44775.0 44812.3 44887.0 45135.3 9585.0 9819.0 9836.2 9902.3 9929.7 17018.7 17031.7 17140.7 17172.0 17260.7 7571.8 7689.8 7720.0 7787.6 7845.9 4276.7 4324.1 4328.9 4336.7 4353.6 3088.7 3100.6 3124.5 3126.2 3135.5 576.5 581.4 590.2 593.6 597.0 578.8 583.4 674.7 680.7 695.6 7997.0 8622.7 8668.3 8670.1 8691.7 658.2 662.2 686.4 705.7 718.5 3700.9 3739.3 3751.5 3817.2 3948.1 55727.0 55910.4 56003.7 56472.7 56854.4 49240.3 50475.2 50724.5 50958.2 51376.7 44871.6 45354.8 45515.5 45579.5 45837.0 8076.7 8219.6 8288.6 8385.2 8395.8 33787.8 33811.3 33954.0 34026.1 34599.5 39559.6 43405.8 44085.1 44506.0 44626.3 9926.9 10036.7 10227.2 10761.2 10762.8 12320.4 12373.6 12448.5 12911.4 13249.3 10672.7 10803.5 10916.4 10961.2 11028.7 10898.4 11024.1 11026.1 11641.5 12042.6 10768.0 11115.3 11149.7 11166.9 11381.0 9643.9 9644.7 9649.9 9650.5 10079.2 8646.4 8906.6 8985.2 9046.9 9239.6 20:07:56 INFO - PROCESS | 30144 | -------- Summary: end -------- 20:07:56 INFO - PROCESS | 30144 | 20:07:57 INFO - TEST-INFO | 30144: exit 0 20:07:57 INFO - TEST-OK | dromaeo_css | took 1110082ms 20:07:57 INFO - TEST-START | kraken 20:07:57 INFO - operating with platform_type : linux_ 20:07:57 INFO - Initialising browser for kraken test... 20:07:57 INFO - TEST-INFO | started process 30384 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVXXA_G/profile http://localhost:59500/getInfo.html) 20:08:02 INFO - PROCESS | 30384 | __metrics Screen width/height:1600/1200 20:08:02 INFO - PROCESS | 30384 | colorDepth:24 20:08:02 INFO - PROCESS | 30384 | Browser inner width/height: 1024/697 20:08:02 INFO - PROCESS | 30384 | __metrics 20:08:02 INFO - PROCESS | 30384 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:08:03 INFO - TEST-INFO | 30384: exit 0 20:08:03 INFO - Browser initialized. 20:08:03 INFO - Running cycle 1/1 for kraken test... 20:08:03 INFO - TEST-INFO | started process 30504 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVXXA_G/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:08:15 INFO - PROCESS | 30504 | RSS: Main: 149491712 20:08:15 INFO - PROCESS | 30504 | 20:08:17 INFO - PROCESS | 30504 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59500/tests/kraken/driver.html?testName=audio-beat-detection) 20:08:18 INFO - PROCESS | 30504 | RSS: Main: 151449600 20:08:18 INFO - PROCESS | 30504 | 20:08:20 INFO - PROCESS | 30504 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59500/tests/kraken/driver.html?testName=audio-dft) 20:08:21 INFO - PROCESS | 30504 | RSS: Main: 151179264 20:08:21 INFO - PROCESS | 30504 | 20:08:24 INFO - PROCESS | 30504 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59500/tests/kraken/driver.html?testName=audio-fft) 20:08:24 INFO - PROCESS | 30504 | RSS: Main: 144859136 20:08:24 INFO - PROCESS | 30504 | 20:08:26 INFO - PROCESS | 30504 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59500/tests/kraken/driver.html?testName=audio-oscillator) 20:08:27 INFO - PROCESS | 30504 | RSS: Main: 145481728 20:08:27 INFO - PROCESS | 30504 | 20:08:29 INFO - PROCESS | 30504 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59500/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:08:30 INFO - PROCESS | 30504 | RSS: Main: 145719296 20:08:30 INFO - PROCESS | 30504 | 20:08:33 INFO - PROCESS | 30504 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59500/tests/kraken/driver.html?testName=imaging-darkroom) 20:08:33 INFO - PROCESS | 30504 | RSS: Main: 146464768 20:08:33 INFO - PROCESS | 30504 | 20:08:37 INFO - PROCESS | 30504 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59500/tests/kraken/driver.html?testName=imaging-desaturate) 20:08:37 INFO - PROCESS | 30504 | RSS: Main: 147685376 20:08:37 INFO - PROCESS | 30504 | 20:08:40 INFO - PROCESS | 30504 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59500/tests/kraken/driver.html?testName=json-parse-financial) 20:08:41 INFO - PROCESS | 30504 | RSS: Main: 148025344 20:08:41 INFO - PROCESS | 30504 | 20:08:42 INFO - PROCESS | 30504 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59500/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:08:43 INFO - PROCESS | 30504 | RSS: Main: 148828160 20:08:43 INFO - PROCESS | 30504 | 20:08:45 INFO - PROCESS | 30504 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59500/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:08:45 INFO - PROCESS | 30504 | RSS: Main: 148180992 20:08:45 INFO - PROCESS | 30504 | 20:08:48 INFO - PROCESS | 30504 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59500/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:08:48 INFO - PROCESS | 30504 | RSS: Main: 149671936 20:08:48 INFO - PROCESS | 30504 | 20:08:51 INFO - PROCESS | 30504 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59500/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:08:51 INFO - PROCESS | 30504 | RSS: Main: 148639744 20:08:51 INFO - PROCESS | 30504 | 20:08:54 INFO - PROCESS | 30504 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59500/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:08:54 INFO - PROCESS | 30504 | RSS: Main: 147722240 20:08:54 INFO - PROCESS | 30504 | 20:08:56 INFO - PROCESS | 30504 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59500/tests/kraken/driver.html?testName=ai-astar) 20:08:56 INFO - PROCESS | 30504 | RSS: Main: 149897216 20:08:56 INFO - PROCESS | 30504 | 20:08:56 INFO - PROCESS | 30504 | __start_tp_report 20:08:56 INFO - PROCESS | 30504 | _x_x_mozilla_page_load 20:08:56 INFO - PROCESS | 30504 | _x_x_mozilla_page_load_details 20:08:56 INFO - PROCESS | 30504 | |i|pagename|runs| 20:08:56 INFO - PROCESS | 30504 | |0;ai-astar;111;104;111;111;111;124;110;109;111;113 20:08:56 INFO - PROCESS | 30504 | |1;audio-beat-detection;156;127;158;158;132;159;151;130;162;134 20:08:56 INFO - PROCESS | 30504 | |2;audio-dft;163;162;163;161;162;162;160;163;169;162 20:08:56 INFO - PROCESS | 30504 | |3;audio-fft;73;72;73;73;73;75;138;71;75;72 20:08:56 INFO - PROCESS | 30504 | |4;audio-oscillator;95;96;139;96;97;95;153;97;96;135 20:08:56 INFO - PROCESS | 30504 | |5;imaging-gaussian-blur;110;114;109;110;110;109;110;110;110;109 20:08:56 INFO - PROCESS | 30504 | |6;imaging-darkroom;149;147;148;148;147;148;148;148;149;146 20:08:56 INFO - PROCESS | 30504 | |7;imaging-desaturate;97;96;97;96;100;97;96;96;96;96 20:08:56 INFO - PROCESS | 30504 | |8;json-parse-financial;61;59;61;59;61;61;59;60;60;60 20:08:56 INFO - PROCESS | 30504 | |9;json-stringify-tinderbox;68;72;69;69;69;69;71;69;69;67 20:08:56 INFO - PROCESS | 30504 | |10;stanford-crypto-aes;88;95;88;89;88;89;91;88;97;89 20:08:56 INFO - PROCESS | 30504 | |11;stanford-crypto-ccm;125;132;127;121;130;123;121;125;133;121 20:08:56 INFO - PROCESS | 30504 | |12;stanford-crypto-pbkdf2;153;153;150;150;164;142;158;158;143;150 20:08:56 INFO - PROCESS | 30504 | |13;stanford-crypto-sha256-iterative;66;70;69;69;68;70;68;70;67;66 20:08:56 INFO - PROCESS | 30504 | __end_tp_report 20:08:56 INFO - PROCESS | 30504 | __start_cc_report 20:08:56 INFO - PROCESS | 30504 | _x_x_mozilla_cycle_collect,733 20:08:56 INFO - PROCESS | 30504 | __end_cc_report 20:08:56 INFO - PROCESS | 30504 | __startTimestamp1451448536886__endTimestamp 20:08:56 INFO - PROCESS | 30504 | 20:08:56 INFO - PROCESS | 30504 | ------- Summary: start ------- 20:08:56 INFO - PROCESS | 30504 | Number of tests: 14 20:08:56 INFO - PROCESS | 30504 | 20:08:56 INFO - PROCESS | 30504 | [#0] ai-astar Cycles:10 Average:111.50 Median:111.00 stddev:4.99 (4.5%) stddev-sans-first:5.29 20:08:56 INFO - PROCESS | 30504 | Values: 111.0 104.0 111.0 111.0 111.0 124.0 110.0 109.0 111.0 113.0 20:08:56 INFO - PROCESS | 30504 | 20:08:56 INFO - PROCESS | 30504 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:157.00 stddev:14.10 (9.0%) stddev-sans-first:14.55 20:08:56 INFO - PROCESS | 30504 | Values: 156.0 127.0 158.0 158.0 132.0 159.0 151.0 130.0 162.0 134.0 20:08:56 INFO - PROCESS | 30504 | 20:08:56 INFO - PROCESS | 30504 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.50 stddev:2.41 (1.5%) stddev-sans-first:2.55 20:08:56 INFO - PROCESS | 30504 | Values: 163.0 162.0 163.0 161.0 162.0 162.0 160.0 163.0 169.0 162.0 20:08:56 INFO - PROCESS | 30504 | 20:08:56 INFO - PROCESS | 30504 | [#3] audio-fft Cycles:10 Average:79.50 Median:73.00 stddev:20.59 (28.2%) stddev-sans-first:21.71 20:08:56 INFO - PROCESS | 30504 | Values: 73.0 72.0 73.0 73.0 73.0 75.0 138.0 71.0 75.0 72.0 20:08:56 INFO - PROCESS | 30504 | 20:08:56 INFO - PROCESS | 30504 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:96.00 stddev:22.83 (23.8%) stddev-sans-first:23.57 20:08:56 INFO - PROCESS | 30504 | Values: 95.0 96.0 139.0 96.0 97.0 95.0 153.0 97.0 96.0 135.0 20:08:56 INFO - PROCESS | 30504 | 20:08:56 INFO - PROCESS | 30504 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:1.45 (1.3%) stddev-sans-first:1.54 20:08:56 INFO - PROCESS | 30504 | Values: 110.0 114.0 109.0 110.0 110.0 109.0 110.0 110.0 110.0 109.0 20:08:56 INFO - PROCESS | 30504 | 20:08:56 INFO - PROCESS | 30504 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 20:08:56 INFO - PROCESS | 30504 | Values: 149.0 147.0 148.0 148.0 147.0 148.0 148.0 148.0 149.0 146.0 20:08:56 INFO - PROCESS | 30504 | 20:08:56 INFO - PROCESS | 30504 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.00 stddev:1.25 (1.3%) stddev-sans-first:1.32 20:08:56 INFO - PROCESS | 30504 | Values: 97.0 96.0 97.0 96.0 100.0 97.0 96.0 96.0 96.0 96.0 20:08:56 INFO - PROCESS | 30504 | 20:08:56 INFO - PROCESS | 30504 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:60.50 stddev:0.88 (1.4%) stddev-sans-first:0.87 20:08:56 INFO - PROCESS | 30504 | Values: 61.0 59.0 61.0 59.0 61.0 61.0 59.0 60.0 60.0 60.0 20:08:56 INFO - PROCESS | 30504 | 20:08:56 INFO - PROCESS | 30504 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:1.40 (2.0%) stddev-sans-first:1.41 20:08:56 INFO - PROCESS | 30504 | Values: 68.0 72.0 69.0 69.0 69.0 69.0 71.0 69.0 69.0 67.0 20:08:56 INFO - PROCESS | 30504 | 20:08:56 INFO - PROCESS | 30504 | [#10] stanford-crypto-aes Cycles:10 Average:90.20 Median:89.00 stddev:3.22 (3.6%) stddev-sans-first:3.32 20:08:56 INFO - PROCESS | 30504 | Values: 88.0 95.0 88.0 89.0 88.0 89.0 91.0 88.0 97.0 89.0 20:08:56 INFO - PROCESS | 30504 | 20:08:56 INFO - PROCESS | 30504 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:126.00 stddev:4.57 (3.6%) stddev-sans-first:4.83 20:08:56 INFO - PROCESS | 30504 | Values: 125.0 132.0 127.0 121.0 130.0 123.0 121.0 125.0 133.0 121.0 20:08:56 INFO - PROCESS | 30504 | 20:08:56 INFO - PROCESS | 30504 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.10 Median:153.00 stddev:6.76 (4.4%) stddev-sans-first:7.16 20:08:56 INFO - PROCESS | 30504 | Values: 153.0 153.0 150.0 150.0 164.0 142.0 158.0 158.0 143.0 150.0 20:08:56 INFO - PROCESS | 30504 | 20:08:56 INFO - PROCESS | 30504 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:69.00 stddev:1.57 (2.3%) stddev-sans-first:1.42 20:08:56 INFO - PROCESS | 30504 | Values: 66.0 70.0 69.0 69.0 68.0 70.0 68.0 70.0 67.0 66.0 20:08:56 INFO - PROCESS | 30504 | -------- Summary: end -------- 20:08:56 INFO - PROCESS | 30504 | 20:08:57 INFO - TEST-INFO | 30504: exit 0 20:08:57 INFO - TEST-OK | kraken | took 60616ms 20:08:57 INFO - TEST-START | v8_7 20:08:57 INFO - operating with platform_type : linux_ 20:08:57 INFO - Initialising browser for v8_7 test... 20:08:57 INFO - TEST-INFO | started process 30792 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptby_5P/profile http://localhost:59500/getInfo.html) 20:09:02 INFO - PROCESS | 30792 | __metrics Screen width/height:1600/1200 20:09:02 INFO - PROCESS | 30792 | colorDepth:24 20:09:02 INFO - PROCESS | 30792 | Browser inner width/height: 1024/697 20:09:02 INFO - PROCESS | 30792 | __metrics 20:09:02 INFO - PROCESS | 30792 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:09:03 INFO - TEST-INFO | 30792: exit 0 20:09:03 INFO - Browser initialized. 20:09:03 INFO - Running cycle 1/1 for v8_7 test... 20:09:03 INFO - TEST-INFO | started process 30915 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptby_5P/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:09:15 INFO - PROCESS | 30915 | RSS: Main: 149774336 20:09:15 INFO - PROCESS | 30915 | 20:09:36 INFO - PROCESS | 30915 | Cycle 1(1): loaded http://localhost:59500/tests/v8_7/run.html (next: http://localhost:59500/tests/v8_7/run.html) 20:09:37 INFO - PROCESS | 30915 | RSS: Main: 146972672 20:09:37 INFO - PROCESS | 30915 | 20:09:37 INFO - PROCESS | 30915 | __start_tp_report 20:09:37 INFO - PROCESS | 30915 | _x_x_mozilla_page_load 20:09:37 INFO - PROCESS | 30915 | _x_x_mozilla_page_load_details 20:09:37 INFO - PROCESS | 30915 | |i|pagename|runs| 20:09:37 INFO - PROCESS | 30915 | |0;Richards;166.86133822793258 20:09:37 INFO - PROCESS | 30915 | |1;DeltaBlue;196.811651249754 20:09:37 INFO - PROCESS | 30915 | |2;Encrypt;284.6569883290635 20:09:37 INFO - PROCESS | 30915 | |3;Decrypt;5202.072538860104 20:09:37 INFO - PROCESS | 30915 | |4;RayTrace;1098.901098901099 20:09:37 INFO - PROCESS | 30915 | |5;Earley;706.2146892655368 20:09:37 INFO - PROCESS | 30915 | |6;Boyer;12243.90243902439 20:09:37 INFO - PROCESS | 30915 | |7;RegExp;25400 20:09:37 INFO - PROCESS | 30915 | |8;Splay;688.4798909338787 20:09:37 INFO - PROCESS | 30915 | |9;NavierStokes;4840.579710144928 20:09:37 INFO - PROCESS | 30915 | __end_tp_report 20:09:37 INFO - PROCESS | 30915 | __startTimestamp1451448577206__endTimestamp 20:09:37 INFO - PROCESS | 30915 | 20:09:37 INFO - PROCESS | 30915 | ------- Summary: start ------- 20:09:37 INFO - PROCESS | 30915 | Number of tests: 10 20:09:37 INFO - PROCESS | 30915 | 20:09:37 INFO - PROCESS | 30915 | [#0] Richards Cycles:1 Average:166.86 Median:166.86 stddev:0.00 (0.0%) 20:09:37 INFO - PROCESS | 30915 | Values: 166.9 20:09:37 INFO - PROCESS | 30915 | 20:09:37 INFO - PROCESS | 30915 | [#1] DeltaBlue Cycles:1 Average:196.81 Median:196.81 stddev:0.00 (0.0%) 20:09:37 INFO - PROCESS | 30915 | Values: 196.8 20:09:37 INFO - PROCESS | 30915 | 20:09:37 INFO - PROCESS | 30915 | [#2] Encrypt Cycles:1 Average:284.66 Median:284.66 stddev:0.00 (0.0%) 20:09:37 INFO - PROCESS | 30915 | Values: 284.7 20:09:37 INFO - PROCESS | 30915 | 20:09:37 INFO - PROCESS | 30915 | [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 20:09:37 INFO - PROCESS | 30915 | Values: 5202.1 20:09:37 INFO - PROCESS | 30915 | 20:09:37 INFO - PROCESS | 30915 | [#4] RayTrace Cycles:1 Average:1098.90 Median:1098.90 stddev:0.00 (0.0%) 20:09:37 INFO - PROCESS | 30915 | Values: 1098.9 20:09:37 INFO - PROCESS | 30915 | 20:09:37 INFO - PROCESS | 30915 | [#5] Earley Cycles:1 Average:706.21 Median:706.21 stddev:0.00 (0.0%) 20:09:37 INFO - PROCESS | 30915 | Values: 706.2 20:09:37 INFO - PROCESS | 30915 | 20:09:37 INFO - PROCESS | 30915 | [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 20:09:37 INFO - PROCESS | 30915 | Values: 12243.9 20:09:37 INFO - PROCESS | 30915 | 20:09:37 INFO - PROCESS | 30915 | [#7] RegExp Cycles:1 Average:25400.00 Median:25400.00 stddev:0.00 (0.0%) 20:09:37 INFO - PROCESS | 30915 | Values: 25400.0 20:09:37 INFO - PROCESS | 30915 | 20:09:37 INFO - PROCESS | 30915 | [#8] Splay Cycles:1 Average:688.48 Median:688.48 stddev:0.00 (0.0%) 20:09:37 INFO - PROCESS | 30915 | Values: 688.5 20:09:37 INFO - PROCESS | 30915 | 20:09:37 INFO - PROCESS | 30915 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 20:09:37 INFO - PROCESS | 30915 | Values: 4840.6 20:09:37 INFO - PROCESS | 30915 | -------- Summary: end -------- 20:09:37 INFO - PROCESS | 30915 | 20:09:38 INFO - TEST-INFO | 30915: exit 0 20:09:38 INFO - TEST-OK | v8_7 | took 40211ms 20:09:38 INFO - SUITE-END | took 1210s 20:09:38 INFO - Completed test suite (00:20:11) 20:09:38 INFO - Working with test: dromaeo_css 20:09:38 INFO - Generating results file: dromaeo_css 20:09:38 INFO - Working with test: kraken 20:09:38 INFO - Generating results file: kraken 20:09:38 INFO - javascript benchmark 20:09:38 INFO - Working with test: v8_7 20:09:38 INFO - Generating results file: v8_7 20:09:38 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:09:38 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 20:09:38 INFO - process_Request line: dromaeo_css 6842.77 graph.html#tests=[[72,64,43]] 20:09:38 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:09:38 INFO - process_Request line: kraken 1530.60 graph.html#tests=[[232,64,43]] 20:09:38 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:09:38 INFO - process_Request line: v8_7 20904.84 graph.html#tests=[[230,64,43]] 20:09:38 INFO - RETURN: dromaeo_css: 6842.77 20:09:38 INFO - RETURN: kraken: 1530.60 20:09:38 INFO - RETURN: v8_7: 20904.84 20:09:38 INFO - javascript benchmark 20:09:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3121.7814752967292, 3155.274286914011, 3167.1132083016764, 3201.135693362791, 3208.7914285571437, 5175.948240517594, 5232.581393488521, 5261.86845328867, 5263.894722105556, 5266.499682530163, 5216.9478305216935, 5250.789968401259, 5272.973635131819, 5342.813001544947, 5353.116735738598, 4497.415336006315, 4792.376990991166, 4907.681000734959, 4927.778249978742, 4928.531789480012, 4731.929021064687, 4858.392700912386, 4884.023195360942, 4905.215165573509, 4907.852764417074, 4761.619070474354, 4793.041391721669, 4826.710397376133, 4850.490698476662, 4883.8779030524165, 4785.258284965801, 4796.2326027835725, 4813.278008298783, 4819.2530157825595, 4846.491118432549, 4736.8578942631775, 4798.424189097295, 4801.399825021872, 4834.226523756182, 4864.0515099555605, 5073.974630126826, 5077.771500282459, 5083.466236045199, 5119.539241468286, 5139.306193663882, 5648.124540696199, 5651.547876169897, 5664.886702265972, 5668.829935101953, 5682.119271512922, 5562.721863906829, 5721.370649228582, 5722.656640601535, 5725.799597014126, 5732.684702341369, 5273.789048438058, 5301.363836339626, 5359.5712343012465, 5366.597505187087, 5400.864978375572, 5819.709014549256, 5819.88360232793, 5852.531797456193, 5854.2096816930025, 5879.353271140171, 5434.212039254286, 5521.089020311684, 5648.51987581052, 5661.830145095653, 5663.716814159276, 5686.289213848269, 5773.249477567973, 5774.711264436762, 5776.624519406225, 5813.505852002542, 5594.440555944373, 5631.605787594829, 5636.577256705764, 5651.208830763697, 5651.350094739076, 5505.174223866452, 5551.9722401387735, 5606.0, 5635.436456354331, 5679.346875109332, 4411.735295882258, 4416.4037854889175, 4421.447319085114, 4457.8439754608435, 4462.955370446319, 3954.169624378855, 3958.3072962231495, 3959.1883663848844, 3966.900827479278, 3981.3828856527284, 5213.087709650796, 5320.787168513216, 5328.706921119376, 5329.227262046981, 5434.266374039454, 5683.857903552444, 5694.373618901917, 5699.5725320600295, 5701.458361455655, 5708.771649133988, 5310.495502927216, 5350.073295505496, 5350.892982140335, 5356.7321633918145, 5400.4599540046465, 4805.879853003633, 4894.11905856942, 4908.9263661045115, 4915.95084049155, 4992.500749924979, 5959.344472108065, 5965.671888046112, 5969.492593129633, 5973.761049557969, 5990.281166260077, 5761.135829625589, 5761.222234998306, 5763.279590051244, 5769.682667453162, 5771.59598828078, 5716.514096301861, 5743.310802703535, 5841.532677385714, 5851.795187168429, 5959.284885813557, 5529.115341545334, 5561.082421400423, 5565.972170139124, 5573.972130139324, 5583.4416558345465, 5536.197251398606, 5644.745986430538, 5695.373508914099, 5699.487046165865, 5699.572532060195, 5502.0921547944145, 5562.16567514876, 5628.296462942132, 5650.773969041356, 5691.231683722644, 5494.2857428534035, 5516.586256030733, 5531.751071201886, 5545.112781954868, 5546.306711661043, 5348.171033489815, 5445.101558243004, 5464.535514481314, 5467.425920278313, 5523.309586301712, 5555.722213889208, 5609.80365687199, 5622.634528755618, 5628.690422026664, 5633.0987042073075, 5395.730213489232, 5428.647137936022, 5437.945620543902, 5440.047991601375, 5446.019716451076], "unit": "score", "name": "dojo.html", "value": 5238.5048259471905}, {"lowerIsBetter": false, "replicates": [479.21887323662423, 517.0150862606733, 534.0467265930314, 550.7191332420466, 577.1775220311056, 28973.420531589356, 37430.62569374305, 37606.62393376065, 37975.24049519008, 38083.047923801954, 40376.79811600938, 41046.179076418455, 41109.0, 41109.0, 41141.38287925684, 8614.612342444605, 8748.60631271591, 8760.4305720128, 8775.341849361323, 8786.912130878705, 8448.23965843074, 8566.18621230982, 8568.314534837198, 8576.914230857705, 8578.699745508908, 8566.957165214166, 8592.699255526059, 8619.741407757745, 8647.092055334193, 8650.697225597105, 8441.57792110392, 8493.787655308604, 8506.064332923374, 8512.021117571465, 8535.445196062266, 8475.830483390358, 8616.0, 8644.308455323622, 8652.394332396734, 8805.383623146383, 39796.0, 39929.40105898414, 40327.0, 40422.79788601038, 40461.39307910384, 3278.2132288250887, 3463.428534291839, 3516.9120771980906, 3692.6307369263127, 3892.6107389260847, 27366.0, 28329.0, 28447.71552284471, 28479.145625631263, 28935.855320723473, 3521.29574085184, 3553.342631613134, 3722.050877026341, 3726.2174943261675, 3831.597682243352, 264823.0, 270144.0, 270340.999999998, 270632.0, 271051.0, 55997.72001139968, 57091.71454142703, 60765.69617151886, 63715.902727781664, 65339.34660653428, 57462.42537574654, 57502.13746793802, 57594.0, 57635.42364576385, 57723.0, 15573.688526229413, 15604.765928511082, 15715.371385144696, 15718.528444146694, 15771.684566308839, 11934.820977685342, 11948.701282467833, 11963.46164422603, 11993.460294286779, 12237.510499580096, 20775.480612984495, 21069.578608427746, 21149.894250528956, 21179.8941005294, 21199.576008479744, 7995.360371170293, 8224.241183139937, 8356.832863342699, 8472.44929079608, 8484.575771211537, 967.192394350711, 992.6972273456665, 997.6607953295769, 1053.984190237147, 1198.6523908066738, 31001.844990775353, 32577.511337329957, 32669.92412505468, 34246.48630270548, 34526.13684657904, 1069.005824583145, 1076.1982323169289, 1077.7251800790748, 1077.8598782158426, 1086.1419478611965, 14149.85850141506, 14149.929250353682, 14363.353649085817, 14382.208978506073, 14427.567172984827, 530201.0, 537991.0, 543044.0, 543234.0, 544707.0, 51878.74060629673, 52082.0, 52107.73946130245, 52171.30458258775, 52320.73839630854, 1339.8861096806686, 1345.0987838148465, 1345.1122259308809, 1358.5584684977619, 1371.1087792934673, 28709.42581148407, 30780.23049423782, 33295.83352083224, 34010.31979360349, 34374.48438273478, 51298.48701512937, 51869.48130518646, 51879.0, 52082.21876671777, 52100.739496302274, 293992.0, 296323.0, 297225.0, 297407.0, 297670.0, 41962.79018604887, 43078.56921430871, 43512.56487435085, 44579.777101115586, 44755.0, 39068.804655976535, 39800.2039959205, 40048.599514005655, 40132.59867401405, 40731.38902916518, 33428.832855835564, 35221.82389088141, 36953.44569831401, 37430.812845935594, 38133.237335253696, 36758.63241367552, 37015.81492092522, 38831.61168388393, 39695.60304396919, 40455.79772101121, 33448.0, 33571.664283356855, 33842.830785845916, 33903.0, 38917.80541097277, 29076.820920931976, 30183.245418864703, 31724.20689482689, 31857.522137168424, 31858.20354491156, 25035.248942531754, 25314.493710126062, 25486.74513254918, 25571.105011324515, 25620.359491012874], "unit": "score", "name": "ext.html", "value": 19026.25179024805}, {"lowerIsBetter": false, "replicates": [349.36415723383453, 349.3798507648923, 349.48974497234036, 349.6241540344129, 355.10159296978645, 16421.917890410547, 16683.749743753855, 17341.65316693667, 17455.21451534681, 18142.18360173792, 10747.731306717336, 11585.942070289637, 15786.684266314667, 15802.288896999635, 15820.129892855888, 4518.638508919287, 5031.748412579356, 5150.922736158961, 5186.299849520305, 5193.662411943212, 5133.743312834362, 5137.0, 5152.381714194302, 5473.7263136843, 5954.642721436706, 3669.1377526281435, 3771.4908487354132, 5890.5582081343855, 5892.587518873681, 5892.587518873681, 5167.922481162766, 5264.052470555299, 5265.131253343194, 5273.288106105684, 5335.519803217729, 5112.18205087188, 5136.43499215086, 5144.948550514484, 5145.0, 5248.343957005374, 12264.570740024146, 12662.240265584094, 12685.365731713377, 13468.0, 20827.8958605206, 2114.3551216878845, 2122.681597760333, 2171.576542574199, 2197.088208393515, 2272.8977196026217, 9533.47565883876, 9573.28200384974, 9628.759281017961, 11396.0, 13182.472701091945, 1838.5679365349133, 1843.64970655575, 1843.8199552286546, 1846.6675998320297, 1863.18951256204, 59041.40958590402, 59878.10182847261, 60357.698211508665, 61010.694946524985, 63079.68460157716, 9973.30186886911, 10194.133498652698, 10201.540930658139, 10215.599334156468, 10253.794924101476, 13121.868781312065, 13142.802857957138, 13166.144200626928, 13194.868051319556, 13224.743649353297, 7278.126624805057, 7287.0, 7332.96333518329, 7346.853062938711, 7363.852722945619, 6670.633115178614, 6671.232808227019, 6791.762288319885, 6799.898001529981, 6822.931770682229, 4170.791460426966, 4216.683748718859, 4230.259704551752, 4241.3637954307105, 4251.234777739975, 1820.8452281555951, 1854.3417086934214, 1872.2510995601867, 1886.141805478504, 1888.4051523770243, 426.2008733624454, 428.4301878501585, 865.8831057807241, 958.6261358070358, 1068.4283908109123, 9985.500724963722, 10249.12882405004, 10393.688189354332, 10494.108000819862, 10599.523021464052, 440.20762627270784, 441.62682533259346, 450.16494402882836, 451.4650139584537, 455.1307003623064, 5715.228444159985, 5744.425557444306, 5751.741171647286, 5753.88492230153, 5803.477687008105, 569454.0, 570730.0, 580216.0, 583290.0, 588447.0, 78565.60717196377, 81405.59297203594, 82834.0, 83977.58011210027, 84896.57551712202, 1177.617274385811, 1182.320165904591, 1191.2733232728028, 1203.789336866045, 1217.4825699078033, 15637.687246255238, 15648.687026259639, 15659.982101163389, 15862.920685396499, 15967.20163991819, 34533.0, 34843.0, 35140.12149696176, 35982.0, 36084.45873311955, 46242.30636540522, 46694.0, 48001.51998479971, 48193.0, 51484.0, 9312.906870931474, 9471.905280947103, 9560.28297877648, 9573.617055317987, 9586.28102892272, 11268.83096753533, 11348.319100853974, 11417.600383986854, 11510.59712910044, 11542.596009139976, 13915.0, 14408.0, 14480.058796178215, 14824.555263342118, 14923.626909327353, 13748.243846588533, 14295.499657511937, 14336.283185840875, 14412.927935360256, 14632.195229262066, 14622.34199461048, 14712.04371715835, 14764.040337378035, 14790.11259324444, 15012.324445399765, 8910.821783564423, 9263.397879137834, 9327.067293270618, 9336.533173341442, 9456.858147127661, 10109.64616238428, 12920.806187907001, 14194.43222271139, 14541.78187327212, 15228.314725837143], "unit": "score", "name": "jquery.html", "value": 8191.588022530528}, {"lowerIsBetter": false, "replicates": [1434.84216736159, 1445.8409574946754, 1599.2723310893546, 1742.7385892116174, 1764.541219282986, 6616.867662646744, 6731.999999999994, 6735.663216839163, 6773.322667733224, 6833.726650933957, 6753.223379311381, 6760.66196690166, 6821.1132552768195, 6825.795226143211, 6860.108185935821, 2110.187577782553, 2148.892555372233, 2155.558110587334, 2156.4069880782754, 2161.7838216178334, 2112.42964399612, 2146.399008277685, 2149.451889768107, 2165.7942495462985, 2176.4450065233423, 2066.7829877862832, 2094.507790669199, 2105.3052492677457, 2148.5380643161716, 2156.3423155937435, 2096.1929657082055, 2099.1078791513546, 2127.3405244374294, 2131.8614290071096, 2132.2856842957626, 2111.5882402931434, 2120.363890832744, 2124.575084982994, 2135.231316725977, 2136.77563855796, 6936.930630693679, 6969.58182509046, 6996.510244282902, 7002.229754726976, 7029.683664235071, 4267.701260911737, 4279.079997800457, 4333.609975102256, 4338.197433474817, 4339.435873336446, 2773.071021207898, 2783.151138902634, 2810.8313501189996, 2820.210341104494, 2836.9432611347866, 877.7191298784392, 930.5440334236243, 935.6210734652477, 953.6137864165024, 992.3053862296422, 8966.282697384258, 8981.05698901619, 8999.370044096915, 9000.729978100668, 9015.684451044182, 3632.5277713897553, 3649.2154186849425, 3818.121831978605, 3825.0628595993603, 3841.539015318124, 7521.4734968551675, 7547.962260188664, 7564.0, 7565.546067235983, 7570.356519695777, 4250.149970006011, 4265.7440553566885, 4279.315309550457, 4284.0, 4289.378040184156, 3937.8031098444962, 3939.803009849496, 3946.092398748304, 3947.0527073502153, 3972.3842804365368, 3123.687631236858, 3175.5712978747574, 3184.6815318467966, 3185.904422867318, 3198.200449887528, 932.883389576303, 950.3632566180676, 951.9143277104955, 952.7570469530225, 954.0650162840456, 1009.3287963504188, 1040.8126537223372, 1043.9634612788516, 1135.6271872538548, 1251.6870782304425, 6331.430171284606, 6395.072714456378, 6434.517411194179, 6462.0, 6469.5794773339585, 1128.954841806335, 1140.8745038045975, 1152.8616566011965, 1160.6460029691025, 1171.9531218751154, 5267.631265811433, 5281.815136470205, 5293.682379057269, 5296.417394086648, 5306.8407947761625, 7700.422468314899, 7831.373490120891, 7842.764717058498, 7907.2488113629115, 7920.168382319889, 7811.414143939227, 7889.21107889218, 7931.048274207132, 7936.920630793734, 7944.920550794418, 6273.937260627426, 6289.622622642748, 6360.045993101072, 6369.426751592379, 6381.904271435932, 6211.720472578835, 6222.253329600477, 6226.221722284715, 6230.43926046658, 6230.626162430269, 6894.724211031703, 6954.408875245661, 7105.467089968376, 7175.138983322035, 7182.17404998411, 7078.93815927615, 7232.493725439169, 7261.346478816932, 7263.273672632695, 7279.235680253497, 6244.281907580505, 6310.589811662411, 6338.334474880256, 6354.6822658867795, 6369.20384951881, 6578.80263592093, 6672.8999065013095, 6674.9332506676255, 6704.932950670431, 6775.4240889524945, 6100.328963814066, 6196.938030619816, 6214.689265536615, 6350.333215012357, 6371.649559274099, 5568.832935011957, 5640.689762062962, 5728.369879313189, 5926.199963005111, 6330.0, 6051.0923361496125, 6101.481374083075, 6115.84710382244, 6132.9080063799975, 6137.1101190328045, 5698.145278208136, 5720.656760594377, 5816.098504731774, 5905.704714764159, 5924.822255332347, 5870.26621672291, 5892.2929248488745, 5908.350081490947, 5913.91129133072, 5928.881422371443], "unit": "score", "name": "mootools.html", "value": 4021.1073765563874}, {"lowerIsBetter": false, "replicates": [327.13962279205685, 332.36352385182374, 336.67847205918343, 337.642099374663, 343.0908093552088, 6223.719932603032, 6225.657588832618, 6248.593841400318, 6254.812355629327, 6354.904676429857, 6120.602160859552, 6194.287656919456, 6205.0, 6225.5953363031485, 6267.968660156705, 4747.833825816106, 4757.476677565465, 4757.976210118944, 4759.071980963713, 4761.4763275751775, 4760.976195119037, 4767.404074490689, 4770.284457331393, 4775.617950563947, 4776.379070720802, 4592.517785632511, 4662.114198302312, 4669.556392142758, 4704.835330763424, 4717.339572459841, 4675.018246168309, 4680.625549955996, 4703.647226457995, 4705.952940470585, 4713.1987562114355, 4084.4894388201474, 4097.057676734368, 4100.036491424513, 4109.383592461125, 4121.773302468363, 5957.404259574051, 5964.254468191476, 5984.922713911495, 6000.099985002241, 6013.128096426038, 5362.410134885159, 5404.810831620914, 5450.618456708032, 5453.890922181534, 5474.042042642522, 6545.509086818508, 6573.57271777333, 6581.506387020992, 6586.604803711744, 6597.670116494156, 4518.209313370147, 4522.728636281834, 4526.366308716782, 4529.954700452986, 4530.954690453086, 6746.59520428771, 6823.761168359133, 6880.380765731108, 6895.55178913364, 6907.930920690779, 4561.817527298871, 4562.8631141065825, 4563.269876819693, 4567.840125595588, 4571.22289210835, 4614.054118905617, 4617.399738034102, 4619.838305659353, 4626.676132670748, 4627.95372046282, 5384.78460861569, 5394.62237643369, 5397.433269506645, 5400.756965936543, 5404.513593776579, 6470.741170353133, 6509.1863517060365, 6627.10534077903, 6628.801135965929, 6654.50091243149, 1638.0744879143247, 1660.5516510542086, 1660.8173100958884, 1660.8671306295466, 1662.9750553741703, 1091.6343025086526, 1094.715374002749, 1105.3699391346854, 1108.1024370260116, 1119.9496022679, 6253.812385628438, 6290.968545157245, 6304.054391841169, 6323.336049714714, 6335.239771227482, 6752.155980502437, 6825.215100263533, 6854.588724676535, 6856.897146542706, 6857.142857142857, 6252.374762523711, 6304.65324407162, 6316.747330106836, 6354.650494222862, 6390.329015453311, 3729.1609387887506, 3742.2702572998546, 3753.9436908446396, 3765.755225910362, 3767.1900541383734, 7169.89245161323, 7175.928240717526, 7204.351608355273, 7213.062301900719, 7251.1661158966335, 6948.444124470131, 7054.047703560056, 7083.716651333992, 7113.181984071794, 7115.71537138519, 7161.89257161143, 7208.495405321577, 7211.855762884713, 7214.855702885913, 7241.058662373857, 6846.931530684629, 6878.174619045746, 6899.241083480913, 6910.067140935909, 6913.2049814272, 6716.462682985447, 6830.18037835443, 6834.0, 6835.487338449537, 6836.863262734618, 7014.193367762568, 7027.489089845503, 7033.085698859116, 7038.40173585251, 7046.859062818818, 4608.815647374202, 4640.930386044144, 4641.466231383434, 4652.697574657636, 4657.184992626209, 6713.530052896251, 6918.342757438036, 6945.652717364213, 6946.652667366712, 6947.617881016593, 6724.193096828412, 6729.226138994079, 6737.797866064026, 6738.764143254963, 6754.12196414463, 6571.047198156145, 6687.230968438497, 6717.462602991651, 6721.260661327348, 6725.0, 6574.342565743387, 6579.605223686594, 6592.2089349276475, 6593.80218593443, 6619.966900165468, 6735.865282694221, 6742.0, 6762.661866906733, 6762.932370676427, 6772.729090836311, 6456.548041637228, 6581.177352830896, 6588.0, 6592.505562082767, 6596.67016649156], "unit": "score", "name": "prototype.html", "value": 4979.856456814341}, {"lowerIsBetter": false, "replicates": [832.1096426823294, 841.0874201491382, 855.2217482091296, 856.6915910272305, 865.2306034160146, 13180.934095329521, 13547.796783048263, 13572.864271357295, 13574.253416062113, 13605.727885442286, 12568.622941311774, 12952.611421657366, 12953.22280663161, 12955.935220323885, 13015.154014989042, 814.1898810683364, 834.2325060943916, 838.053000109875, 839.0895877972407, 840.5083026429546, 833.2500749325595, 839.039300001498, 840.7141571865565, 842.2756429470651, 843.3337663246028, 864.6584599083359, 871.0549054276119, 872.0, 872.8079822439054, 874.8993865705462, 861.719941019165, 866.2982983783156, 869.826034793044, 870.0777176193192, 871.5293741379647, 629.7764293675725, 637.0476138173414, 638.1544453598954, 638.8977763557808, 640.4844100499097, 13661.248631325274, 13718.38267277965, 13779.104358216784, 13788.241646709426, 13842.031057825956, 11914.344711040889, 11917.880821191764, 12372.690682732913, 12387.318697471635, 12548.874511254862, 10191.184705223564, 10414.218933580012, 10483.528241229164, 10568.418736969541, 10683.305585137019, 3613.8193090345376, 3674.669279764834, 3704.4072948328408, 3724.366857634209, 3781.867634632802, 44180.779096104314, 44775.0, 44812.327815083125, 44887.0, 45135.322970155474, 9584.952075239578, 9819.006095958035, 9836.21287833032, 9902.257330700226, 9929.65246216379, 17018.74471882898, 17031.744523832152, 17140.742888856676, 17172.0, 17260.74108888368, 7571.772846814604, 7689.846203075907, 7719.961400192963, 7787.610619469004, 7845.921540784633, 4276.743395396286, 4324.070324880166, 4328.870133895988, 4336.739795612273, 4353.608175264241, 3088.722015018659, 3100.5814215081127, 3124.515700066448, 3126.218445388653, 3135.451296023187, 576.4869266352949, 581.3866370978574, 590.1590233916652, 593.5785592229565, 597.0059850349206, 578.8494991302292, 583.4369833111068, 674.6896427643339, 680.7072958627838, 695.6382681005949, 7997.0, 8622.741317760478, 8668.306535477146, 8670.089640587774, 8691.652333906699, 658.2101478226148, 662.2053535757111, 686.3856848120904, 705.6683358821346, 718.5257729898242, 3700.9444858327147, 3739.3456145174487, 3751.4747935289083, 3817.2174704185577, 3948.072203032285, 55727.0, 55910.44089559134, 56003.71998139983, 56472.71763641156, 56854.43145568574, 49240.261396079084, 50475.24287135696, 50724.492755072715, 50958.23562646489, 51376.74311628418, 44871.55128448739, 45354.77322613366, 45515.54484455179, 45579.544204558195, 45837.0, 8076.676932922617, 8219.589020549069, 8288.58557072132, 8385.161483851565, 8395.790105247417, 33787.83106084454, 33811.323773524884, 33954.0, 34026.14934626654, 34599.4810077844, 39559.60440395674, 43405.78297108494, 44085.11829763323, 44506.0, 44626.330605040304, 9926.851097233692, 10036.698899033041, 10227.181825453798, 10761.192910531585, 10762.816090230224, 12320.383980801103, 12373.62879113628, 12448.502059917502, 12911.354432278536, 13249.337533123113, 10672.733181670521, 10803.459827008775, 10916.399598022184, 10961.232713710282, 11028.724281893017, 10898.400587967737, 11024.062954648623, 11026.062784663072, 11641.47613357384, 12042.578509752468, 10768.0, 11115.277506962022, 11149.665510034712, 11166.88833111691, 11381.0, 9643.855342169732, 9644.662436814679, 9649.903500965182, 9650.517474126405, 10079.193664506969, 8646.43798153118, 8906.643734250558, 8985.191332780081, 9046.864297035418, 9239.614057891371], "unit": "score", "name": "yui.html", "value": 6278.544390356262}], "name": "dromaeo_css", "value": 6842.772136567981}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 104.0, 111.0, 111.0, 111.0, 124.0, 110.0, 109.0, 111.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [156.0, 127.0, 158.0, 158.0, 132.0, 159.0, 151.0, 130.0, 162.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 146.7}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 163.0, 161.0, 162.0, 162.0, 160.0, 163.0, 169.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.7}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 73.0, 73.0, 75.0, 138.0, 71.0, 75.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 139.0, 96.0, 97.0, 95.0, 153.0, 97.0, 96.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 109.9}, {"lowerIsBetter": true, "replicates": [110.0, 114.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [149.0, 147.0, 148.0, 148.0, 147.0, 148.0, 148.0, 148.0, 149.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 96.0, 100.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [61.0, 59.0, 61.0, 59.0, 61.0, 61.0, 59.0, 60.0, 60.0, 60.0], "unit": "score", "name": "json-parse-financial", "value": 60.1}, {"lowerIsBetter": true, "replicates": [68.0, 72.0, 69.0, 69.0, 69.0, 69.0, 71.0, 69.0, 69.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [88.0, 95.0, 88.0, 89.0, 88.0, 89.0, 91.0, 88.0, 97.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 90.2}, {"lowerIsBetter": true, "replicates": [125.0, 132.0, 127.0, 121.0, 130.0, 123.0, 121.0, 125.0, 133.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.8}, {"lowerIsBetter": true, "replicates": [153.0, 153.0, 150.0, 150.0, 164.0, 142.0, 158.0, 158.0, 143.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.1}, {"lowerIsBetter": true, "replicates": [66.0, 70.0, 69.0, 69.0, 68.0, 70.0, 68.0, 70.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1530.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.86133822793258], "unit": "score", "name": "Richards", "value": 211.56488599999994}, {"lowerIsBetter": false, "replicates": [196.811651249754], "unit": "score", "name": "DeltaBlue", "value": 335.945558}, {"lowerIsBetter": false, "replicates": [284.6569883290635], "unit": "score", "name": "Encrypt", "value": 935.093853}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1098.901098901099], "unit": "score", "name": "RayTrace", "value": 673.3899900000001}, {"lowerIsBetter": false, "replicates": [706.2146892655368], "unit": "score", "name": "Earley", "value": 943.711608}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [25400.0], "unit": "score", "name": "RegExp", "value": 35.86555118110237}, {"lowerIsBetter": false, "replicates": [688.4798909338787], "unit": "score", "name": "Splay", "value": 118.36366039603962}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20904.838455879}]} 20:09:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20904.84"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1530.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6842.77"}}} 20:09:38 INFO - Return code: 0 20:09:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:09:38 INFO - # TBPL SUCCESS # 20:09:38 INFO - Running post-action listener: _resource_record_post_action 20:09:38 INFO - Running post-run listener: _resource_record_post_run 20:09:39 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 32768; Write bytes: 313761792; Read time: 148; Write time: 203048 20:09:39 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 475136; Read time: 0; Write time: 56 20:09:39 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 32768; Write bytes: 313286656; Read time: 148; Write time: 202992 20:09:39 INFO - Running post-run listener: _upload_blobber_files 20:09:39 INFO - Blob upload gear active. 20:09:39 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:09:39 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 20:09:39 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'] 20:09:39 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 20:09:40 INFO - (blobuploader) - INFO - Open directory for files ... 20:09:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:09:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:09:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:09:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:09:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:09:40 INFO - (blobuploader) - INFO - Done attempting. 20:09:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:09:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:09:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:09:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:09:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:09:41 INFO - (blobuploader) - INFO - Done attempting. 20:09:41 INFO - (blobuploader) - INFO - Iteration through files over. 20:09:41 INFO - Return code: 0 20:09:41 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:09:41 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:09:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d26ee385e38e776ba9d5cae8088b07b4708e4fad5a84310bedabb20eb04252a984aec45c907c78404ec01af269bf9fff4ecd10d741a393c4bd774f166e4fdfe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b4c6f4fc8c689336e814b2634109de49e971db1727fec836c021b0c995eb416ec8edfe104e2316ec90bfcbf0292d50f1cb4b87ae77c5297016064e22b96fa11"} 20:09:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:09:41 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:09:41 INFO - Contents: 20:09:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0d26ee385e38e776ba9d5cae8088b07b4708e4fad5a84310bedabb20eb04252a984aec45c907c78404ec01af269bf9fff4ecd10d741a393c4bd774f166e4fdfe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b4c6f4fc8c689336e814b2634109de49e971db1727fec836c021b0c995eb416ec8edfe104e2316ec90bfcbf0292d50f1cb4b87ae77c5297016064e22b96fa11"} 20:09:41 INFO - Copying logs to upload dir... 20:09:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1271.219058 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-29 20:09:41.518283) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 20:09:41.525797) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1451441964.903238-1452020180 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/0d26ee385e38e776ba9d5cae8088b07b4708e4fad5a84310bedabb20eb04252a984aec45c907c78404ec01af269bf9fff4ecd10d741a393c4bd774f166e4fdfe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b4c6f4fc8c689336e814b2634109de49e971db1727fec836c021b0c995eb416ec8edfe104e2316ec90bfcbf0292d50f1cb4b87ae77c5297016064e22b96fa11"} build_url:https://queue.taskcluster.net/v1/task/UAvIM4l2SL6IUTky90yILg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011303 build_url: 'https://queue.taskcluster.net/v1/task/UAvIM4l2SL6IUTky90yILg/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/0d26ee385e38e776ba9d5cae8088b07b4708e4fad5a84310bedabb20eb04252a984aec45c907c78404ec01af269bf9fff4ecd10d741a393c4bd774f166e4fdfe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b4c6f4fc8c689336e814b2634109de49e971db1727fec836c021b0c995eb416ec8edfe104e2316ec90bfcbf0292d50f1cb4b87ae77c5297016064e22b96fa11"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 20:09:41.554064) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 20:09:41.554429) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1451441964.903238-1452020180 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 20:09:41.634217) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 20:09:41.637577) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 20:09:41.637903) ========= ========= Total master_lag: 0.20 =========