builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1450865149.63 results: success (0) buildid: 20151222233014 builduid: 864bd7103c15478488c22704df3fdc5a revision: 9ad78f315cf7688e2f109061697a06fbfd8ed345 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-23 02:05:49.629879) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-23 02:05:49.630542) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-23 02:05:49.630841) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1450846249.248039-444150760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006403 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-23 02:05:49.658100) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-23 02:05:49.658396) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-23 02:05:49.689288) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 02:05:49.689590) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1450846249.248039-444150760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004645 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 02:05:49.742936) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-23 02:05:49.743524) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-23 02:05:49.743912) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 02:05:49.744203) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1450846249.248039-444150760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-23 02:05:50-- 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% 37.2M=0s 2015-12-23 02:05:50 (37.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179873 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 02:05:49.954428) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 02:05:49.954718) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1450846249.248039-444150760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017737 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 02:05:50.011324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 02:05:50.011699) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9ad78f315cf7688e2f109061697a06fbfd8ed345 --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 9ad78f315cf7688e2f109061697a06fbfd8ed345 --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=d16fe3a243cfe9e60ec7df77000001e0-1450846249.248039-444150760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-23 02:05:50,648 truncating revision to first 12 chars 2015-12-23 02:05:50,648 Setting DEBUG logging. 2015-12-23 02:05:50,648 attempt 1/10 2015-12-23 02:05:50,648 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9ad78f315cf7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-23 02:05:50,902 unpacking tar archive at: fx-team-9ad78f315cf7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.555424 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 02:05:50.583745) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-23 02:05:50.584044) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-23 02:05:50.593840) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-23 02:05:50.594105) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-23 02:05:50.594495) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-12-23 02:05:50.594779) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d16fe3a243cfe9e60ec7df77000001e0-1450846249.248039-444150760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:05:51 INFO - MultiFileLogger online at 20151223 02:05:51 in /builds/slave/test-pgo 02:05:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:05:51 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 02:05:51 INFO - {'append_to_log': False, 02:05:51 INFO - 'base_work_dir': '/builds/slave/test-pgo', 02:05:51 INFO - 'blob_upload_branch': 'Fx-Team', 02:05:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 02:05:51 INFO - 'branch': 'Fx-Team', 02:05:51 INFO - 'buildbot_json_path': 'buildprops.json', 02:05:51 INFO - 'config_files': ('talos/linux_config.py',), 02:05:51 INFO - 'default_actions': ('clobber', 02:05:51 INFO - 'read-buildbot-config', 02:05:51 INFO - 'download-and-extract', 02:05:51 INFO - 'populate-webroot', 02:05:51 INFO - 'create-virtualenv', 02:05:51 INFO - 'install', 02:05:51 INFO - 'run-tests'), 02:05:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:05:51 INFO - 'download_minidump_stackwalk': True, 02:05:51 INFO - 'download_symbols': 'ondemand', 02:05:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:05:51 INFO - 'tooltool.py': '/tools/tooltool.py', 02:05:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:05:51 INFO - '/tools/misc-python/virtualenv.py')}, 02:05:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:05:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:05:51 INFO - 'installer_path': 'installer.exe', 02:05:51 INFO - 'log_level': 'info', 02:05:51 INFO - 'log_name': 'talos', 02:05:51 INFO - 'log_to_console': True, 02:05:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:05:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:05:51 INFO - 'opt_config_files': (), 02:05:51 INFO - 'pip_index': False, 02:05:51 INFO - 'sps_profile': False, 02:05:51 INFO - 'sps_profile_interval': 0, 02:05:51 INFO - 'suite': 'dromaeojs', 02:05:51 INFO - 'system_bits': '64', 02:05:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:05:51 INFO - 'title': 'talos-linux64-ix-034', 02:05:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:05:51 INFO - 'use_talos_json': True, 02:05:51 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 02:05:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:05:51 INFO - 'work_dir': 'build'} 02:05:51 INFO - ##### 02:05:51 INFO - ##### Running clobber step. 02:05:51 INFO - ##### 02:05:51 INFO - Running pre-action listener: _resource_record_pre_action 02:05:51 INFO - Running main action method: clobber 02:05:51 INFO - rmtree: /builds/slave/test-pgo/build 02:05:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 02:05:52 INFO - Running post-action listener: _resource_record_post_action 02:05:52 INFO - ##### 02:05:52 INFO - ##### Running read-buildbot-config step. 02:05:52 INFO - ##### 02:05:52 INFO - Running pre-action listener: _resource_record_pre_action 02:05:52 INFO - Running main action method: read_buildbot_config 02:05:52 INFO - Using buildbot properties: 02:05:52 INFO - { 02:05:52 INFO - "project": "", 02:05:52 INFO - "product": "firefox", 02:05:52 INFO - "script_repo_revision": "production", 02:05:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:05:52 INFO - "repository": "", 02:05:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:05:52 INFO - "buildid": "20151222233014", 02:05:52 INFO - "pgo_build": "True", 02:05:52 INFO - "basedir": "/builds/slave/test-pgo", 02:05:52 INFO - "buildnumber": 557, 02:05:52 INFO - "slavename": "talos-linux64-ix-034", 02:05:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:05:52 INFO - "platform": "ubuntu64_hw", 02:05:52 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:05:52 INFO - "branch": "fx-team", 02:05:52 INFO - "repo_path": "integration/fx-team", 02:05:52 INFO - "revision": "9ad78f315cf7688e2f109061697a06fbfd8ed345", 02:05:52 INFO - "stage_platform": "linux64-pgo", 02:05:52 INFO - "builduid": "864bd7103c15478488c22704df3fdc5a", 02:05:52 INFO - "slavebuilddir": "test" 02:05:52 INFO - } 02:05:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/8y00M5PYQ3GSgBHURkjYTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 02:05:52 INFO - Running post-action listener: _resource_record_post_action 02:05:52 INFO - ##### 02:05:52 INFO - ##### Running download-and-extract step. 02:05:52 INFO - ##### 02:05:52 INFO - Running pre-action listener: _resource_record_pre_action 02:05:52 INFO - Running main action method: download_and_extract 02:05:52 INFO - mkdir: /builds/slave/test-pgo/build/tests 02:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:05:52 INFO - https://queue.taskcluster.net/v1/task/8y00M5PYQ3GSgBHURkjYTA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:05:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8y00M5PYQ3GSgBHURkjYTA/artifacts/public/build/test_packages.json 02:05:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8y00M5PYQ3GSgBHURkjYTA/artifacts/public/build/test_packages.json 02:05:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8y00M5PYQ3GSgBHURkjYTA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 02:05:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8y00M5PYQ3GSgBHURkjYTA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 02:05:57 INFO - Downloaded 1302 bytes. 02:05:57 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 02:05:57 INFO - Using the following test package requirements: 02:05:57 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:05:57 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:05:57 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:57 INFO - u'jsshell-linux-x86_64.zip'], 02:05:57 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:05:57 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:05:57 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:05:57 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:05:57 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:05:57 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:05:57 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:05:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:05:57 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:05: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')]} 02:05:57 INFO - https://queue.taskcluster.net/v1/task/8y00M5PYQ3GSgBHURkjYTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:05:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8y00M5PYQ3GSgBHURkjYTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:05:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8y00M5PYQ3GSgBHURkjYTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:05:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8y00M5PYQ3GSgBHURkjYTA/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 02:05:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8y00M5PYQ3GSgBHURkjYTA/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 02:06:05 INFO - Downloaded 23176158 bytes. 02:06:05 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 02:06:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:06:05 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 02:06:06 INFO - Return code: 0 02:06:06 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 02:06:06 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')]} 02:06:06 INFO - https://queue.taskcluster.net/v1/task/8y00M5PYQ3GSgBHURkjYTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:06:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8y00M5PYQ3GSgBHURkjYTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:06:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8y00M5PYQ3GSgBHURkjYTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:06:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8y00M5PYQ3GSgBHURkjYTA/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 02:06:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8y00M5PYQ3GSgBHURkjYTA/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 02:06:08 INFO - Downloaded 23176158 bytes. 02:06:08 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 02:06:08 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:06:08 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 02:06:09 INFO - Return code: 0 02:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:09 INFO - https://queue.taskcluster.net/v1/task/8y00M5PYQ3GSgBHURkjYTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:06:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8y00M5PYQ3GSgBHURkjYTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:06:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8y00M5PYQ3GSgBHURkjYTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:06:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8y00M5PYQ3GSgBHURkjYTA/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 02:06:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8y00M5PYQ3GSgBHURkjYTA/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 02:06:10 INFO - Downloaded 11132277 bytes. 02:06:10 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 02:06:10 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:06:10 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 02:06:10 INFO - Return code: 0 02:06:10 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')]} 02:06:10 INFO - https://queue.taskcluster.net/v1/task/8y00M5PYQ3GSgBHURkjYTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:06:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8y00M5PYQ3GSgBHURkjYTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:06:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8y00M5PYQ3GSgBHURkjYTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:06:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8y00M5PYQ3GSgBHURkjYTA/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 02:06:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/8y00M5PYQ3GSgBHURkjYTA/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 02:06:11 INFO - Downloaded 54932762 bytes. 02:06:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/8y00M5PYQ3GSgBHURkjYTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:06:11 INFO - mkdir: /builds/slave/test-pgo/properties 02:06:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 02:06:11 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 02:06:11 INFO - Contents: 02:06:11 INFO - build_url:https://queue.taskcluster.net/v1/task/8y00M5PYQ3GSgBHURkjYTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:06:11 INFO - Running post-action listener: _resource_record_post_action 02:06:11 INFO - Running post-action listener: set_extra_try_arguments 02:06:11 INFO - ##### 02:06:11 INFO - ##### Running populate-webroot step. 02:06:11 INFO - ##### 02:06:11 INFO - Running pre-action listener: _resource_record_pre_action 02:06:11 INFO - Running main action method: populate_webroot 02:06:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:06:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:06:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:06:11 INFO - '--tppagecycles', 02:06:11 INFO - '7'], 02:06:11 INFO - 'tests': ['tsvgm']}}, 02:06:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:06:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:06:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:06:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:06:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:06:11 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:06:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:06:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:11 INFO - 'talos_options': ['--e10s'], 02:06:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:06:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:11 INFO - 'tests': ['damp', 'tps']}, 02:06:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:11 INFO - 'talos_options': ['--e10s'], 02:06:11 INFO - 'tests': ['damp', 'tps']}, 02:06:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:06:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:06:11 INFO - 'other': {'tests': ['a11yr', 02:06:11 INFO - 'ts_paint', 02:06:11 INFO - 'tpaint', 02:06:11 INFO - 'sessionrestore', 02:06:11 INFO - 'sessionrestore_no_auto_restore']}, 02:06:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:06:11 INFO - 'tests': ['a11yr', 02:06:11 INFO - 'ts_paint', 02:06:11 INFO - 'tpaint', 02:06:11 INFO - 'sessionrestore', 02:06:11 INFO - 'sessionrestore_no_auto_restore']}, 02:06:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:06:11 INFO - 'tests': ['a11yr', 02:06:11 INFO - 'ts_paint', 02:06:11 INFO - 'tpaint', 02:06:11 INFO - 'sessionrestore', 02:06:11 INFO - 'sessionrestore_no_auto_restore']}, 02:06:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:06:11 INFO - 'tests': ['a11yr', 02:06:11 INFO - 'ts_paint', 02:06:11 INFO - 'tpaint', 02:06:11 INFO - 'sessionrestore', 02:06:11 INFO - 'sessionrestore_no_auto_restore']}, 02:06:11 INFO - 'other_l64': {'tests': ['a11yr', 02:06:11 INFO - 'ts_paint', 02:06:11 INFO - 'tpaint', 02:06:11 INFO - 'sessionrestore', 02:06:11 INFO - 'sessionrestore_no_auto_restore']}, 02:06:11 INFO - 'other_nol64': {'tests': ['a11yr', 02:06:11 INFO - 'ts_paint', 02:06:11 INFO - 'tpaint', 02:06:11 INFO - 'sessionrestore', 02:06:11 INFO - 'sessionrestore_no_auto_restore']}, 02:06:11 INFO - 'svgr': {'tests': ['tsvgx', 02:06:11 INFO - 'tsvgr_opacity', 02:06:11 INFO - 'tart', 02:06:11 INFO - 'tscrollx', 02:06:11 INFO - 'cart']}, 02:06:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:06:11 INFO - 'tests': ['tsvgx', 02:06:11 INFO - 'tsvgr_opacity', 02:06:11 INFO - 'tart', 02:06:11 INFO - 'tscrollx', 02:06:11 INFO - 'cart']}, 02:06:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:11 INFO - 'tests': ['tp5o']}, 02:06:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:11 INFO - 'talos_options': ['--e10s'], 02:06:11 INFO - 'tests': ['tp5o']}, 02:06:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:11 INFO - 'talos_options': ['--xperf_path', 02:06:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:06:11 INFO - 'tests': ['tp5n']}, 02:06:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:11 INFO - 'talos_options': ['--e10s', 02:06:11 INFO - '--xperf_path', 02:06:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:06:11 INFO - 'tests': ['tp5n']}}, 02:06:11 INFO - 'talos.zip': {'path': '', 02:06:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:06:11 INFO - Running post-action listener: _resource_record_post_action 02:06:11 INFO - ##### 02:06:11 INFO - ##### Running create-virtualenv step. 02:06:11 INFO - ##### 02:06:11 INFO - Running pre-action listener: _resource_record_pre_action 02:06:11 INFO - Running main action method: create_virtualenv 02:06:11 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 02:06:11 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 02:06:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 02:06:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:06:11 INFO - Using real prefix '/usr' 02:06:11 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 02:06:12 INFO - Installing distribute.............................................................................................................................................................................................done. 02:06:14 INFO - Installing pip.................done. 02:06:14 INFO - Return code: 0 02:06:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 02:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9030d2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1541840>, '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 0x14ae6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aeb60>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450846249.248039-444150760', '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 02:06:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 02:06:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:06:14 INFO - Using env: {'DISPLAY': ':0', 02:06:14 INFO - 'HOME': '/home/cltbld', 02:06:14 INFO - 'LANG': 'en_US.UTF-8', 02:06:14 INFO - 'LANGUAGE': 'en_US:en', 02:06:14 INFO - 'LOGNAME': 'cltbld', 02:06:14 INFO - 'MAIL': '/var/mail/cltbld', 02:06:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:14 INFO - 'MOZ_NO_REMOTE': '1', 02:06:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:14 INFO - 'NO_EM_RESTART': '1', 02:06:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:14 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:14 INFO - 'SHELL': '/bin/bash', 02:06:14 INFO - 'SHLVL': '1', 02:06:14 INFO - 'TERM': 'linux', 02:06:14 INFO - 'TMOUT': '86400', 02:06:14 INFO - 'USER': 'cltbld', 02:06:14 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450846249.248039-444150760', 02:06:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:14 INFO - '_': '/tools/buildbot/bin/python'} 02:06:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:14 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 02:06:14 INFO - Cleaning up... 02:06:14 INFO - Return code: 0 02:06:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 02:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9030d2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1541840>, '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 0x14ae6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aeb60>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450846249.248039-444150760', '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 02:06:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 02:06:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:06:14 INFO - Using env: {'DISPLAY': ':0', 02:06:14 INFO - 'HOME': '/home/cltbld', 02:06:14 INFO - 'LANG': 'en_US.UTF-8', 02:06:14 INFO - 'LANGUAGE': 'en_US:en', 02:06:14 INFO - 'LOGNAME': 'cltbld', 02:06:14 INFO - 'MAIL': '/var/mail/cltbld', 02:06:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:14 INFO - 'MOZ_NO_REMOTE': '1', 02:06:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:14 INFO - 'NO_EM_RESTART': '1', 02:06:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:14 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:14 INFO - 'SHELL': '/bin/bash', 02:06:14 INFO - 'SHLVL': '1', 02:06:14 INFO - 'TERM': 'linux', 02:06:14 INFO - 'TMOUT': '86400', 02:06:14 INFO - 'USER': 'cltbld', 02:06:14 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450846249.248039-444150760', 02:06:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:14 INFO - '_': '/tools/buildbot/bin/python'} 02:06:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:14 INFO - Downloading/unpacking psutil>=0.7.1 02:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:16 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 02:06:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:06:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 02:06:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:06:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:06:16 INFO - Installing collected packages: psutil 02:06:16 INFO - Running setup.py install for psutil 02:06:16 INFO - building 'psutil._psutil_linux' extension 02:06:16 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 02:06:16 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 02:06:16 INFO - building 'psutil._psutil_posix' extension 02:06:16 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 02:06:16 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 02:06:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:06:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:06:16 INFO - Successfully installed psutil 02:06:16 INFO - Cleaning up... 02:06:16 INFO - Return code: 0 02:06:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 02:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:16 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 0x7f9030d2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1541840>, '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 0x14ae6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aeb60>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450846249.248039-444150760', '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 02:06:16 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 02:06:16 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 02:06:16 INFO - Using env: {'DISPLAY': ':0', 02:06:16 INFO - 'HOME': '/home/cltbld', 02:06:16 INFO - 'LANG': 'en_US.UTF-8', 02:06:16 INFO - 'LANGUAGE': 'en_US:en', 02:06:16 INFO - 'LOGNAME': 'cltbld', 02:06:16 INFO - 'MAIL': '/var/mail/cltbld', 02:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:16 INFO - 'MOZ_NO_REMOTE': '1', 02:06:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:16 INFO - 'NO_EM_RESTART': '1', 02:06:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:16 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:16 INFO - 'SHELL': '/bin/bash', 02:06:16 INFO - 'SHLVL': '1', 02:06:16 INFO - 'TERM': 'linux', 02:06:16 INFO - 'TMOUT': '86400', 02:06:16 INFO - 'USER': 'cltbld', 02:06:16 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450846249.248039-444150760', 02:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:16 INFO - '_': '/tools/buildbot/bin/python'} 02:06:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:06:17 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 02:06:17 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 02:06:17 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 02:06:17 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 02:06:17 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 02:06:17 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 02:06:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:06:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:06:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:06:18 INFO - Installing collected packages: mozsystemmonitor 02:06:18 INFO - Running setup.py install for mozsystemmonitor 02:06:18 INFO - Successfully installed mozsystemmonitor 02:06:18 INFO - Cleaning up... 02:06:19 INFO - Return code: 0 02:06:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 02:06:19 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')]} 02:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:19 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')]} 02:06:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:19 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 0x7f9030d2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1541840>, '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 0x14ae6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aeb60>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450846249.248039-444150760', '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 02:06:19 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 02:06:19 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 02:06:19 INFO - Using env: {'DISPLAY': ':0', 02:06:19 INFO - 'HOME': '/home/cltbld', 02:06:19 INFO - 'LANG': 'en_US.UTF-8', 02:06:19 INFO - 'LANGUAGE': 'en_US:en', 02:06:19 INFO - 'LOGNAME': 'cltbld', 02:06:19 INFO - 'MAIL': '/var/mail/cltbld', 02:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:19 INFO - 'MOZ_NO_REMOTE': '1', 02:06:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:19 INFO - 'NO_EM_RESTART': '1', 02:06:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:19 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:19 INFO - 'SHELL': '/bin/bash', 02:06:19 INFO - 'SHLVL': '1', 02:06:19 INFO - 'TERM': 'linux', 02:06:19 INFO - 'TMOUT': '86400', 02:06:19 INFO - 'USER': 'cltbld', 02:06:19 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450846249.248039-444150760', 02:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:19 INFO - '_': '/tools/buildbot/bin/python'} 02:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:19 INFO - Downloading/unpacking blobuploader==1.2.4 02:06:19 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 02:06:19 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 02:06:19 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 02:06:19 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 02:06:19 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 02:06:19 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 02:06:20 INFO - Downloading blobuploader-1.2.4.tar.gz 02:06:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:06:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:06:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:06:20 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 02:06:20 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 02:06:20 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 02:06:20 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 02:06:20 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 02:06:20 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 02:06:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:06:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 02:06:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:06:21 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 02:06:21 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 02:06:21 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 02:06:21 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 02:06:21 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 02:06:21 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 02:06:21 INFO - Downloading docopt-0.6.1.tar.gz 02:06:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:06:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 02:06:21 INFO - Installing collected packages: blobuploader, requests, docopt 02:06:21 INFO - Running setup.py install for blobuploader 02:06:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:06:21 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 02:06:21 INFO - Running setup.py install for requests 02:06:22 INFO - Running setup.py install for docopt 02:06:22 INFO - Successfully installed blobuploader requests docopt 02:06:22 INFO - Cleaning up... 02:06:22 INFO - Return code: 0 02:06:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:06:22 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')]} 02:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:22 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')]} 02:06:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:22 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 0x7f9030d2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1541840>, '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 0x14ae6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aeb60>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450846249.248039-444150760', '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 02:06:22 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 02:06:22 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 02:06:22 INFO - Using env: {'DISPLAY': ':0', 02:06:22 INFO - 'HOME': '/home/cltbld', 02:06:22 INFO - 'LANG': 'en_US.UTF-8', 02:06:22 INFO - 'LANGUAGE': 'en_US:en', 02:06:22 INFO - 'LOGNAME': 'cltbld', 02:06:22 INFO - 'MAIL': '/var/mail/cltbld', 02:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:22 INFO - 'MOZ_NO_REMOTE': '1', 02:06:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:22 INFO - 'NO_EM_RESTART': '1', 02:06:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:22 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:22 INFO - 'SHELL': '/bin/bash', 02:06:22 INFO - 'SHLVL': '1', 02:06:22 INFO - 'TERM': 'linux', 02:06:22 INFO - 'TMOUT': '86400', 02:06:22 INFO - 'USER': 'cltbld', 02:06:22 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450846249.248039-444150760', 02:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:22 INFO - '_': '/tools/buildbot/bin/python'} 02:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:06:22 INFO - Running setup.py (path:/tmp/pip-RRKUeB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:06:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:06:22 INFO - Running setup.py (path:/tmp/pip-6P2Xtq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:06:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:06:22 INFO - Running setup.py (path:/tmp/pip-_zzKfK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:06:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:06:22 INFO - Running setup.py (path:/tmp/pip-Etj729-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:06:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:06:22 INFO - Running setup.py (path:/tmp/pip-YUXOpG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:06:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:06:22 INFO - Running setup.py (path:/tmp/pip-6sPCyF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:06:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:06:22 INFO - Running setup.py (path:/tmp/pip-3MkRKa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:06:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:06:22 INFO - Running setup.py (path:/tmp/pip-vGMCFp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:06:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:06:22 INFO - Running setup.py (path:/tmp/pip-txkuiz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:06:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:06:23 INFO - Running setup.py (path:/tmp/pip-WKypoJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:06:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:06:23 INFO - Running setup.py (path:/tmp/pip-pCuLoy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:06:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:06:23 INFO - Running setup.py (path:/tmp/pip-MHRjZG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:06:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:06:23 INFO - Running setup.py (path:/tmp/pip-w4FthH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:06:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:06:23 INFO - Running setup.py (path:/tmp/pip-bNizwR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:06:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:06:23 INFO - Running setup.py (path:/tmp/pip-B4VELx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:06:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:06:23 INFO - Running setup.py (path:/tmp/pip-57gwvr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:06:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:06:23 INFO - Running setup.py (path:/tmp/pip-KpnJXE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:06:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:06:23 INFO - Running setup.py install for manifestparser 02:06:23 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 02:06:23 INFO - Running setup.py install for mozcrash 02:06:23 INFO - Running setup.py install for mozdebug 02:06:23 INFO - Running setup.py install for mozdevice 02:06:24 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 02:06:24 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 02:06:24 INFO - Running setup.py install for mozfile 02:06:24 INFO - Running setup.py install for mozhttpd 02:06:24 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 02:06:24 INFO - Running setup.py install for mozinfo 02:06:24 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 02:06:24 INFO - Running setup.py install for mozInstall 02:06:24 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 02:06:24 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 02:06:24 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 02:06:24 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 02:06:24 INFO - Running setup.py install for mozleak 02:06:24 INFO - Running setup.py install for mozlog 02:06:24 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 02:06:24 INFO - Running setup.py install for moznetwork 02:06:24 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 02:06:24 INFO - Running setup.py install for mozprocess 02:06:24 INFO - Running setup.py install for mozprofile 02:06:24 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 02:06:24 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 02:06:24 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 02:06:24 INFO - Running setup.py install for mozrunner 02:06:25 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 02:06:25 INFO - Running setup.py install for mozscreenshot 02:06:25 INFO - Running setup.py install for moztest 02:06:25 INFO - Running setup.py install for mozversion 02:06:25 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 02:06:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:06:25 INFO - Cleaning up... 02:06:25 INFO - Return code: 0 02:06:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:06: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')]} 02:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06: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')]} 02:06:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:25 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 0x7f9030d2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1541840>, '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 0x14ae6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aeb60>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450846249.248039-444150760', '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 02:06:25 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 02:06:25 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 02:06:25 INFO - Using env: {'DISPLAY': ':0', 02:06:25 INFO - 'HOME': '/home/cltbld', 02:06:25 INFO - 'LANG': 'en_US.UTF-8', 02:06:25 INFO - 'LANGUAGE': 'en_US:en', 02:06:25 INFO - 'LOGNAME': 'cltbld', 02:06:25 INFO - 'MAIL': '/var/mail/cltbld', 02:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:25 INFO - 'MOZ_NO_REMOTE': '1', 02:06:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:25 INFO - 'NO_EM_RESTART': '1', 02:06:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:25 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:25 INFO - 'SHELL': '/bin/bash', 02:06:25 INFO - 'SHLVL': '1', 02:06:25 INFO - 'TERM': 'linux', 02:06:25 INFO - 'TMOUT': '86400', 02:06:25 INFO - 'USER': 'cltbld', 02:06:25 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450846249.248039-444150760', 02:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:25 INFO - '_': '/tools/buildbot/bin/python'} 02:06:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:06:25 INFO - Running setup.py (path:/tmp/pip-fh6LWX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:06:25 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)) 02:06:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:06:25 INFO - Running setup.py (path:/tmp/pip-DZtlUH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:06:25 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)) 02:06:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:06:25 INFO - Running setup.py (path:/tmp/pip-GOviot-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:06:25 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)) 02:06:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:06:25 INFO - Running setup.py (path:/tmp/pip-ettdNa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:06:25 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)) 02:06:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:06:25 INFO - Running setup.py (path:/tmp/pip-j_9UdX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:06:25 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)) 02:06:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:06:25 INFO - Running setup.py (path:/tmp/pip-B2kThV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:06:26 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)) 02:06:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:06:26 INFO - Running setup.py (path:/tmp/pip-BYJ4_C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:06:26 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)) 02:06:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:06:26 INFO - Running setup.py (path:/tmp/pip-83xhis-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:06:26 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)) 02:06:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:06:26 INFO - Running setup.py (path:/tmp/pip-dmmF9o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:06:26 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)) 02:06:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:06:26 INFO - Running setup.py (path:/tmp/pip-qRlzLA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:06:26 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)) 02:06:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:06:26 INFO - Running setup.py (path:/tmp/pip-hkhwxB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:06:26 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)) 02:06:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:06:26 INFO - Running setup.py (path:/tmp/pip-MOlekO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:06:26 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)) 02:06:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:06:26 INFO - Running setup.py (path:/tmp/pip-FvjlZU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:06:26 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)) 02:06:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:06:26 INFO - Running setup.py (path:/tmp/pip-jKnF3I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:06:26 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)) 02:06:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:06:26 INFO - Running setup.py (path:/tmp/pip-VA1xJg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:06:26 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)) 02:06:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:06:26 INFO - Running setup.py (path:/tmp/pip-9JaoCi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:06:26 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)) 02:06:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:06:26 INFO - Running setup.py (path:/tmp/pip-aYmlCk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:06:26 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)) 02:06:26 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)) 02:06:26 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)) 02:06:26 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)) 02:06:26 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)) 02:06:26 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)) 02:06:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 02:06:26 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 02:06:26 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 02:06:26 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 02:06:26 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 02:06:26 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 02:06:26 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 02:06:28 INFO - Downloading blessings-1.5.1.tar.gz 02:06:28 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 02:06:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 02:06:28 INFO - Installing collected packages: blessings 02:06:28 INFO - Running setup.py install for blessings 02:06:28 INFO - Successfully installed blessings 02:06:28 INFO - Cleaning up... 02:06:28 INFO - Return code: 0 02:06:28 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 02:06:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:06:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:06:28 INFO - Reading from file tmpfile_stdout 02:06:28 INFO - Current package versions: 02:06:28 INFO - argparse == 1.2.1 02:06:28 INFO - blessings == 1.5.1 02:06:28 INFO - blobuploader == 1.2.4 02:06:28 INFO - docopt == 0.6.1 02:06:28 INFO - manifestparser == 1.1 02:06:28 INFO - mozInstall == 1.12 02:06:28 INFO - mozcrash == 0.16 02:06:28 INFO - mozdebug == 0.1 02:06:28 INFO - mozdevice == 0.47 02:06:28 INFO - mozfile == 1.2 02:06:28 INFO - mozhttpd == 0.7 02:06:28 INFO - mozinfo == 0.9 02:06:28 INFO - mozleak == 0.1 02:06:28 INFO - mozlog == 3.1 02:06:28 INFO - moznetwork == 0.27 02:06:28 INFO - mozprocess == 0.22 02:06:28 INFO - mozprofile == 0.28 02:06:28 INFO - mozrunner == 6.11 02:06:28 INFO - mozscreenshot == 0.1 02:06:28 INFO - mozsystemmonitor == 0.0 02:06:28 INFO - moztest == 0.7 02:06:28 INFO - mozversion == 1.4 02:06:28 INFO - psutil == 3.1.1 02:06:28 INFO - requests == 1.2.3 02:06:28 INFO - wsgiref == 0.1.2 02:06:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:06:28 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')]} 02:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:28 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')]} 02:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:28 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 0x7f9030d2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1541840>, '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 0x14ae6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aeb60>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450846249.248039-444150760', '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 02:06:28 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 02:06:28 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 02:06:28 INFO - Using env: {'DISPLAY': ':0', 02:06:28 INFO - 'HOME': '/home/cltbld', 02:06:28 INFO - 'LANG': 'en_US.UTF-8', 02:06:28 INFO - 'LANGUAGE': 'en_US:en', 02:06:28 INFO - 'LOGNAME': 'cltbld', 02:06:28 INFO - 'MAIL': '/var/mail/cltbld', 02:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:28 INFO - 'MOZ_NO_REMOTE': '1', 02:06:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:28 INFO - 'NO_EM_RESTART': '1', 02:06:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:28 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:28 INFO - 'SHELL': '/bin/bash', 02:06:28 INFO - 'SHLVL': '1', 02:06:28 INFO - 'TERM': 'linux', 02:06:28 INFO - 'TMOUT': '86400', 02:06:28 INFO - 'USER': 'cltbld', 02:06:28 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450846249.248039-444150760', 02:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:28 INFO - '_': '/tools/buildbot/bin/python'} 02:06:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:29 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)) 02:06:29 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)) 02:06:29 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)) 02:06:29 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)) 02:06:29 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)) 02:06:29 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)) 02:06:29 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)) 02:06:29 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)) 02:06:29 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)) 02:06:29 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)) 02:06:29 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)) 02:06:29 INFO - Cleaning up... 02:06:29 INFO - Return code: 0 02:06:29 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 02:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9030d2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1541840>, '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 0x14ae6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aeb60>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450846249.248039-444150760', '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 02:06:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 02:06:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:06:29 INFO - Using env: {'DISPLAY': ':0', 02:06:29 INFO - 'HOME': '/home/cltbld', 02:06:29 INFO - 'LANG': 'en_US.UTF-8', 02:06:29 INFO - 'LANGUAGE': 'en_US:en', 02:06:29 INFO - 'LOGNAME': 'cltbld', 02:06:29 INFO - 'MAIL': '/var/mail/cltbld', 02:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:29 INFO - 'MOZ_NO_REMOTE': '1', 02:06:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:29 INFO - 'NO_EM_RESTART': '1', 02:06:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:29 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:29 INFO - 'SHELL': '/bin/bash', 02:06:29 INFO - 'SHLVL': '1', 02:06:29 INFO - 'TERM': 'linux', 02:06:29 INFO - 'TMOUT': '86400', 02:06:29 INFO - 'USER': 'cltbld', 02:06:29 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450846249.248039-444150760', 02:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:29 INFO - '_': '/tools/buildbot/bin/python'} 02:06:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:29 INFO - Downloading/unpacking jsonschema 02:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:06:31 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 02:06:31 INFO - Downloading/unpacking functools32 (from jsonschema) 02:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:31 INFO - Downloading functools32-3.2.3-2.tar.gz 02:06:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 02:06:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 02:06:31 INFO - warning: no files found matching '*.txt' 02:06:31 INFO - no previously-included directories found matching 'build' 02:06:31 INFO - no previously-included directories found matching 'dist' 02:06:31 INFO - no previously-included directories found matching '.git*' 02:06:31 INFO - Installing collected packages: jsonschema, functools32 02:06:31 INFO - Running setup.py install for functools32 02:06:31 INFO - warning: no files found matching '*.txt' 02:06:31 INFO - no previously-included directories found matching 'build' 02:06:31 INFO - no previously-included directories found matching 'dist' 02:06:31 INFO - no previously-included directories found matching '.git*' 02:06:31 INFO - Successfully installed jsonschema functools32 02:06:31 INFO - Cleaning up... 02:06:31 INFO - Return code: 0 02:06:31 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 02:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:31 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9030d2af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1541840>, '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 0x14ae6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aeb60>, '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': 'd16fe3a243cfe9e60ec7df77000001e0-1450846249.248039-444150760', '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 02:06:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 02:06:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:06:31 INFO - Using env: {'DISPLAY': ':0', 02:06:31 INFO - 'HOME': '/home/cltbld', 02:06:31 INFO - 'LANG': 'en_US.UTF-8', 02:06:31 INFO - 'LANGUAGE': 'en_US:en', 02:06:31 INFO - 'LOGNAME': 'cltbld', 02:06:31 INFO - 'MAIL': '/var/mail/cltbld', 02:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:31 INFO - 'MOZ_NO_REMOTE': '1', 02:06:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:31 INFO - 'NO_EM_RESTART': '1', 02:06:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:31 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:31 INFO - 'SHELL': '/bin/bash', 02:06:31 INFO - 'SHLVL': '1', 02:06:31 INFO - 'TERM': 'linux', 02:06:31 INFO - 'TMOUT': '86400', 02:06:31 INFO - 'USER': 'cltbld', 02:06:31 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450846249.248039-444150760', 02:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:31 INFO - '_': '/tools/buildbot/bin/python'} 02:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:31 INFO - Downloading/unpacking flake8 02:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:06:33 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 02:06:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:06:33 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 02:06:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:33 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 02:06:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 02:06:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 02:06:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:06:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:06:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:06:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:06:34 INFO - no previously-included directories found matching 'docs/_build' 02:06:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:06:34 INFO - Running setup.py install for pep8 02:06:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:06:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:06:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:06:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:06:34 INFO - no previously-included directories found matching 'docs/_build' 02:06:34 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 02:06:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:06:34 INFO - Cleaning up... 02:06:34 INFO - Return code: 0 02:06:34 INFO - Running post-action listener: _resource_record_post_action 02:06:34 INFO - Running post-action listener: _start_resource_monitoring 02:06:34 INFO - Starting resource monitoring. 02:06:34 INFO - ##### 02:06:34 INFO - ##### Running install step. 02:06:34 INFO - ##### 02:06:34 INFO - Running pre-action listener: _resource_record_pre_action 02:06:34 INFO - Running main action method: install 02:06:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:06:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:06:34 INFO - Reading from file tmpfile_stdout 02:06:34 INFO - Detecting whether we're running mozinstall >=1.0... 02:06:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 02:06:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 02:06:34 INFO - Reading from file tmpfile_stdout 02:06:34 INFO - Output received: 02:06:34 INFO - Usage: mozinstall [options] installer 02:06:34 INFO - Options: 02:06:34 INFO - -h, --help show this help message and exit 02:06:34 INFO - -d DEST, --destination=DEST 02:06:34 INFO - Directory to install application into. [default: 02:06:34 INFO - "/builds/slave/test-pgo"] 02:06:34 INFO - --app=APP Application being installed. [default: firefox] 02:06:34 INFO - mkdir: /builds/slave/test-pgo/build/application 02:06:34 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'] 02:06:34 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 02:06:50 INFO - Reading from file tmpfile_stdout 02:06:50 INFO - Output received: 02:06:50 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 02:06:50 INFO - Running post-action listener: _resource_record_post_action 02:06:50 INFO - ##### 02:06:50 INFO - ##### Running run-tests step. 02:06:50 INFO - ##### 02:06:50 INFO - Running pre-action listener: _resource_record_pre_action 02:06:50 INFO - Running main action method: run_tests 02:06:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 02:06:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 02:06:50 INFO - Python 2.7.3 02:06:50 INFO - Return code: 0 02:06:50 INFO - grabbing minidump binary from tooltool 02:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:50 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 0x1541840>, '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 0x14ae6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aeb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 02:06:50 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 02:06:50 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 02:06:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:06:50 INFO - Return code: 0 02:06:50 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 02:06:50 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 02:06:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 02:06:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 02:06:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 02:06:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 02:06:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 02:06:51 INFO - Return code: 0 02:06:51 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/8y00M5PYQ3GSgBHURkjYTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 02:06:51 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/8y00M5PYQ3GSgBHURkjYTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 02:06:51 INFO - Using env: {'DISPLAY': ':0', 02:06:51 INFO - 'HOME': '/home/cltbld', 02:06:51 INFO - 'LANG': 'en_US.UTF-8', 02:06:51 INFO - 'LANGUAGE': 'en_US:en', 02:06:51 INFO - 'LOGNAME': 'cltbld', 02:06:51 INFO - 'MAIL': '/var/mail/cltbld', 02:06:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:06:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 02:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:51 INFO - 'MOZ_NO_REMOTE': '1', 02:06:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:51 INFO - 'NO_EM_RESTART': '1', 02:06:51 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:06:51 INFO - 'PWD': '/builds/slave/test-pgo', 02:06:51 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 02:06:51 INFO - 'SHELL': '/bin/bash', 02:06:51 INFO - 'SHLVL': '1', 02:06:51 INFO - 'TERM': 'linux', 02:06:51 INFO - 'TMOUT': '86400', 02:06:51 INFO - 'USER': 'cltbld', 02:06:51 INFO - 'XDG_SESSION_COOKIE': 'd16fe3a243cfe9e60ec7df77000001e0-1450846249.248039-444150760', 02:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:51 INFO - '_': '/tools/buildbot/bin/python'} 02:06:51 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/8y00M5PYQ3GSgBHURkjYTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:06:51 INFO - mozversion application_buildid: 20151222233014 02:06:51 INFO - mozversion application_changeset: 9ad78f315cf7688e2f109061697a06fbfd8ed345 02:06:51 INFO - mozversion application_display_name: Nightly 02:06:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:06:51 INFO - mozversion application_name: Firefox 02:06:51 INFO - mozversion application_remotingname: firefox 02:06:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:06:51 INFO - mozversion application_vendor: Mozilla 02:06:51 INFO - mozversion application_version: 46.0a1 02:06:51 INFO - mozversion platform_buildid: 20151222233014 02:06:51 INFO - mozversion platform_changeset: 9ad78f315cf7688e2f109061697a06fbfd8ed345 02:06:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:06:51 INFO - mozversion platform_version: 46.0a1 02:06:51 INFO - using testdate: 1450865211 02:06:51 INFO - actual date: 1450865211 02:06:51 INFO - starting webserver on 'localhost:44813' 02:06:51 INFO - SUITE-START | Running 3 tests 02:06:51 INFO - TEST-START | dromaeo_css 02:06:51 INFO - operating with platform_type : linux_ 02:06:51 INFO - Initialising browser for dromaeo_css test... 02:06:51 INFO - TEST-INFO | started process 4300 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuBeDe_/profile http://localhost:44813/getInfo.html) 02:06:56 INFO - PROCESS | 4300 | __metrics Screen width/height:1600/1200 02:06:56 INFO - PROCESS | 4300 | colorDepth:24 02:06:56 INFO - PROCESS | 4300 | Browser inner width/height: 1024/697 02:06:56 INFO - PROCESS | 4300 | __metrics 02:06:56 INFO - PROCESS | 4300 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:06:56 INFO - PROCESS | 4300 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:06:57 INFO - TEST-INFO | 4300: exit 0 02:06:57 INFO - Browser initialized. 02:06:57 INFO - Running cycle 1/1 for dromaeo_css test... 02:06:57 INFO - TEST-INFO | started process 4394 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuBeDe_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:07:09 INFO - PROCESS | 4394 | RSS: Main: 150007808 02:07:09 INFO - PROCESS | 4394 | 02:08:01 INFO - PROCESS | 4394 | 1450865281296 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] 02:10:10 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:44813/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44813/tests/dromaeo/cssquery-ext.html) 02:10:11 INFO - PROCESS | 4394 | RSS: Main: 279298048 02:10:11 INFO - PROCESS | 4394 | 02:13:13 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:44813/tests/dromaeo/cssquery-ext.html (next: http://localhost:44813/tests/dromaeo/cssquery-jquery.html) 02:13:14 INFO - PROCESS | 4394 | RSS: Main: 225808384 02:13:14 INFO - PROCESS | 4394 | 02:16:16 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:44813/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44813/tests/dromaeo/cssquery-mootools.html) 02:16:16 INFO - PROCESS | 4394 | RSS: Main: 225456128 02:16:16 INFO - PROCESS | 4394 | 02:19:18 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:44813/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44813/tests/dromaeo/cssquery-prototype.html) 02:19:19 INFO - PROCESS | 4394 | RSS: Main: 210558976 02:19:19 INFO - PROCESS | 4394 | 02:22:21 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:44813/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44813/tests/dromaeo/cssquery-yui.html) 02:22:22 INFO - PROCESS | 4394 | RSS: Main: 217399296 02:22:22 INFO - PROCESS | 4394 | 02:25:24 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:44813/tests/dromaeo/cssquery-yui.html (next: http://localhost:44813/tests/dromaeo/cssquery-dojo.html) 02:25:25 INFO - PROCESS | 4394 | RSS: Main: 247971840 02:25:25 INFO - PROCESS | 4394 | 02:25:25 INFO - PROCESS | 4394 | __start_tp_report 02:25:25 INFO - PROCESS | 4394 | _x_x_mozilla_page_load 02:25:25 INFO - PROCESS | 4394 | _x_x_mozilla_page_load_details 02:25:25 INFO - PROCESS | 4394 | |i|pagename|runs| 02:25:25 INFO - PROCESS | 4394 | |0;dojo.html;3082.475979083556;3158.4314823331792;3178.6026746656653;3202.487601983683;3231.7414606831458;5021.748912554372;5132.615053870956;5227.3465816772905;5303.310569625948;5327.493888080631;5248.396434410034;5280.419153893069;5352.304200453946;5374.355077390718;5407.459254074601;4888.755562221883;4946.5795407390415;4963.1810751226;4982.153033984213;4987.251912213161;4792.424909010923;4922.114019476493;4947.282644016615;4992.631447483452;5008.424031236418;4773.618110551165;4819.180739274297;4829.227323628238;4830.830920917786;4898.4366797818175;4774.116788394123;4792.281157826319;4794.5684888359865;4812.350332705075;4814.470408255089;4751.073540659573;4846.345743324641;4863.902721945577;4868.78090485929;4907.362042934431;5111.923321150186;5152.562032227265;5197.220416937452;5217.530422262014;5240.895182096375;5763.394843541451;5765.6540607563265;5772.653640781525;5772.8845423091725;5775.537956963475;5637.774489020475;5769.624974376652;5789.652620842763;5792.913106303409;5805.216295800055;5299.682019078868;5399.514043736043;5409.43200963897;5415.864603384947;5451.37309209442;5874.441928016831;5877.177195192677;5889;5890;5894.528437725057;5555.1667249912025;5661.150827375926;5709.571782116358;5713.028785106542;5714.200011998323;5607.383187849333;5631.380548139701;5698.3162020556965;5741.712914354265;5745.425457454221;5731.799387021434;5736.4550367715;5739.311282646109;5743.913841292384;5749.712514374348;5742.626729262668;5746.195532625436;5747.626404283708;5748.45389687979;5749.511291540266;4352.238358287351;4373.147236288957;4427.468703755506;4446.710963787344;4458.219811532968;3920.8235629396745;3958.1094253793244;3963.0884896473394;3994.960050399517;4001.4397984282223;5304.336957880265;5411;5411.891762164734;5417.729113544307;5422.8373148805595;5788.479036886701;5801.970990145022;5837.591368604157;5856.560757943172;5934.13954976526;5370.489803468664;5383.461653834664;5383.730813459311;5386.299781028441;5388.326459192601;4970.975145124251;4989.950100499022;4997.0505603935135;5009.874753131201;5035.471275516092;5880.176775251468;5886.293644762571;5979.162917191684;5990.430909063719;6026.879462410815;5857.560682948882;5857.7949771757785;5860.326062502696;5861.882762344644;5865.208196893364;5701.800436984686;5829;5937;5945.821625351246;5946.375630558729;5593.524550413261;5633.042382795016;5668.404817494104;5705.857353566194;5707.1724599933605;5732.541396688338;5764.654120752601;5769.192313076257;5779.2775903012125;5783.739731712168;5460.645058071213;5591.384947655836;5640.802571909963;5649.802256920988;5652.85867853307;5576.163575463713;5617.494425501724;5630.324361076697;5639.436056394327;5674.460926212003;5576.553875689854;5579.330480342385;5586.581006424616;5587.385387607279;5604.775808967759;5451.073317535949;5663.716814159358;5680.488756011979;5696;5699.2590963174525;5391.757370918396;5446.074167391474;5459.754311056092;5499.092649712913;5514.751836167462 02:25:25 INFO - PROCESS | 4394 | |1;ext.html;559.3288054334797;609.4454046817394;614.3518587889778;614.4776939601337;616.3620652624535;29745.405091898177;30475.238119047033;38045.99999999996;38369;38398;43182.784086079606;43210.351844722354;43478.78260608693;43674.34488482675;43732.3440148398;8596.183362580545;8754.299656027502;8780;8781.912180878206;8808.779780505507;7759.41804364672;7934.246246606564;10478.161747060218;10739.087177589876;10740.570377184942;10348.379097254152;10427.530761115768;10438.164946804276;10441.84337234942;10448.32085914413;7792.571408572526;7952.681892724284;10333.689989300334;10424.218183636181;10437.321574097736;10424.478776061242;10689.946550267277;10691.251612387136;10697;10704.197185211062;39228.80385598083;39599.8020009901;39601;39609.20781584381;39680;3260.8858689945973;3288.342331533679;3337.516060171286;3631.5823680276844;4127.236461254677;29720.40559188804;30338.696613033808;30422.391552169054;30555;30588.847055764578;3900.8533116619183;3954.683625309997;3979.920401591981;4068.186362727437;4100.528439229497;264628;264920.9999999981;264955;264977;265924;58069.70965145147;59037;60758.69620651868;60808;61169.38830611637;71156.81696604956;71797.2820271801;72197.63901180461;72216.63891680508;72238.97012873391;13050.412731427108;13228.603141905758;13231.338433078308;13236.338183090807;13245.139065960682;9048.864267036;9260.166585007382;9915.851262231072;10075.34510256831;10251.692449226535;20650.690239646417;20754.792452075286;20859.1656333748;20889.582208355747;20933.476663083242;7964.20357964199;8012.799680008046;8055.556944367999;8067.475614085183;8104.675812967415;876.609908590671;908.5775114571755;938.1228551304553;1054.641421916552;1059.2955684469741;26756.59865102025;27042.188734338;31823.363532729214;32702.509462358084;32728.672713273038;956.9856452153223;999.8750156230471;1046.9162467002623;1118.1055155875267;1120.5181771838188;14672.899532535102;14846.554603361916;14869.553913382615;15006.249687515581;15022.173780441963;371849;376381;379266;379606;380777;52315.73842130841;52840.73579632154;52873.735631322364;52887.73556132272;53013.73493132587;1263.090574786134;1271.2245530226555;1276.4383671184648;1288.8066789981578;1310.1614966421498;27470.5879411805;28347.574786378635;28391.716082839732;28448.146555603365;28645.28386790347;45477.317840231764;46270.305945410175;46301.07397851957;46322.30516542187;46349.07301854011;297649;298968;299344;299683;299720;27482.587761183997;30758.231044224074;30826.229344266572;30994.690053100083;31402.842985784926;37789.4331585032;39341.40987885127;39432.6056739429;39709.631940485946;40078.59921400749;27691.307717306423;27759.44481110326;27839;27889.70843027605;28069;32507.18732031718;32612;32846.507302390004;33071.50392744159;33931.15172120618;29871.103866884027;30301.24246893757;33616;34556.13609659779;34896.65103348934;25961.037608083694;30555;35770;37273.627263727016;37873.431898522096;24742.50514989726;24841;24858;25111.623325649765;25261 02:25:25 INFO - PROCESS | 4394 | |2;jquery.html;356.69502575298134;365.26763838503797;365.6161030917537;367.95584529856416;370.73307218802455;13295.335233238347;13641.658958526017;16461.917690411545;17219.139043047846;18488;12975.805362919564;15786.131762753044;16093;16113.194340282967;16200.027998320109;5343.679379237248;5495.038368285554;5499.780008799643;5500.669959802404;5502.202180683798;3941.2117576484675;4037.7577345359227;5304.283921670563;5460.262864513299;5772.3361813391575;5856.795012174574;5888;5891.970540147293;5906.704664766766;5911.674857882815;5752.338481074688;5860.062390017598;5957.642541447527;5960.344362120163;5966.8209953701025;5209.661372010845;5241.711705856176;5259.605529585297;5263.894722105537;5268.947310526884;19647.803521964885;20486.38540843777;20491;20587.07358168886;21220.151193952224;2131.2753663754397;2131.6163090643677;2226.265332440291;2255.9661605075935;2279.6922415474032;13308.467661293536;13342.799858002138;13487.86512134876;13549.458021679122;13794;1832.4869036669754;1846.455295687762;1877.6244751049708;1878.0703551741838;1883.0961138653522;59039;59550.40449595492;59942.70028649872;62162.37837621656;62719.60962732565;9709.223262139012;9879.555420006118;9939.204863610894;10016.348937319051;10019.949900250453;12931.224126552437;13073.869261307455;13116.278604676643;13120.60638180856;13128.540501082416;7046.823829404203;7056.682449289794;7082.291770822876;7113.57318560888;7149.499535032498;6608.669566521751;6623.370779775913;6647.966760166169;6677.465802735769;6723.731050758012;5876.236089308448;5902.911456328158;5952.077427998581;5960.582759206901;5997.250343707036;1660.0703605980689;1715.5882588178997;1732.774739283885;1750.599520383688;1783.3401641392768;885.5616469847466;901.4005686218723;904.8506996345661;919.2416256588341;1057.5505410200633;17052.31790728357;17525.211365488583;17605.559861003578;17835;17940.55148621295;852.3224036890687;924.6763632728491;930.316217580078;964.4984608003939;1011.4083261292079;9624.422534647943;10079.34484258521;10138.341007834468;10295;10355.534000969974;520918;525422;529342;530701;532499;67586.66206669033;72053.2794672057;72233;72557;74004;1113.6937342230951;1121.5513794482108;1121.747606788466;1125.25437931447;1137.9146564007733;15873.68252634964;15968.600784980468;16161.254020893633;16174.595635109217;16397;34595.82702086474;35577.28845423129;36161;36264.09339766527;36306.63693363138;44221.55778442174;44576.10847783091;44769.776151120335;44879.32681009853;45140.42008529686;9261;9569.282303827102;9642.373245739005;9645.614175432904;9658.951705241428;17810.198541065423;17962.82037179664;18147.27410903549;18156.909215454365;18406.079696014876;14958.850411495745;15044;15076.773848392064;15122.470713524974;15198.696026079637;14764.48324308644;14767.704645906806;14770.556883293519;14804.703905922037;15363.539093827203;11859.466324015268;14956.700865982837;15031.624209394415;15282;15745.763813542577;8156.877646835421;9158.129977652112;9665.613375465184;9688.12806847387;9801.068898454636;13831.723365532433;13961.650958726113;14032.649183770487;14291.499797507038;14558.41766329335 02:25:25 INFO - PROCESS | 4394 | |3;mootools.html;1512.553796629994;1693.4580934101086;1737.5048111288281;1745.6820100823877;1776.9555761105971;6426.582272152313;7416.592087435189;7512.849743005137;7518.661660225289;7528.435367347443;7412.444066695006;7584.734534291301;7584.924150758491;7586.658600362983;7612.314891659749;1917.932872349468;1941.4272789527054;2202.2402271216406;2203.8347123965727;2238.675392068149;2239.529698763262;2242.473018840571;2243.753187149412;2248.4828489447436;2248.8313376496744;2173.858699184556;2254.977450225493;2257.2099765082253;2258.54829034193;2260.0846657103816;2219.1789038055863;2247.640177692497;2260.2089268755967;2261.8190544756544;2274.1812947339026;2259.4916143867663;2276.0326861083972;2290.6678531612824;2303.2974942642486;2307.1348244408346;7628.160902300742;7643.350315223157;7671.884921726179;7692.499987500794;7709.845803083963;4532.0709254602725;4566.589006989387;4573.679842411033;4614.2617181250835;4645.070985802819;2868.6270784797844;2949.9115026549025;2970.9851450742826;2997.4904266274566;3002.6847181045896;914.2503147419119;923.1138107416821;938.3009657804911;940.9764755881089;968.5157421289356;10382.221333400024;10403.11573516252;10426.895731042745;10434.321769084985;10446.947765261126;3956.7428117172867;3999.6000399960353;4001.15975645112;4036.979815100906;4085.97957010219;8867.73396798097;8884.511351875708;8893.333000024895;8895.4662720237;8907.198352148338;4498.05540836428;4513.1650644630845;4518;4536.637069034469;4562.908741825145;4129.2773764591075;4134.772587507716;4139.668826493873;4141.958580414218;4142.984968682692;3157.8105313681253;3206.7755257132244;3292.6378098409155;3323.5014747788027;3427.246005878703;1107.6123356825046;1111.77208672222;1112.2270022334562;1115.4701516779628;1116.2911551165068;1004.3672486333563;1051.2641151194196;1271.0721173543366;1292.6315999939973;1295.4494339905502;7089.326513981164;7135.82160445993;7137.179224389158;7144.321289477595;7180.1742799578715;1082.258652822819;1083.842842787807;1093.294824837991;1103.475848971748;1113.8941800528937;5550.16747487872;5650.180723795027;5658.91511627326;5661.490465858093;5669.858253543694;8975.461472311683;9061.637534498677;9181.449113053239;9182.724518264462;9274.536273186448;9042.050584688644;9077.183053525214;9165.908340916505;9195.724128276162;9197.264218862474;6907.378335949788;7136.92863071373;7150.5352152109945;7150.892736608955;7201.747938822116;6896.310368963063;6926.688299026455;6935.89596156048;6945.027696122446;6946.270641582561;7999.32005779492;8226.218509241613;8269.131741167332;8272.462289951134;8273.255407013397;8287.917120828715;8363.749087527383;8374.83250335002;8543.957280213808;8546.2308392245;6777.830554236183;6803.047573339637;6838.93161068383;6861.142357205349;6864.4554975130195;6447.3552644735155;6542.901856472062;6962.025316455802;7020.543664661781;7373.225811289737;6896.7586134485055;6988.825279367853;7036.964815176096;7060.505764596429;7075.858482830417;6743.15710536183;6743.5953842769595;6824.897626535705;6896.517243792886;6901.033855260167;6845.520813543004;6852.177738671391;6898.724051038103;6900.413464855343;6904.3095690430555;6214.689265536615;6218.22272215973;6228.626282423069;6339.619622822645;6345.016522439029;6392.68036598159;6419.165508483868;6426.068220108152;6436.195475565554;6436.259830119596 02:25:25 INFO - PROCESS | 4394 | |4;prototype.html;332.18283023761546;335.35611625678695;340.18695318189526;341.70101161483717;342.0610424385063;5748.310202775662;5871.970640146798;5873.0896711009755;5895.557833162514;5920.911186332209;5656.519195868346;5843.620164689292;5844.064949608063;5850.3564607893095;5869.060950247961;4548.295014272777;4548.704334218265;4551.067031258584;4557.316402539613;4563.0873825235085;4324.6107850293465;4401.05377343871;4443.066955939256;4521.819127234907;4552.385427967231;4507.706999045068;4517.028838799657;4523.479799823013;4524.592786649201;4527.954720452803;4512.684112112121;4516.525764794682;4520.254158063915;4538;4545.318202269653;3995.300822356076;3997.98001009996;4003.919921601552;4005.35914253718;4016;5504.779808807642;5626.971865140648;5629.296337957755;5650.982823091842;5689.6017278790505;5232.790688372461;5237.947620523784;5241.213817927303;5242.18746094356;5250.6324557281005;5922.674252916088;6249.250089989185;6253.249610046778;6259.561830671855;6265.780697675605;4262.595053469915;4267.210566045292;4368.36658684489;4377.321515165123;4379.5182529921685;6394.104825324458;6435.099086127946;6445.419912207877;6469.54157420182;6487.772927947546;4442.73343599385;4448.021435284232;4449.13241917823;4449.221386257456;4451.866444006685;4429;4467.508574056851;4505.144022635689;4506.1663592235545;4535.455745310584;5206;5208.801975545645;5214.009338225725;5215.269862219292;5220.086484865134;6257.687115644199;6263.029230469285;6263.498920086382;6265.843353916098;6271.341509141565;1575.6139745762362;1576.3064251729202;1578.2661062605714;1578.4396539228637;1579.3603590545847;1054.3726482742757;1067.0876400677464;1070.1652710885521;1076.2036093291065;1087.6465148826662;5989.431004054608;6003.549733769984;6008.489278411296;6011.0382338825575;6016.157737916695;6451.032345148265;6457.128287681103;6464.870702585922;6468.320826313264;6468.417842394113;5991.460768530853;6001.609895356788;6005.429484198994;6007.579469437185;6012.278526576839;3417.9829100854336;3513.1041584395816;3515.54297941266;3519.419295816213;3522.542069530996;6622.834429139214;6628.734850606018;6637.800865973932;6647.368499992493;6674.666266686646;6706.5640733352175;6708.83227919306;6713.798586042427;6719;6725.39471447572;6440.194975628046;6630.701618427182;6632.469402447792;6641.236257830315;6643.966780166068;6227.906581401192;6355;6512.706928188148;6521.8695626088165;6534.705938232696;6280.466160376236;6425.710843012169;6447.451966582893;6455.709493072917;6466.159399278064;6610.8016759497295;6616.305287944889;6625.635590042401;6630.30381809903;6630.801075967729;4440.711353761995;4456.108778244299;4468.195724769573;4476.194285028726;4477.888052798706;6380.489560835215;6396.744130234739;6400;6432.871342573216;6484.578502397329;6287.30839607652;6289.088082228142;6299.685015749286;6301.212348456443;6315;6204.875902481835;6205.441510264098;6265.874682506415;6272.686365681607;6300.716467759054;6162.075688646739;6173.32093469727;6180.7527698891545;6181.196444462191;6189.319174890668;6303.590266632654;6314.936850631435;6318.08387783778;6322.620642761265;6325.778597749057;6068.332483426731;6082.6046306991675;6163.476104530986;6163.9383606163365;6173.938260617337 02:25:25 INFO - PROCESS | 4394 | |5;yui.html;687.6762232702048;699.8180473076999;726.2301959922482;806.0649646410162;858.5149390594314;12821.807672884914;13367.131136476122;13427.865721342809;13501.864981350183;13551.593452196425;12038.277703337784;12063.336516491589;12071.698207544816;12107.878921210786;12144.757104857898;676.5399528320739;685.1777866560122;808.385626923538;828.2752591482453;843.173689784012;835.365122506893;835.8286551256978;840.5293035899886;841.7474757572704;844.7930257087022;719.2088702427341;879.5030807593721;886.5921676029002;886.6586364249746;886.9157430044168;731.0824914732004;863.2101627011277;880.0275695356603;880.8326417980563;880.9823803523958;631.8957372033655;641.3426238105932;642.0465608571315;642.2357394700339;642.5277421095491;13318.600441986757;13377.933110334387;13378.063535552516;13457.259850708208;13484.528041518597;10791.83812242817;11240.381779002151;11917.642470725892;12105;12255.69360765979;10662;10765.407902565355;10782.083522900562;10802.189835762349;10812.837807432894;3641.217138315275;3683.28176005679;3694.722895782827;3702.389105797567;3821.197548514815;46642.5335746645;46956.29565556485;47247.29129063067;47293.76353118247;48113.27830082586;9775.853362199572;9824.95087524572;9860.704178874645;9860.852087218698;9934.652287170058;18368.63262734738;18488.260469581335;18512.629747404975;18546.350877719215;18569.350072747387;7437.665305061285;7479.139898911695;7571.621418929031;7609;7663.425243106789;4197.265478541304;4244.087521182961;4275.3800698898485;4313.137372525507;4321.373400856858;2839.5314773062214;2890.5664150377193;2892.291388609762;2892.9276768080967;2893.146521776081;522.8274669359103;532.8321578702696;540.5810496864882;556.3824155187739;565.4119715495921;592.7747455966705;621.7606221604624;625.3621306267581;634.5494698763837;669.136813510566;8480.575971201415;8518.701845435504;8527.40308178434;8783.956080219557;9555.665551705657;549.4231057389725;558.9166530405952;606.7360698096343;661.4146480364816;668.3416834418094;3794.772313661189;4220.556841531595;4429.424174857248;4478.843240486567;4487.394201782783;57779;57814.7109264451;57866.132008019915;57880.4211957875;57892.71053644705;51433;54159.45840541544;54872;55055.174172387444;55428.722856386266;47638;48038.27942580864;48283.27575086306;49216;49401;8384.245417912172;8426.747197584082;8448.91551084506;8466.238038576557;8530.10433904456;33435;34066.489002665476;34088.65911340855;34238.14404639904;34470.31059378848;43680;44297;48142.51857481521;48692;48808.75595621999;10926.235163538477;11108.739993746918;11223.775524489627;11350.318980861175;11411.714707132389;12153.513859445877;12674.429650665927;12677.936610316889;12819.423125959167;13410.195388276734;11667.894621557862;11727.061835053346;11971.64085077449;12043.711694777965;12349.3825308736;11332.263402878787;11499.195056345976;11787.292762434281;11794.882051179378;12501.374931253218;7872;10433.113185379329;10500.894991050298;11438.656840294805;11725.941370293094;9641.325107242426;9842.852357214791;9861.408315501092;9878.259130565093;10386.169106471312;9091.590878410356;9168.587413566538;9361.157495825408;9513.429194248367;10074.016439230894 02:25:25 INFO - PROCESS | 4394 | __end_tp_report 02:25:25 INFO - PROCESS | 4394 | __start_cc_report 02:25:25 INFO - PROCESS | 4394 | _x_x_mozilla_cycle_collect,1000 02:25:25 INFO - PROCESS | 4394 | __end_cc_report 02:25:25 INFO - PROCESS | 4394 | __startTimestamp1450866325091__endTimestamp 02:25:25 INFO - PROCESS | 4394 | 02:25:25 INFO - PROCESS | 4394 | ------- Summary: start ------- 02:25:25 INFO - PROCESS | 4394 | Number of tests: 6 02:25:25 INFO - PROCESS | 4394 | 02:25:25 INFO - PROCESS | 4394 | [#0] dojo.html Cycles:165 Average:5331.20 Median:5555.17 stddev:599.96 (10.8%) stddev-sans-first:575.28 02:25:25 INFO - PROCESS | 4394 | Values: 3082.5 3158.4 3178.6 3202.5 3231.7 5021.7 5132.6 5227.3 5303.3 5327.5 5248.4 5280.4 5352.3 5374.4 5407.5 4888.8 4946.6 4963.2 4982.2 4987.3 4792.4 4922.1 4947.3 4992.6 5008.4 4773.6 4819.2 4829.2 4830.8 4898.4 4774.1 4792.3 4794.6 4812.4 4814.5 4751.1 4846.3 4863.9 4868.8 4907.4 5111.9 5152.6 5197.2 5217.5 5240.9 5763.4 5765.7 5772.7 5772.9 5775.5 5637.8 5769.6 5789.7 5792.9 5805.2 5299.7 5399.5 5409.4 5415.9 5451.4 5874.4 5877.2 5889.0 5890.0 5894.5 5555.2 5661.2 5709.6 5713.0 5714.2 5607.4 5631.4 5698.3 5741.7 5745.4 5731.8 5736.5 5739.3 5743.9 5749.7 5742.6 5746.2 5747.6 5748.5 5749.5 4352.2 4373.1 4427.5 4446.7 4458.2 3920.8 3958.1 3963.1 3995.0 4001.4 5304.3 5411.0 5411.9 5417.7 5422.8 5788.5 5802.0 5837.6 5856.6 5934.1 5370.5 5383.5 5383.7 5386.3 5388.3 4971.0 4990.0 4997.1 5009.9 5035.5 5880.2 5886.3 5979.2 5990.4 6026.9 5857.6 5857.8 5860.3 5861.9 5865.2 5701.8 5829.0 5937.0 5945.8 5946.4 5593.5 5633.0 5668.4 5705.9 5707.2 5732.5 5764.7 5769.2 5779.3 5783.7 5460.6 5591.4 5640.8 5649.8 5652.9 5576.2 5617.5 5630.3 5639.4 5674.5 5576.6 5579.3 5586.6 5587.4 5604.8 5451.1 5663.7 5680.5 5696.0 5699.3 5391.8 5446.1 5459.8 5499.1 5514.8 02:25:25 INFO - PROCESS | 4394 | 02:25:25 INFO - PROCESS | 4394 | [#1] ext.html Cycles:180 Average:47990.64 Median:32715.59 stddev:83408.28 (254.9%) stddev-sans-first:83566.23 02:25:25 INFO - PROCESS | 4394 | Values: 559.3 609.4 614.4 614.5 616.4 29745.4 30475.2 38046.0 38369.0 38398.0 43182.8 43210.4 43478.8 43674.3 43732.3 8596.2 8754.3 8780.0 8781.9 8808.8 7759.4 7934.2 10478.2 10739.1 10740.6 10348.4 10427.5 10438.2 10441.8 10448.3 7792.6 7952.7 10333.7 10424.2 10437.3 10424.5 10689.9 10691.3 10697.0 10704.2 39228.8 39599.8 39601.0 39609.2 39680.0 3260.9 3288.3 3337.5 3631.6 4127.2 29720.4 30338.7 30422.4 30555.0 30588.8 3900.9 3954.7 3979.9 4068.2 4100.5 264628.0 264921.0 264955.0 264977.0 265924.0 58069.7 59037.0 60758.7 60808.0 61169.4 71156.8 71797.3 72197.6 72216.6 72239.0 13050.4 13228.6 13231.3 13236.3 13245.1 9048.9 9260.2 9915.9 10075.3 10251.7 20650.7 20754.8 20859.2 20889.6 20933.5 7964.2 8012.8 8055.6 8067.5 8104.7 876.6 908.6 938.1 1054.6 1059.3 26756.6 27042.2 31823.4 32702.5 32728.7 957.0 999.9 1046.9 1118.1 1120.5 14672.9 14846.6 14869.6 15006.2 15022.2 371849.0 376381.0 379266.0 379606.0 380777.0 52315.7 52840.7 52873.7 52887.7 53013.7 1263.1 1271.2 1276.4 1288.8 1310.2 27470.6 28347.6 28391.7 28448.1 28645.3 45477.3 46270.3 46301.1 46322.3 46349.1 297649.0 298968.0 299344.0 299683.0 299720.0 27482.6 30758.2 30826.2 30994.7 31402.8 37789.4 39341.4 39432.6 39709.6 40078.6 27691.3 27759.4 27839.0 27889.7 28069.0 32507.2 32612.0 32846.5 33071.5 33931.2 29871.1 30301.2 33616.0 34556.1 34896.7 25961.0 30555.0 35770.0 37273.6 37873.4 24742.5 24841.0 24858.0 25111.6 25261.0 02:25:25 INFO - PROCESS | 4394 | 02:25:25 INFO - PROCESS | 4394 | [#2] jquery.html Cycles:180 Average:28459.90 Median:18258.85 stddev:86071.45 (471.4%) stddev-sans-first:86287.03 02:25:25 INFO - PROCESS | 4394 | Values: 356.7 365.3 365.6 368.0 370.7 13295.3 13641.7 16461.9 17219.1 18488.0 12975.8 15786.1 16093.0 16113.2 16200.0 5343.7 5495.0 5499.8 5500.7 5502.2 3941.2 4037.8 5304.3 5460.3 5772.3 5856.8 5888.0 5892.0 5906.7 5911.7 5752.3 5860.1 5957.6 5960.3 5966.8 5209.7 5241.7 5259.6 5263.9 5268.9 19647.8 20486.4 20491.0 20587.1 21220.2 2131.3 2131.6 2226.3 2256.0 2279.7 13308.5 13342.8 13487.9 13549.5 13794.0 1832.5 1846.5 1877.6 1878.1 1883.1 59039.0 59550.4 59942.7 62162.4 62719.6 9709.2 9879.6 9939.2 10016.3 10019.9 12931.2 13073.9 13116.3 13120.6 13128.5 7046.8 7056.7 7082.3 7113.6 7149.5 6608.7 6623.4 6648.0 6677.5 6723.7 5876.2 5902.9 5952.1 5960.6 5997.3 1660.1 1715.6 1732.8 1750.6 1783.3 885.6 901.4 904.9 919.2 1057.6 17052.3 17525.2 17605.6 17835.0 17940.6 852.3 924.7 930.3 964.5 1011.4 9624.4 10079.3 10138.3 10295.0 10355.5 520918.0 525422.0 529342.0 530701.0 532499.0 67586.7 72053.3 72233.0 72557.0 74004.0 1113.7 1121.6 1121.7 1125.3 1137.9 15873.7 15968.6 16161.3 16174.6 16397.0 34595.8 35577.3 36161.0 36264.1 36306.6 44221.6 44576.1 44769.8 44879.3 45140.4 9261.0 9569.3 9642.4 9645.6 9659.0 17810.2 17962.8 18147.3 18156.9 18406.1 14958.9 15044.0 15076.8 15122.5 15198.7 14764.5 14767.7 14770.6 14804.7 15363.5 11859.5 14956.7 15031.6 15282.0 15745.8 8156.9 9158.1 9665.6 9688.1 9801.1 13831.7 13961.7 14032.6 14291.5 14558.4 02:25:25 INFO - PROCESS | 4394 | 02:25:25 INFO - PROCESS | 4394 | [#3] mootools.html Cycles:180 Average:5313.56 Median:6405.92 stddev:2751.84 (43.0%) stddev-sans-first:2744.73 02:25:25 INFO - PROCESS | 4394 | Values: 1512.6 1693.5 1737.5 1745.7 1777.0 6426.6 7416.6 7512.8 7518.7 7528.4 7412.4 7584.7 7584.9 7586.7 7612.3 1917.9 1941.4 2202.2 2203.8 2238.7 2239.5 2242.5 2243.8 2248.5 2248.8 2173.9 2255.0 2257.2 2258.5 2260.1 2219.2 2247.6 2260.2 2261.8 2274.2 2259.5 2276.0 2290.7 2303.3 2307.1 7628.2 7643.4 7671.9 7692.5 7709.8 4532.1 4566.6 4573.7 4614.3 4645.1 2868.6 2949.9 2971.0 2997.5 3002.7 914.3 923.1 938.3 941.0 968.5 10382.2 10403.1 10426.9 10434.3 10446.9 3956.7 3999.6 4001.2 4037.0 4086.0 8867.7 8884.5 8893.3 8895.5 8907.2 4498.1 4513.2 4518.0 4536.6 4562.9 4129.3 4134.8 4139.7 4142.0 4143.0 3157.8 3206.8 3292.6 3323.5 3427.2 1107.6 1111.8 1112.2 1115.5 1116.3 1004.4 1051.3 1271.1 1292.6 1295.4 7089.3 7135.8 7137.2 7144.3 7180.2 1082.3 1083.8 1093.3 1103.5 1113.9 5550.2 5650.2 5658.9 5661.5 5669.9 8975.5 9061.6 9181.4 9182.7 9274.5 9042.1 9077.2 9165.9 9195.7 9197.3 6907.4 7136.9 7150.5 7150.9 7201.7 6896.3 6926.7 6935.9 6945.0 6946.3 7999.3 8226.2 8269.1 8272.5 8273.3 8287.9 8363.7 8374.8 8544.0 8546.2 6777.8 6803.0 6838.9 6861.1 6864.5 6447.4 6542.9 6962.0 7020.5 7373.2 6896.8 6988.8 7037.0 7060.5 7075.9 6743.2 6743.6 6824.9 6896.5 6901.0 6845.5 6852.2 6898.7 6900.4 6904.3 6214.7 6218.2 6228.6 6339.6 6345.0 6392.7 6419.2 6426.1 6436.2 6436.3 02:25:25 INFO - PROCESS | 4394 | 02:25:25 INFO - PROCESS | 4394 | [#4] prototype.html Cycles:180 Average:5233.48 Median:5956.05 stddev:1569.53 (26.4%) stddev-sans-first:1530.21 02:25:25 INFO - PROCESS | 4394 | Values: 332.2 335.4 340.2 341.7 342.1 5748.3 5872.0 5873.1 5895.6 5920.9 5656.5 5843.6 5844.1 5850.4 5869.1 4548.3 4548.7 4551.1 4557.3 4563.1 4324.6 4401.1 4443.1 4521.8 4552.4 4507.7 4517.0 4523.5 4524.6 4528.0 4512.7 4516.5 4520.3 4538.0 4545.3 3995.3 3998.0 4003.9 4005.4 4016.0 5504.8 5627.0 5629.3 5651.0 5689.6 5232.8 5237.9 5241.2 5242.2 5250.6 5922.7 6249.3 6253.2 6259.6 6265.8 4262.6 4267.2 4368.4 4377.3 4379.5 6394.1 6435.1 6445.4 6469.5 6487.8 4442.7 4448.0 4449.1 4449.2 4451.9 4429.0 4467.5 4505.1 4506.2 4535.5 5206.0 5208.8 5214.0 5215.3 5220.1 6257.7 6263.0 6263.5 6265.8 6271.3 1575.6 1576.3 1578.3 1578.4 1579.4 1054.4 1067.1 1070.2 1076.2 1087.6 5989.4 6003.5 6008.5 6011.0 6016.2 6451.0 6457.1 6464.9 6468.3 6468.4 5991.5 6001.6 6005.4 6007.6 6012.3 3418.0 3513.1 3515.5 3519.4 3522.5 6622.8 6628.7 6637.8 6647.4 6674.7 6706.6 6708.8 6713.8 6719.0 6725.4 6440.2 6630.7 6632.5 6641.2 6644.0 6227.9 6355.0 6512.7 6521.9 6534.7 6280.5 6425.7 6447.5 6455.7 6466.2 6610.8 6616.3 6625.6 6630.3 6630.8 4440.7 4456.1 4468.2 4476.2 4477.9 6380.5 6396.7 6400.0 6432.9 6484.6 6287.3 6289.1 6299.7 6301.2 6315.0 6204.9 6205.4 6265.9 6272.7 6300.7 6162.1 6173.3 6180.8 6181.2 6189.3 6303.6 6314.9 6318.1 6322.6 6325.8 6068.3 6082.6 6163.5 6163.9 6173.9 02:25:25 INFO - PROCESS | 4394 | 02:25:25 INFO - PROCESS | 4394 | [#5] yui.html Cycles:180 Average:13945.32 Median:48212.90 stddev:16333.77 (33.9%) stddev-sans-first:16349.25 02:25:25 INFO - PROCESS | 4394 | Values: 687.7 699.8 726.2 806.1 858.5 12821.8 13367.1 13427.9 13501.9 13551.6 12038.3 12063.3 12071.7 12107.9 12144.8 676.5 685.2 808.4 828.3 843.2 835.4 835.8 840.5 841.7 844.8 719.2 879.5 886.6 886.7 886.9 731.1 863.2 880.0 880.8 881.0 631.9 641.3 642.0 642.2 642.5 13318.6 13377.9 13378.1 13457.3 13484.5 10791.8 11240.4 11917.6 12105.0 12255.7 10662.0 10765.4 10782.1 10802.2 10812.8 3641.2 3683.3 3694.7 3702.4 3821.2 46642.5 46956.3 47247.3 47293.8 48113.3 9775.9 9825.0 9860.7 9860.9 9934.7 18368.6 18488.3 18512.6 18546.4 18569.4 7437.7 7479.1 7571.6 7609.0 7663.4 4197.3 4244.1 4275.4 4313.1 4321.4 2839.5 2890.6 2892.3 2892.9 2893.1 522.8 532.8 540.6 556.4 565.4 592.8 621.8 625.4 634.5 669.1 8480.6 8518.7 8527.4 8784.0 9555.7 549.4 558.9 606.7 661.4 668.3 3794.8 4220.6 4429.4 4478.8 4487.4 57779.0 57814.7 57866.1 57880.4 57892.7 51433.0 54159.5 54872.0 55055.2 55428.7 47638.0 48038.3 48283.3 49216.0 49401.0 8384.2 8426.7 8448.9 8466.2 8530.1 33435.0 34066.5 34088.7 34238.1 34470.3 43680.0 44297.0 48142.5 48692.0 48808.8 10926.2 11108.7 11223.8 11350.3 11411.7 12153.5 12674.4 12677.9 12819.4 13410.2 11667.9 11727.1 11971.6 12043.7 12349.4 11332.3 11499.2 11787.3 11794.9 12501.4 7872.0 10433.1 10500.9 11438.7 11725.9 9641.3 9842.9 9861.4 9878.3 10386.2 9091.6 9168.6 9361.2 9513.4 10074.0 02:25:25 INFO - PROCESS | 4394 | -------- Summary: end -------- 02:25:25 INFO - PROCESS | 4394 | 02:25:25 INFO - TEST-INFO | 4394: exit 0 02:25:25 INFO - TEST-OK | dromaeo_css | took 1114120ms 02:25:25 INFO - TEST-START | kraken 02:25:25 INFO - operating with platform_type : linux_ 02:25:25 INFO - Initialising browser for kraken test... 02:25:25 INFO - TEST-INFO | started process 4592 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpR0NQvs/profile http://localhost:44813/getInfo.html) 02:25:30 INFO - PROCESS | 4592 | __metrics Screen width/height:1600/1200 02:25:30 INFO - PROCESS | 4592 | colorDepth:24 02:25:30 INFO - PROCESS | 4592 | Browser inner width/height: 1024/697 02:25:30 INFO - PROCESS | 4592 | __metrics 02:25:30 INFO - PROCESS | 4592 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:25:30 INFO - PROCESS | 4592 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:25:31 INFO - TEST-INFO | 4592: exit 0 02:25:31 INFO - Browser initialized. 02:25:31 INFO - Running cycle 1/1 for kraken test... 02:25:31 INFO - TEST-INFO | started process 4675 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpR0NQvs/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:25:43 INFO - PROCESS | 4675 | RSS: Main: 150315008 02:25:43 INFO - PROCESS | 4675 | 02:25:46 INFO - PROCESS | 4675 | Cycle 1(1): loaded http://localhost:44813/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44813/tests/kraken/driver.html?testName=audio-beat-detection) 02:25:46 INFO - PROCESS | 4675 | RSS: Main: 185303040 02:25:46 INFO - PROCESS | 4675 | 02:25:49 INFO - PROCESS | 4675 | Cycle 1(1): loaded http://localhost:44813/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44813/tests/kraken/driver.html?testName=audio-dft) 02:25:49 INFO - PROCESS | 4675 | RSS: Main: 176308224 02:25:49 INFO - PROCESS | 4675 | 02:25:52 INFO - PROCESS | 4675 | Cycle 1(1): loaded http://localhost:44813/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44813/tests/kraken/driver.html?testName=audio-fft) 02:25:53 INFO - PROCESS | 4675 | RSS: Main: 160743424 02:25:53 INFO - PROCESS | 4675 | 02:25:55 INFO - PROCESS | 4675 | Cycle 1(1): loaded http://localhost:44813/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44813/tests/kraken/driver.html?testName=audio-oscillator) 02:25:55 INFO - PROCESS | 4675 | RSS: Main: 163045376 02:25:55 INFO - PROCESS | 4675 | 02:25:58 INFO - PROCESS | 4675 | Cycle 1(1): loaded http://localhost:44813/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44813/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:25:58 INFO - PROCESS | 4675 | RSS: Main: 163926016 02:25:58 INFO - PROCESS | 4675 | 02:26:01 INFO - PROCESS | 4675 | Cycle 1(1): loaded http://localhost:44813/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44813/tests/kraken/driver.html?testName=imaging-darkroom) 02:26:02 INFO - PROCESS | 4675 | RSS: Main: 165036032 02:26:02 INFO - PROCESS | 4675 | 02:26:05 INFO - PROCESS | 4675 | Cycle 1(1): loaded http://localhost:44813/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44813/tests/kraken/driver.html?testName=imaging-desaturate) 02:26:06 INFO - PROCESS | 4675 | RSS: Main: 166465536 02:26:06 INFO - PROCESS | 4675 | 02:26:08 INFO - PROCESS | 4675 | Cycle 1(1): loaded http://localhost:44813/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44813/tests/kraken/driver.html?testName=json-parse-financial) 02:26:09 INFO - PROCESS | 4675 | RSS: Main: 166563840 02:26:09 INFO - PROCESS | 4675 | 02:26:10 INFO - PROCESS | 4675 | Cycle 1(1): loaded http://localhost:44813/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44813/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:26:11 INFO - PROCESS | 4675 | RSS: Main: 175144960 02:26:11 INFO - PROCESS | 4675 | 02:26:13 INFO - PROCESS | 4675 | Cycle 1(1): loaded http://localhost:44813/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44813/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:26:13 INFO - PROCESS | 4675 | RSS: Main: 173957120 02:26:13 INFO - PROCESS | 4675 | 02:26:15 INFO - PROCESS | 4675 | Cycle 1(1): loaded http://localhost:44813/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44813/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:26:16 INFO - PROCESS | 4675 | RSS: Main: 187191296 02:26:16 INFO - PROCESS | 4675 | 02:26:18 INFO - PROCESS | 4675 | Cycle 1(1): loaded http://localhost:44813/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44813/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:26:19 INFO - PROCESS | 4675 | RSS: Main: 192741376 02:26:19 INFO - PROCESS | 4675 | 02:26:22 INFO - PROCESS | 4675 | Cycle 1(1): loaded http://localhost:44813/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44813/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:26:22 INFO - PROCESS | 4675 | RSS: Main: 191803392 02:26:22 INFO - PROCESS | 4675 | 02:26:24 INFO - PROCESS | 4675 | Cycle 1(1): loaded http://localhost:44813/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44813/tests/kraken/driver.html?testName=ai-astar) 02:26:24 INFO - PROCESS | 4675 | RSS: Main: 249040896 02:26:24 INFO - PROCESS | 4675 | 02:26:24 INFO - PROCESS | 4675 | __start_tp_report 02:26:24 INFO - PROCESS | 4675 | _x_x_mozilla_page_load 02:26:24 INFO - PROCESS | 4675 | _x_x_mozilla_page_load_details 02:26:24 INFO - PROCESS | 4675 | |i|pagename|runs| 02:26:24 INFO - PROCESS | 4675 | |0;ai-astar;109;111;105;111;109;110;100;110;111;114 02:26:24 INFO - PROCESS | 4675 | |1;audio-beat-detection;151;128;147;162;130;152;149;123;159;123 02:26:24 INFO - PROCESS | 4675 | |2;audio-dft;161;166;160;161;163;165;160;161;161;163 02:26:24 INFO - PROCESS | 4675 | |3;audio-fft;71;72;82;101;72;72;72;103;91;73 02:26:24 INFO - PROCESS | 4675 | |4;audio-oscillator;94;94;136;92;93;92;138;93;93;143 02:26:24 INFO - PROCESS | 4675 | |5;imaging-gaussian-blur;109;109;109;109;110;110;109;109;109;110 02:26:24 INFO - PROCESS | 4675 | |6;imaging-darkroom;146;146;146;145;145;146;145;146;145;147 02:26:24 INFO - PROCESS | 4675 | |7;imaging-desaturate;96;96;96;96;96;95;95;95;96;95 02:26:24 INFO - PROCESS | 4675 | |8;json-parse-financial;63;60;60;59;59;59;59;67;58;56 02:26:24 INFO - PROCESS | 4675 | |9;json-stringify-tinderbox;67;67;68;66;67;71;68;67;67;67 02:26:24 INFO - PROCESS | 4675 | |10;stanford-crypto-aes;89;87;86;94;88;88;86;85;87;85 02:26:24 INFO - PROCESS | 4675 | |11;stanford-crypto-ccm;114;115;117;125;122;120;122;118;132;115 02:26:24 INFO - PROCESS | 4675 | |12;stanford-crypto-pbkdf2;144;143;151;153;148;145;155;153;156;143 02:26:24 INFO - PROCESS | 4675 | |13;stanford-crypto-sha256-iterative;69;69;71;70;68;69;67;68;67;69 02:26:24 INFO - PROCESS | 4675 | __end_tp_report 02:26:24 INFO - PROCESS | 4675 | __start_cc_report 02:26:24 INFO - PROCESS | 4675 | _x_x_mozilla_cycle_collect,929 02:26:24 INFO - PROCESS | 4675 | __end_cc_report 02:26:24 INFO - PROCESS | 4675 | __startTimestamp1450866384578__endTimestamp 02:26:24 INFO - PROCESS | 4675 | 02:26:24 INFO - PROCESS | 4675 | ------- Summary: start ------- 02:26:24 INFO - PROCESS | 4675 | Number of tests: 14 02:26:24 INFO - PROCESS | 4675 | 02:26:24 INFO - PROCESS | 4675 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.50 stddev:3.89 (3.5%) stddev-sans-first:4.12 02:26:24 INFO - PROCESS | 4675 | Values: 109.0 111.0 105.0 111.0 109.0 110.0 100.0 110.0 111.0 114.0 02:26:24 INFO - PROCESS | 4675 | 02:26:24 INFO - PROCESS | 4675 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:150.00 stddev:14.92 (9.9%) stddev-sans-first:15.50 02:26:24 INFO - PROCESS | 4675 | Values: 151.0 128.0 147.0 162.0 130.0 152.0 149.0 123.0 159.0 123.0 02:26:24 INFO - PROCESS | 4675 | 02:26:24 INFO - PROCESS | 4675 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:2.08 (1.3%) stddev-sans-first:2.17 02:26:24 INFO - PROCESS | 4675 | Values: 161.0 166.0 160.0 161.0 163.0 165.0 160.0 161.0 161.0 163.0 02:26:24 INFO - PROCESS | 4675 | 02:26:24 INFO - PROCESS | 4675 | [#3] audio-fft Cycles:10 Average:80.90 Median:72.00 stddev:12.79 (17.8%) stddev-sans-first:13.06 02:26:24 INFO - PROCESS | 4675 | Values: 71.0 72.0 82.0 101.0 72.0 72.0 72.0 103.0 91.0 73.0 02:26:24 INFO - PROCESS | 4675 | 02:26:24 INFO - PROCESS | 4675 | [#4] audio-oscillator Cycles:10 Average:106.80 Median:93.00 stddev:22.29 (24.0%) stddev-sans-first:23.16 02:26:24 INFO - PROCESS | 4675 | Values: 94.0 94.0 136.0 92.0 93.0 92.0 138.0 93.0 93.0 143.0 02:26:24 INFO - PROCESS | 4675 | 02:26:24 INFO - PROCESS | 4675 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 02:26:24 INFO - PROCESS | 4675 | Values: 109.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 109.0 110.0 02:26:24 INFO - PROCESS | 4675 | 02:26:24 INFO - PROCESS | 4675 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 02:26:24 INFO - PROCESS | 4675 | Values: 146.0 146.0 146.0 145.0 145.0 146.0 145.0 146.0 145.0 147.0 02:26:24 INFO - PROCESS | 4675 | 02:26:24 INFO - PROCESS | 4675 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:26:24 INFO - PROCESS | 4675 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 02:26:24 INFO - PROCESS | 4675 | 02:26:24 INFO - PROCESS | 4675 | [#8] json-parse-financial Cycles:10 Average:60.00 Median:59.50 stddev:3.02 (5.1%) stddev-sans-first:3.00 02:26:24 INFO - PROCESS | 4675 | Values: 63.0 60.0 60.0 59.0 59.0 59.0 59.0 67.0 58.0 56.0 02:26:24 INFO - PROCESS | 4675 | 02:26:24 INFO - PROCESS | 4675 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.00 stddev:1.35 (2.0%) stddev-sans-first:1.42 02:26:24 INFO - PROCESS | 4675 | Values: 67.0 67.0 68.0 66.0 67.0 71.0 68.0 67.0 67.0 67.0 02:26:24 INFO - PROCESS | 4675 | 02:26:24 INFO - PROCESS | 4675 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:87.50 stddev:2.64 (3.0%) stddev-sans-first:2.74 02:26:24 INFO - PROCESS | 4675 | Values: 89.0 87.0 86.0 94.0 88.0 88.0 86.0 85.0 87.0 85.0 02:26:24 INFO - PROCESS | 4675 | 02:26:24 INFO - PROCESS | 4675 | [#11] stanford-crypto-ccm Cycles:10 Average:120.00 Median:121.00 stddev:5.54 (4.6%) stddev-sans-first:5.43 02:26:24 INFO - PROCESS | 4675 | Values: 114.0 115.0 117.0 125.0 122.0 120.0 122.0 118.0 132.0 115.0 02:26:24 INFO - PROCESS | 4675 | 02:26:24 INFO - PROCESS | 4675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.10 Median:152.00 stddev:5.11 (3.4%) stddev-sans-first:5.07 02:26:24 INFO - PROCESS | 4675 | Values: 144.0 143.0 151.0 153.0 148.0 145.0 155.0 153.0 156.0 143.0 02:26:24 INFO - PROCESS | 4675 | 02:26:24 INFO - PROCESS | 4675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.25 (1.8%) stddev-sans-first:1.32 02:26:24 INFO - PROCESS | 4675 | Values: 69.0 69.0 71.0 70.0 68.0 69.0 67.0 68.0 67.0 69.0 02:26:24 INFO - PROCESS | 4675 | -------- Summary: end -------- 02:26:24 INFO - PROCESS | 4675 | 02:26:25 INFO - TEST-INFO | 4675: exit 0 02:26:25 INFO - TEST-OK | kraken | took 60079ms 02:26:25 INFO - TEST-START | v8_7 02:26:25 INFO - operating with platform_type : linux_ 02:26:25 INFO - Initialising browser for v8_7 test... 02:26:25 INFO - TEST-INFO | started process 4926 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpobxse0/profile http://localhost:44813/getInfo.html) 02:26:30 INFO - PROCESS | 4926 | __metrics Screen width/height:1600/1200 02:26:30 INFO - PROCESS | 4926 | colorDepth:24 02:26:30 INFO - PROCESS | 4926 | Browser inner width/height: 1024/697 02:26:30 INFO - PROCESS | 4926 | __metrics 02:26:30 INFO - PROCESS | 4926 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:26:30 INFO - PROCESS | 4926 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:26:31 INFO - TEST-INFO | 4926: exit 0 02:26:31 INFO - Browser initialized. 02:26:31 INFO - Running cycle 1/1 for v8_7 test... 02:26:31 INFO - TEST-INFO | started process 5009 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpobxse0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:26:43 INFO - PROCESS | 5009 | RSS: Main: 150220800 02:26:43 INFO - PROCESS | 5009 | 02:27:05 INFO - PROCESS | 5009 | Cycle 1(1): loaded http://localhost:44813/tests/v8_7/run.html (next: http://localhost:44813/tests/v8_7/run.html) 02:27:05 INFO - PROCESS | 5009 | RSS: Main: 588103680 02:27:05 INFO - PROCESS | 5009 | 02:27:05 INFO - PROCESS | 5009 | __start_tp_report 02:27:05 INFO - PROCESS | 5009 | _x_x_mozilla_page_load 02:27:05 INFO - PROCESS | 5009 | _x_x_mozilla_page_load_details 02:27:05 INFO - PROCESS | 5009 | |i|pagename|runs| 02:27:05 INFO - PROCESS | 5009 | |0;Richards;166.22340425531914 02:27:05 INFO - PROCESS | 5009 | |1;DeltaBlue;188.46588767433096 02:27:05 INFO - PROCESS | 5009 | |2;Encrypt;279.4857462269424 02:27:05 INFO - PROCESS | 5009 | |3;Decrypt;5138.461538461538 02:27:05 INFO - PROCESS | 5009 | |4;RayTrace;1958.9041095890411 02:27:05 INFO - PROCESS | 5009 | |5;Earley;766.8711656441718 02:27:05 INFO - PROCESS | 5009 | |6;Boyer;12195.121951219513 02:27:05 INFO - PROCESS | 5009 | |7;RegExp;25200 02:27:05 INFO - PROCESS | 5009 | |8;Splay;576.036866359447 02:27:05 INFO - PROCESS | 5009 | |9;NavierStokes;4840.579710144928 02:27:05 INFO - PROCESS | 5009 | __end_tp_report 02:27:05 INFO - PROCESS | 5009 | __startTimestamp1450866425354__endTimestamp 02:27:05 INFO - PROCESS | 5009 | 02:27:05 INFO - PROCESS | 5009 | ------- Summary: start ------- 02:27:05 INFO - PROCESS | 5009 | Number of tests: 10 02:27:05 INFO - PROCESS | 5009 | 02:27:05 INFO - PROCESS | 5009 | [#0] Richards Cycles:1 Average:166.22 Median:166.22 stddev:0.00 (0.0%) 02:27:05 INFO - PROCESS | 5009 | Values: 166.2 02:27:05 INFO - PROCESS | 5009 | 02:27:05 INFO - PROCESS | 5009 | [#1] DeltaBlue Cycles:1 Average:188.47 Median:188.47 stddev:0.00 (0.0%) 02:27:05 INFO - PROCESS | 5009 | Values: 188.5 02:27:05 INFO - PROCESS | 5009 | 02:27:05 INFO - PROCESS | 5009 | [#2] Encrypt Cycles:1 Average:279.49 Median:279.49 stddev:0.00 (0.0%) 02:27:05 INFO - PROCESS | 5009 | Values: 279.5 02:27:05 INFO - PROCESS | 5009 | 02:27:05 INFO - PROCESS | 5009 | [#3] Decrypt Cycles:1 Average:5138.46 Median:5138.46 stddev:0.00 (0.0%) 02:27:05 INFO - PROCESS | 5009 | Values: 5138.5 02:27:05 INFO - PROCESS | 5009 | 02:27:05 INFO - PROCESS | 5009 | [#4] RayTrace Cycles:1 Average:1958.90 Median:1958.90 stddev:0.00 (0.0%) 02:27:05 INFO - PROCESS | 5009 | Values: 1958.9 02:27:05 INFO - PROCESS | 5009 | 02:27:05 INFO - PROCESS | 5009 | [#5] Earley Cycles:1 Average:766.87 Median:766.87 stddev:0.00 (0.0%) 02:27:05 INFO - PROCESS | 5009 | Values: 766.9 02:27:05 INFO - PROCESS | 5009 | 02:27:05 INFO - PROCESS | 5009 | [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 02:27:05 INFO - PROCESS | 5009 | Values: 12195.1 02:27:05 INFO - PROCESS | 5009 | 02:27:05 INFO - PROCESS | 5009 | [#7] RegExp Cycles:1 Average:25200.00 Median:25200.00 stddev:0.00 (0.0%) 02:27:05 INFO - PROCESS | 5009 | Values: 25200.0 02:27:05 INFO - PROCESS | 5009 | 02:27:05 INFO - PROCESS | 5009 | [#8] Splay Cycles:1 Average:576.04 Median:576.04 stddev:0.00 (0.0%) 02:27:05 INFO - PROCESS | 5009 | Values: 576.0 02:27:05 INFO - PROCESS | 5009 | 02:27:05 INFO - PROCESS | 5009 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 02:27:05 INFO - PROCESS | 5009 | Values: 4840.6 02:27:05 INFO - PROCESS | 5009 | -------- Summary: end -------- 02:27:05 INFO - PROCESS | 5009 | 02:27:06 INFO - TEST-INFO | 5009: exit 0 02:27:06 INFO - TEST-OK | v8_7 | took 40268ms 02:27:06 INFO - SUITE-END | took 1214s 02:27:06 INFO - Completed test suite (00:20:14) 02:27:06 INFO - Working with test: dromaeo_css 02:27:06 INFO - Generating results file: dromaeo_css 02:27:06 INFO - Working with test: kraken 02:27:06 INFO - Generating results file: kraken 02:27:06 INFO - javascript benchmark 02:27:06 INFO - Working with test: v8_7 02:27:06 INFO - Generating results file: v8_7 02:27:06 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:27:06 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 02:27:06 INFO - process_Request line: dromaeo_css 6973.68 graph.html#tests=[[72,64,35]] 02:27:06 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:27:06 INFO - process_Request line: kraken 1504.60 graph.html#tests=[[232,64,35]] 02:27:06 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:27:06 INFO - process_Request line: v8_7 20094.82 graph.html#tests=[[230,64,35]] 02:27:06 INFO - RETURN: dromaeo_css: 6973.68 02:27:06 INFO - RETURN: kraken: 1504.60 02:27:06 INFO - RETURN: v8_7: 20094.82 02:27:06 INFO - javascript benchmark 02:27:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3082.475979083556, 3158.4314823331792, 3178.6026746656653, 3202.487601983683, 3231.7414606831458, 5021.748912554372, 5132.615053870956, 5227.3465816772905, 5303.310569625948, 5327.493888080631, 5248.396434410034, 5280.419153893069, 5352.304200453946, 5374.355077390718, 5407.459254074601, 4888.755562221883, 4946.5795407390415, 4963.1810751226, 4982.153033984213, 4987.251912213161, 4792.424909010923, 4922.114019476493, 4947.282644016615, 4992.631447483452, 5008.424031236418, 4773.618110551165, 4819.180739274297, 4829.227323628238, 4830.830920917786, 4898.4366797818175, 4774.116788394123, 4792.281157826319, 4794.5684888359865, 4812.350332705075, 4814.470408255089, 4751.073540659573, 4846.345743324641, 4863.902721945577, 4868.78090485929, 4907.362042934431, 5111.923321150186, 5152.562032227265, 5197.220416937452, 5217.530422262014, 5240.895182096375, 5763.394843541451, 5765.6540607563265, 5772.653640781525, 5772.8845423091725, 5775.537956963475, 5637.774489020475, 5769.624974376652, 5789.652620842763, 5792.913106303409, 5805.216295800055, 5299.682019078868, 5399.514043736043, 5409.43200963897, 5415.864603384947, 5451.37309209442, 5874.441928016831, 5877.177195192677, 5889.0, 5890.0, 5894.528437725057, 5555.1667249912025, 5661.150827375926, 5709.571782116358, 5713.028785106542, 5714.200011998323, 5607.383187849333, 5631.380548139701, 5698.3162020556965, 5741.712914354265, 5745.425457454221, 5731.799387021434, 5736.4550367715, 5739.311282646109, 5743.913841292384, 5749.712514374348, 5742.626729262668, 5746.195532625436, 5747.626404283708, 5748.45389687979, 5749.511291540266, 4352.238358287351, 4373.147236288957, 4427.468703755506, 4446.710963787344, 4458.219811532968, 3920.8235629396745, 3958.1094253793244, 3963.0884896473394, 3994.960050399517, 4001.4397984282223, 5304.336957880265, 5411.0, 5411.891762164734, 5417.729113544307, 5422.8373148805595, 5788.479036886701, 5801.970990145022, 5837.591368604157, 5856.560757943172, 5934.13954976526, 5370.489803468664, 5383.461653834664, 5383.730813459311, 5386.299781028441, 5388.326459192601, 4970.975145124251, 4989.950100499022, 4997.0505603935135, 5009.874753131201, 5035.471275516092, 5880.176775251468, 5886.293644762571, 5979.162917191684, 5990.430909063719, 6026.879462410815, 5857.560682948882, 5857.7949771757785, 5860.326062502696, 5861.882762344644, 5865.208196893364, 5701.800436984686, 5829.0, 5937.0, 5945.821625351246, 5946.375630558729, 5593.524550413261, 5633.042382795016, 5668.404817494104, 5705.857353566194, 5707.1724599933605, 5732.541396688338, 5764.654120752601, 5769.192313076257, 5779.2775903012125, 5783.739731712168, 5460.645058071213, 5591.384947655836, 5640.802571909963, 5649.802256920988, 5652.85867853307, 5576.163575463713, 5617.494425501724, 5630.324361076697, 5639.436056394327, 5674.460926212003, 5576.553875689854, 5579.330480342385, 5586.581006424616, 5587.385387607279, 5604.775808967759, 5451.073317535949, 5663.716814159358, 5680.488756011979, 5696.0, 5699.2590963174525, 5391.757370918396, 5446.074167391474, 5459.754311056092, 5499.092649712913, 5514.751836167462], "unit": "score", "name": "dojo.html", "value": 5291.669019217046}, {"lowerIsBetter": false, "replicates": [559.3288054334797, 609.4454046817394, 614.3518587889778, 614.4776939601337, 616.3620652624535, 29745.405091898177, 30475.238119047033, 38045.99999999996, 38369.0, 38398.0, 43182.784086079606, 43210.351844722354, 43478.78260608693, 43674.34488482675, 43732.3440148398, 8596.183362580545, 8754.299656027502, 8780.0, 8781.912180878206, 8808.779780505507, 7759.41804364672, 7934.246246606564, 10478.161747060218, 10739.087177589876, 10740.570377184942, 10348.379097254152, 10427.530761115768, 10438.164946804276, 10441.84337234942, 10448.32085914413, 7792.571408572526, 7952.681892724284, 10333.689989300334, 10424.218183636181, 10437.321574097736, 10424.478776061242, 10689.946550267277, 10691.251612387136, 10697.0, 10704.197185211062, 39228.80385598083, 39599.8020009901, 39601.0, 39609.20781584381, 39680.0, 3260.8858689945973, 3288.342331533679, 3337.516060171286, 3631.5823680276844, 4127.236461254677, 29720.40559188804, 30338.696613033808, 30422.391552169054, 30555.0, 30588.847055764578, 3900.8533116619183, 3954.683625309997, 3979.920401591981, 4068.186362727437, 4100.528439229497, 264628.0, 264920.9999999981, 264955.0, 264977.0, 265924.0, 58069.70965145147, 59037.0, 60758.69620651868, 60808.0, 61169.38830611637, 71156.81696604956, 71797.2820271801, 72197.63901180461, 72216.63891680508, 72238.97012873391, 13050.412731427108, 13228.603141905758, 13231.338433078308, 13236.338183090807, 13245.139065960682, 9048.864267036, 9260.166585007382, 9915.851262231072, 10075.34510256831, 10251.692449226535, 20650.690239646417, 20754.792452075286, 20859.1656333748, 20889.582208355747, 20933.476663083242, 7964.20357964199, 8012.799680008046, 8055.556944367999, 8067.475614085183, 8104.675812967415, 876.609908590671, 908.5775114571755, 938.1228551304553, 1054.641421916552, 1059.2955684469741, 26756.59865102025, 27042.188734338, 31823.363532729214, 32702.509462358084, 32728.672713273038, 956.9856452153223, 999.8750156230471, 1046.9162467002623, 1118.1055155875267, 1120.5181771838188, 14672.899532535102, 14846.554603361916, 14869.553913382615, 15006.249687515581, 15022.173780441963, 371849.0, 376381.0, 379266.0, 379606.0, 380777.0, 52315.73842130841, 52840.73579632154, 52873.735631322364, 52887.73556132272, 53013.73493132587, 1263.090574786134, 1271.2245530226555, 1276.4383671184648, 1288.8066789981578, 1310.1614966421498, 27470.5879411805, 28347.574786378635, 28391.716082839732, 28448.146555603365, 28645.28386790347, 45477.317840231764, 46270.305945410175, 46301.07397851957, 46322.30516542187, 46349.07301854011, 297649.0, 298968.0, 299344.0, 299683.0, 299720.0, 27482.587761183997, 30758.231044224074, 30826.229344266572, 30994.690053100083, 31402.842985784926, 37789.4331585032, 39341.40987885127, 39432.6056739429, 39709.631940485946, 40078.59921400749, 27691.307717306423, 27759.44481110326, 27839.0, 27889.70843027605, 28069.0, 32507.18732031718, 32612.0, 32846.507302390004, 33071.50392744159, 33931.15172120618, 29871.103866884027, 30301.24246893757, 33616.0, 34556.13609659779, 34896.65103348934, 25961.037608083694, 30555.0, 35770.0, 37273.627263727016, 37873.431898522096, 24742.50514989726, 24841.0, 24858.0, 25111.623325649765, 25261.0], "unit": "score", "name": "ext.html", "value": 18541.426242552174}, {"lowerIsBetter": false, "replicates": [356.69502575298134, 365.26763838503797, 365.6161030917537, 367.95584529856416, 370.73307218802455, 13295.335233238347, 13641.658958526017, 16461.917690411545, 17219.139043047846, 18488.0, 12975.805362919564, 15786.131762753044, 16093.0, 16113.194340282967, 16200.027998320109, 5343.679379237248, 5495.038368285554, 5499.780008799643, 5500.669959802404, 5502.202180683798, 3941.2117576484675, 4037.7577345359227, 5304.283921670563, 5460.262864513299, 5772.3361813391575, 5856.795012174574, 5888.0, 5891.970540147293, 5906.704664766766, 5911.674857882815, 5752.338481074688, 5860.062390017598, 5957.642541447527, 5960.344362120163, 5966.8209953701025, 5209.661372010845, 5241.711705856176, 5259.605529585297, 5263.894722105537, 5268.947310526884, 19647.803521964885, 20486.38540843777, 20491.0, 20587.07358168886, 21220.151193952224, 2131.2753663754397, 2131.6163090643677, 2226.265332440291, 2255.9661605075935, 2279.6922415474032, 13308.467661293536, 13342.799858002138, 13487.86512134876, 13549.458021679122, 13794.0, 1832.4869036669754, 1846.455295687762, 1877.6244751049708, 1878.0703551741838, 1883.0961138653522, 59039.0, 59550.40449595492, 59942.70028649872, 62162.37837621656, 62719.60962732565, 9709.223262139012, 9879.555420006118, 9939.204863610894, 10016.348937319051, 10019.949900250453, 12931.224126552437, 13073.869261307455, 13116.278604676643, 13120.60638180856, 13128.540501082416, 7046.823829404203, 7056.682449289794, 7082.291770822876, 7113.57318560888, 7149.499535032498, 6608.669566521751, 6623.370779775913, 6647.966760166169, 6677.465802735769, 6723.731050758012, 5876.236089308448, 5902.911456328158, 5952.077427998581, 5960.582759206901, 5997.250343707036, 1660.0703605980689, 1715.5882588178997, 1732.774739283885, 1750.599520383688, 1783.3401641392768, 885.5616469847466, 901.4005686218723, 904.8506996345661, 919.2416256588341, 1057.5505410200633, 17052.31790728357, 17525.211365488583, 17605.559861003578, 17835.0, 17940.55148621295, 852.3224036890687, 924.6763632728491, 930.316217580078, 964.4984608003939, 1011.4083261292079, 9624.422534647943, 10079.34484258521, 10138.341007834468, 10295.0, 10355.534000969974, 520918.0, 525422.0, 529342.0, 530701.0, 532499.0, 67586.66206669033, 72053.2794672057, 72233.0, 72557.0, 74004.0, 1113.6937342230951, 1121.5513794482108, 1121.747606788466, 1125.25437931447, 1137.9146564007733, 15873.68252634964, 15968.600784980468, 16161.254020893633, 16174.595635109217, 16397.0, 34595.82702086474, 35577.28845423129, 36161.0, 36264.09339766527, 36306.63693363138, 44221.55778442174, 44576.10847783091, 44769.776151120335, 44879.32681009853, 45140.42008529686, 9261.0, 9569.282303827102, 9642.373245739005, 9645.614175432904, 9658.951705241428, 17810.198541065423, 17962.82037179664, 18147.27410903549, 18156.909215454365, 18406.079696014876, 14958.850411495745, 15044.0, 15076.773848392064, 15122.470713524974, 15198.696026079637, 14764.48324308644, 14767.704645906806, 14770.556883293519, 14804.703905922037, 15363.539093827203, 11859.466324015268, 14956.700865982837, 15031.624209394415, 15282.0, 15745.763813542577, 8156.877646835421, 9158.129977652112, 9665.613375465184, 9688.12806847387, 9801.068898454636, 13831.723365532433, 13961.650958726113, 14032.649183770487, 14291.499797507038, 14558.41766329335], "unit": "score", "name": "jquery.html", "value": 9016.471256529818}, {"lowerIsBetter": false, "replicates": [1512.553796629994, 1693.4580934101086, 1737.5048111288281, 1745.6820100823877, 1776.9555761105971, 6426.582272152313, 7416.592087435189, 7512.849743005137, 7518.661660225289, 7528.435367347443, 7412.444066695006, 7584.734534291301, 7584.924150758491, 7586.658600362983, 7612.314891659749, 1917.932872349468, 1941.4272789527054, 2202.2402271216406, 2203.8347123965727, 2238.675392068149, 2239.529698763262, 2242.473018840571, 2243.753187149412, 2248.4828489447436, 2248.8313376496744, 2173.858699184556, 2254.977450225493, 2257.2099765082253, 2258.54829034193, 2260.0846657103816, 2219.1789038055863, 2247.640177692497, 2260.2089268755967, 2261.8190544756544, 2274.1812947339026, 2259.4916143867663, 2276.0326861083972, 2290.6678531612824, 2303.2974942642486, 2307.1348244408346, 7628.160902300742, 7643.350315223157, 7671.884921726179, 7692.499987500794, 7709.845803083963, 4532.0709254602725, 4566.589006989387, 4573.679842411033, 4614.2617181250835, 4645.070985802819, 2868.6270784797844, 2949.9115026549025, 2970.9851450742826, 2997.4904266274566, 3002.6847181045896, 914.2503147419119, 923.1138107416821, 938.3009657804911, 940.9764755881089, 968.5157421289356, 10382.221333400024, 10403.11573516252, 10426.895731042745, 10434.321769084985, 10446.947765261126, 3956.7428117172867, 3999.6000399960353, 4001.15975645112, 4036.979815100906, 4085.97957010219, 8867.73396798097, 8884.511351875708, 8893.333000024895, 8895.4662720237, 8907.198352148338, 4498.05540836428, 4513.1650644630845, 4518.0, 4536.637069034469, 4562.908741825145, 4129.2773764591075, 4134.772587507716, 4139.668826493873, 4141.958580414218, 4142.984968682692, 3157.8105313681253, 3206.7755257132244, 3292.6378098409155, 3323.5014747788027, 3427.246005878703, 1107.6123356825046, 1111.77208672222, 1112.2270022334562, 1115.4701516779628, 1116.2911551165068, 1004.3672486333563, 1051.2641151194196, 1271.0721173543366, 1292.6315999939973, 1295.4494339905502, 7089.326513981164, 7135.82160445993, 7137.179224389158, 7144.321289477595, 7180.1742799578715, 1082.258652822819, 1083.842842787807, 1093.294824837991, 1103.475848971748, 1113.8941800528937, 5550.16747487872, 5650.180723795027, 5658.91511627326, 5661.490465858093, 5669.858253543694, 8975.461472311683, 9061.637534498677, 9181.449113053239, 9182.724518264462, 9274.536273186448, 9042.050584688644, 9077.183053525214, 9165.908340916505, 9195.724128276162, 9197.264218862474, 6907.378335949788, 7136.92863071373, 7150.5352152109945, 7150.892736608955, 7201.747938822116, 6896.310368963063, 6926.688299026455, 6935.89596156048, 6945.027696122446, 6946.270641582561, 7999.32005779492, 8226.218509241613, 8269.131741167332, 8272.462289951134, 8273.255407013397, 8287.917120828715, 8363.749087527383, 8374.83250335002, 8543.957280213808, 8546.2308392245, 6777.830554236183, 6803.047573339637, 6838.93161068383, 6861.142357205349, 6864.4554975130195, 6447.3552644735155, 6542.901856472062, 6962.025316455802, 7020.543664661781, 7373.225811289737, 6896.7586134485055, 6988.825279367853, 7036.964815176096, 7060.505764596429, 7075.858482830417, 6743.15710536183, 6743.5953842769595, 6824.897626535705, 6896.517243792886, 6901.033855260167, 6845.520813543004, 6852.177738671391, 6898.724051038103, 6900.413464855343, 6904.3095690430555, 6214.689265536615, 6218.22272215973, 6228.626282423069, 6339.619622822645, 6345.016522439029, 6392.68036598159, 6419.165508483868, 6426.068220108152, 6436.195475565554, 6436.259830119596], "unit": "score", "name": "mootools.html", "value": 4372.172883307343}, {"lowerIsBetter": false, "replicates": [332.18283023761546, 335.35611625678695, 340.18695318189526, 341.70101161483717, 342.0610424385063, 5748.310202775662, 5871.970640146798, 5873.0896711009755, 5895.557833162514, 5920.911186332209, 5656.519195868346, 5843.620164689292, 5844.064949608063, 5850.3564607893095, 5869.060950247961, 4548.295014272777, 4548.704334218265, 4551.067031258584, 4557.316402539613, 4563.0873825235085, 4324.6107850293465, 4401.05377343871, 4443.066955939256, 4521.819127234907, 4552.385427967231, 4507.706999045068, 4517.028838799657, 4523.479799823013, 4524.592786649201, 4527.954720452803, 4512.684112112121, 4516.525764794682, 4520.254158063915, 4538.0, 4545.318202269653, 3995.300822356076, 3997.98001009996, 4003.919921601552, 4005.35914253718, 4016.0, 5504.779808807642, 5626.971865140648, 5629.296337957755, 5650.982823091842, 5689.6017278790505, 5232.790688372461, 5237.947620523784, 5241.213817927303, 5242.18746094356, 5250.6324557281005, 5922.674252916088, 6249.250089989185, 6253.249610046778, 6259.561830671855, 6265.780697675605, 4262.595053469915, 4267.210566045292, 4368.36658684489, 4377.321515165123, 4379.5182529921685, 6394.104825324458, 6435.099086127946, 6445.419912207877, 6469.54157420182, 6487.772927947546, 4442.73343599385, 4448.021435284232, 4449.13241917823, 4449.221386257456, 4451.866444006685, 4429.0, 4467.508574056851, 4505.144022635689, 4506.1663592235545, 4535.455745310584, 5206.0, 5208.801975545645, 5214.009338225725, 5215.269862219292, 5220.086484865134, 6257.687115644199, 6263.029230469285, 6263.498920086382, 6265.843353916098, 6271.341509141565, 1575.6139745762362, 1576.3064251729202, 1578.2661062605714, 1578.4396539228637, 1579.3603590545847, 1054.3726482742757, 1067.0876400677464, 1070.1652710885521, 1076.2036093291065, 1087.6465148826662, 5989.431004054608, 6003.549733769984, 6008.489278411296, 6011.0382338825575, 6016.157737916695, 6451.032345148265, 6457.128287681103, 6464.870702585922, 6468.320826313264, 6468.417842394113, 5991.460768530853, 6001.609895356788, 6005.429484198994, 6007.579469437185, 6012.278526576839, 3417.9829100854336, 3513.1041584395816, 3515.54297941266, 3519.419295816213, 3522.542069530996, 6622.834429139214, 6628.734850606018, 6637.800865973932, 6647.368499992493, 6674.666266686646, 6706.5640733352175, 6708.83227919306, 6713.798586042427, 6719.0, 6725.39471447572, 6440.194975628046, 6630.701618427182, 6632.469402447792, 6641.236257830315, 6643.966780166068, 6227.906581401192, 6355.0, 6512.706928188148, 6521.8695626088165, 6534.705938232696, 6280.466160376236, 6425.710843012169, 6447.451966582893, 6455.709493072917, 6466.159399278064, 6610.8016759497295, 6616.305287944889, 6625.635590042401, 6630.30381809903, 6630.801075967729, 4440.711353761995, 4456.108778244299, 4468.195724769573, 4476.194285028726, 4477.888052798706, 6380.489560835215, 6396.744130234739, 6400.0, 6432.871342573216, 6484.578502397329, 6287.30839607652, 6289.088082228142, 6299.685015749286, 6301.212348456443, 6315.0, 6204.875902481835, 6205.441510264098, 6265.874682506415, 6272.686365681607, 6300.716467759054, 6162.075688646739, 6173.32093469727, 6180.7527698891545, 6181.196444462191, 6189.319174890668, 6303.590266632654, 6314.936850631435, 6318.08387783778, 6322.620642761265, 6325.778597749057, 6068.332483426731, 6082.6046306991675, 6163.476104530986, 6163.9383606163365, 6173.938260617337], "unit": "score", "name": "prototype.html", "value": 4725.240156063767}, {"lowerIsBetter": false, "replicates": [687.6762232702048, 699.8180473076999, 726.2301959922482, 806.0649646410162, 858.5149390594314, 12821.807672884914, 13367.131136476122, 13427.865721342809, 13501.864981350183, 13551.593452196425, 12038.277703337784, 12063.336516491589, 12071.698207544816, 12107.878921210786, 12144.757104857898, 676.5399528320739, 685.1777866560122, 808.385626923538, 828.2752591482453, 843.173689784012, 835.365122506893, 835.8286551256978, 840.5293035899886, 841.7474757572704, 844.7930257087022, 719.2088702427341, 879.5030807593721, 886.5921676029002, 886.6586364249746, 886.9157430044168, 731.0824914732004, 863.2101627011277, 880.0275695356603, 880.8326417980563, 880.9823803523958, 631.8957372033655, 641.3426238105932, 642.0465608571315, 642.2357394700339, 642.5277421095491, 13318.600441986757, 13377.933110334387, 13378.063535552516, 13457.259850708208, 13484.528041518597, 10791.83812242817, 11240.381779002151, 11917.642470725892, 12105.0, 12255.69360765979, 10662.0, 10765.407902565355, 10782.083522900562, 10802.189835762349, 10812.837807432894, 3641.217138315275, 3683.28176005679, 3694.722895782827, 3702.389105797567, 3821.197548514815, 46642.5335746645, 46956.29565556485, 47247.29129063067, 47293.76353118247, 48113.27830082586, 9775.853362199572, 9824.95087524572, 9860.704178874645, 9860.852087218698, 9934.652287170058, 18368.63262734738, 18488.260469581335, 18512.629747404975, 18546.350877719215, 18569.350072747387, 7437.665305061285, 7479.139898911695, 7571.621418929031, 7609.0, 7663.425243106789, 4197.265478541304, 4244.087521182961, 4275.3800698898485, 4313.137372525507, 4321.373400856858, 2839.5314773062214, 2890.5664150377193, 2892.291388609762, 2892.9276768080967, 2893.146521776081, 522.8274669359103, 532.8321578702696, 540.5810496864882, 556.3824155187739, 565.4119715495921, 592.7747455966705, 621.7606221604624, 625.3621306267581, 634.5494698763837, 669.136813510566, 8480.575971201415, 8518.701845435504, 8527.40308178434, 8783.956080219557, 9555.665551705657, 549.4231057389725, 558.9166530405952, 606.7360698096343, 661.4146480364816, 668.3416834418094, 3794.772313661189, 4220.556841531595, 4429.424174857248, 4478.843240486567, 4487.394201782783, 57779.0, 57814.7109264451, 57866.132008019915, 57880.4211957875, 57892.71053644705, 51433.0, 54159.45840541544, 54872.0, 55055.174172387444, 55428.722856386266, 47638.0, 48038.27942580864, 48283.27575086306, 49216.0, 49401.0, 8384.245417912172, 8426.747197584082, 8448.91551084506, 8466.238038576557, 8530.10433904456, 33435.0, 34066.489002665476, 34088.65911340855, 34238.14404639904, 34470.31059378848, 43680.0, 44297.0, 48142.51857481521, 48692.0, 48808.75595621999, 10926.235163538477, 11108.739993746918, 11223.775524489627, 11350.318980861175, 11411.714707132389, 12153.513859445877, 12674.429650665927, 12677.936610316889, 12819.423125959167, 13410.195388276734, 11667.894621557862, 11727.061835053346, 11971.64085077449, 12043.711694777965, 12349.3825308736, 11332.263402878787, 11499.195056345976, 11787.292762434281, 11794.882051179378, 12501.374931253218, 7872.0, 10433.113185379329, 10500.894991050298, 11438.656840294805, 11725.941370293094, 9641.325107242426, 9842.852357214791, 9861.408315501092, 9878.259130565093, 10386.169106471312, 9091.590878410356, 9168.587413566538, 9361.157495825408, 9513.429194248367, 10074.016439230894], "unit": "score", "name": "yui.html", "value": 6292.734240082499}], "name": "dromaeo_css", "value": 6973.683143119973}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 105.0, 111.0, 109.0, 110.0, 100.0, 110.0, 111.0, 114.0], "unit": "score", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [151.0, 128.0, 147.0, 162.0, 130.0, 152.0, 149.0, 123.0, 159.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 142.4}, {"lowerIsBetter": true, "replicates": [161.0, 166.0, 160.0, 161.0, 163.0, 165.0, 160.0, 161.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 82.0, 101.0, 72.0, 72.0, 72.0, 103.0, 91.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 136.0, 92.0, 93.0, 92.0, 138.0, 93.0, 93.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [63.0, 60.0, 60.0, 59.0, 59.0, 59.0, 59.0, 67.0, 58.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 60.0}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 66.0, 67.0, 71.0, 68.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [89.0, 87.0, 86.0, 94.0, 88.0, 88.0, 86.0, 85.0, 87.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.5}, {"lowerIsBetter": true, "replicates": [114.0, 115.0, 117.0, 125.0, 122.0, 120.0, 122.0, 118.0, 132.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.0}, {"lowerIsBetter": true, "replicates": [144.0, 143.0, 151.0, 153.0, 148.0, 145.0, 155.0, 153.0, 156.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.1}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 71.0, 70.0, 68.0, 69.0, 67.0, 68.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1504.5999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.22340425531914], "unit": "score", "name": "Richards", "value": 212.37683199999995}, {"lowerIsBetter": false, "replicates": [188.46588767433096], "unit": "score", "name": "DeltaBlue", "value": 350.8221079999999}, {"lowerIsBetter": false, "replicates": [279.4857462269424], "unit": "score", "name": "Encrypt", "value": 952.3956179999999}, {"lowerIsBetter": false, "replicates": [5138.461538461538], "unit": "score", "name": "Decrypt", "value": 51.80169161676644}, {"lowerIsBetter": false, "replicates": [1958.9041095890411], "unit": "score", "name": "RayTrace", "value": 377.7566223776223}, {"lowerIsBetter": false, "replicates": [766.8711656441718], "unit": "score", "name": "Earley", "value": 869.067752}, {"lowerIsBetter": false, "replicates": [12195.121951219513], "unit": "score", "name": "Boyer", "value": 54.64996600000001}, {"lowerIsBetter": false, "replicates": [25200.0], "unit": "score", "name": "RegExp", "value": 36.150198412698415}, {"lowerIsBetter": false, "replicates": [576.036866359447], "unit": "score", "name": "Splay", "value": 141.46837599999995}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20094.82071943556}]} 02:27:06 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20094.82"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1504.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6973.68"}}} 02:27:06 INFO - Return code: 0 02:27:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:27:06 INFO - # TBPL SUCCESS # 02:27:06 INFO - Running post-action listener: _resource_record_post_action 02:27:06 INFO - Running post-run listener: _resource_record_post_run 02:27:07 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 16384; Write bytes: 558125056; Read time: 320; Write time: 561400 02:27:07 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234627072; Read time: 0; Write time: 251280 02:27:07 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 16384; Write bytes: 323497984; Read time: 320; Write time: 310120 02:27:07 INFO - Running post-run listener: _upload_blobber_files 02:27:07 INFO - Blob upload gear active. 02:27:07 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:27:07 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 02:27:07 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'] 02:27:07 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 02:27:07 INFO - (blobuploader) - INFO - Open directory for files ... 02:27:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 02:27:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:27:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:08 INFO - (blobuploader) - INFO - Done attempting. 02:27:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:27:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:27:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:09 INFO - (blobuploader) - INFO - Done attempting. 02:27:09 INFO - (blobuploader) - INFO - Iteration through files over. 02:27:09 INFO - Return code: 0 02:27:09 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:27:09 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:27:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c7cb3d7157a502e440f0974b7c0694e47246fd3a38d318d41c22c91eac5c2bbed62a074f29699980967778a7803ce728e590bd3957a931005a315f921a28b12", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a958820b96ec7592ba0beccfea272eeef23ed07d34700b09961161ec9d2afe45880be82f42ae0d828e0cd808013fc8d2fcc83b73306ea085f00e43ef7d77855f"} 02:27:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:27:09 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:27:09 INFO - Contents: 02:27:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c7cb3d7157a502e440f0974b7c0694e47246fd3a38d318d41c22c91eac5c2bbed62a074f29699980967778a7803ce728e590bd3957a931005a315f921a28b12", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a958820b96ec7592ba0beccfea272eeef23ed07d34700b09961161ec9d2afe45880be82f42ae0d828e0cd808013fc8d2fcc83b73306ea085f00e43ef7d77855f"} 02:27:09 INFO - Copying logs to upload dir... 02:27:09 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1278.300880 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-12-23 02:27:08.905455) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-23 02:27:08.908796) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1450846249.248039-444150760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c7cb3d7157a502e440f0974b7c0694e47246fd3a38d318d41c22c91eac5c2bbed62a074f29699980967778a7803ce728e590bd3957a931005a315f921a28b12", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a958820b96ec7592ba0beccfea272eeef23ed07d34700b09961161ec9d2afe45880be82f42ae0d828e0cd808013fc8d2fcc83b73306ea085f00e43ef7d77855f"} build_url:https://queue.taskcluster.net/v1/task/8y00M5PYQ3GSgBHURkjYTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011142 build_url: 'https://queue.taskcluster.net/v1/task/8y00M5PYQ3GSgBHURkjYTA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c7cb3d7157a502e440f0974b7c0694e47246fd3a38d318d41c22c91eac5c2bbed62a074f29699980967778a7803ce728e590bd3957a931005a315f921a28b12", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a958820b96ec7592ba0beccfea272eeef23ed07d34700b09961161ec9d2afe45880be82f42ae0d828e0cd808013fc8d2fcc83b73306ea085f00e43ef7d77855f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-23 02:27:08.933008) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 02:27:08.933289) ========= 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=d16fe3a243cfe9e60ec7df77000001e0-1450846249.248039-444150760 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.66 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 02:27:09.599696) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-23 02:27:09.599998) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-23 02:27:09.600532) ========= ========= Total master_lag: 0.84 =========