builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-049 starttime: 1450972366.04 results: success (0) buildid: 20151224053002 builduid: c71c3d898832458fbad699b3102d3613 revision: ea9e749bb86bfb584e8591959ac57278bf43c0e4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:46.040880) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:46.041597) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:46.042096) ========= 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=0c96bf5caf0e090009e1a122000001b2-1450969329.971396-692637892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006148 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:46.067195) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:46.067570) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:46.092298) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:46.092767) ========= 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=0c96bf5caf0e090009e1a122000001b2-1450969329.971396-692637892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.026825 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:46.142662) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:46.143031) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:46.143483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:46.143813) ========= 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=0c96bf5caf0e090009e1a122000001b2-1450969329.971396-692637892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-24 07:52:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 216M=0s 2015-12-24 07:52:46 (216 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.488231 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:46.644744) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:46.645055) ========= 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=0c96bf5caf0e090009e1a122000001b2-1450969329.971396-692637892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.070740 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:46.726277) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-24 07:52:46.726638) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ea9e749bb86bfb584e8591959ac57278bf43c0e4 --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 ea9e749bb86bfb584e8591959ac57278bf43c0e4 --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=0c96bf5caf0e090009e1a122000001b2-1450969329.971396-692637892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-24 07:52:47,107 truncating revision to first 12 chars 2015-12-24 07:52:47,107 Setting DEBUG logging. 2015-12-24 07:52:47,107 attempt 1/10 2015-12-24 07:52:47,107 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ea9e749bb86b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-24 07:52:48,215 unpacking tar archive at: fx-team-ea9e749bb86b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.373720 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-24 07:52:48.113649) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:48.114039) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:48.124507) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:48.124873) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-24 07:52:48.125379) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-24 07:52:48.125686) ========= /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=0c96bf5caf0e090009e1a122000001b2-1450969329.971396-692637892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:52:48 INFO - MultiFileLogger online at 20151224 07:52:48 in /builds/slave/test-pgo 07:52:48 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 07:52:48 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:52:48 INFO - {'append_to_log': False, 07:52:48 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:52:48 INFO - 'blob_upload_branch': 'Fx-Team', 07:52:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:52:48 INFO - 'branch': 'Fx-Team', 07:52:48 INFO - 'buildbot_json_path': 'buildprops.json', 07:52:48 INFO - 'config_files': ('talos/linux_config.py',), 07:52:48 INFO - 'default_actions': ('clobber', 07:52:48 INFO - 'read-buildbot-config', 07:52:48 INFO - 'download-and-extract', 07:52:48 INFO - 'populate-webroot', 07:52:48 INFO - 'create-virtualenv', 07:52:48 INFO - 'install', 07:52:48 INFO - 'run-tests'), 07:52:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:52:48 INFO - 'download_minidump_stackwalk': True, 07:52:48 INFO - 'download_symbols': 'ondemand', 07:52:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:52:48 INFO - 'tooltool.py': '/tools/tooltool.py', 07:52:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:52:48 INFO - '/tools/misc-python/virtualenv.py')}, 07:52:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:52:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:52:48 INFO - 'installer_path': 'installer.exe', 07:52:48 INFO - 'log_level': 'info', 07:52:48 INFO - 'log_name': 'talos', 07:52:48 INFO - 'log_to_console': True, 07:52:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:52:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:52:48 INFO - 'opt_config_files': (), 07:52:48 INFO - 'pip_index': False, 07:52:48 INFO - 'sps_profile': False, 07:52:48 INFO - 'sps_profile_interval': 0, 07:52:48 INFO - 'suite': 'dromaeojs', 07:52:48 INFO - 'system_bits': '64', 07:52:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:52:48 INFO - 'title': 'talos-linux64-ix-049', 07:52:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:52:48 INFO - 'use_talos_json': True, 07:52:48 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:52:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:52:48 INFO - 'work_dir': 'build'} 07:52:48 INFO - ##### 07:52:48 INFO - ##### Running clobber step. 07:52:48 INFO - ##### 07:52:48 INFO - Running pre-action listener: _resource_record_pre_action 07:52:48 INFO - Running main action method: clobber 07:52:48 INFO - rmtree: /builds/slave/test-pgo/build 07:52:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:52:49 INFO - Running post-action listener: _resource_record_post_action 07:52:49 INFO - ##### 07:52:49 INFO - ##### Running read-buildbot-config step. 07:52:49 INFO - ##### 07:52:49 INFO - Running pre-action listener: _resource_record_pre_action 07:52:49 INFO - Running main action method: read_buildbot_config 07:52:49 INFO - Using buildbot properties: 07:52:49 INFO - { 07:52:49 INFO - "project": "", 07:52:49 INFO - "product": "firefox", 07:52:49 INFO - "script_repo_revision": "production", 07:52:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:52:49 INFO - "repository": "", 07:52:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 07:52:49 INFO - "buildid": "20151224053002", 07:52:49 INFO - "pgo_build": "True", 07:52:49 INFO - "basedir": "/builds/slave/test-pgo", 07:52:49 INFO - "buildnumber": 384, 07:52:49 INFO - "slavename": "talos-linux64-ix-049", 07:52:49 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:52:49 INFO - "platform": "ubuntu64_hw", 07:52:49 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 07:52:49 INFO - "branch": "fx-team", 07:52:49 INFO - "repo_path": "integration/fx-team", 07:52:49 INFO - "revision": "ea9e749bb86bfb584e8591959ac57278bf43c0e4", 07:52:49 INFO - "stage_platform": "linux64-pgo", 07:52:49 INFO - "builduid": "c71c3d898832458fbad699b3102d3613", 07:52:49 INFO - "slavebuilddir": "test" 07:52:49 INFO - } 07:52:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:52:49 INFO - Running post-action listener: _resource_record_post_action 07:52:49 INFO - ##### 07:52:49 INFO - ##### Running download-and-extract step. 07:52:49 INFO - ##### 07:52:49 INFO - Running pre-action listener: _resource_record_pre_action 07:52:49 INFO - Running main action method: download_and_extract 07:52:49 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:49 INFO - https://queue.taskcluster.net/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:52:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/artifacts/public/build/test_packages.json 07:52:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/artifacts/public/build/test_packages.json 07:52:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:52:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:52:50 INFO - Downloaded 1302 bytes. 07:52:50 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:52:50 INFO - Using the following test package requirements: 07:52:50 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:52:50 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:52:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:52:50 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:52:50 INFO - u'jsshell-linux-x86_64.zip'], 07:52:50 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:52:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:52:50 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:52:50 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:52:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:52:50 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:52:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:52:50 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:52:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:52:50 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:52:50 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:52:50 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:52:50 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:52: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')]} 07:52:50 INFO - https://queue.taskcluster.net/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:52:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:52:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:52:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/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 07:52:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/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 07:52:51 INFO - Downloaded 23181976 bytes. 07:52:51 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 07:52:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:52:51 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 07:52:52 INFO - Return code: 0 07:52:52 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 07:52: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')]} 07:52:52 INFO - https://queue.taskcluster.net/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:52:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:52:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:52:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/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 07:52:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/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 07:52:55 INFO - Downloaded 23181976 bytes. 07:52:55 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 07:52:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:52:55 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 07:52:56 INFO - Return code: 0 07:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:56 INFO - https://queue.taskcluster.net/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:52:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:52:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:52:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/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 07:52:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/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 07:52:57 INFO - Downloaded 11132277 bytes. 07:52:57 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 07:52:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:52:57 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 07:52:57 INFO - Return code: 0 07:52: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')]} 07:52:57 INFO - https://queue.taskcluster.net/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:52:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:52:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:52:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/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 07:52:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/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 07:52:59 INFO - Downloaded 54843646 bytes. 07:52:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:52:59 INFO - mkdir: /builds/slave/test-pgo/properties 07:52:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:52:59 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:52:59 INFO - Contents: 07:52:59 INFO - build_url:https://queue.taskcluster.net/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:52:59 INFO - Running post-action listener: _resource_record_post_action 07:52:59 INFO - Running post-action listener: set_extra_try_arguments 07:52:59 INFO - ##### 07:52:59 INFO - ##### Running populate-webroot step. 07:52:59 INFO - ##### 07:52:59 INFO - Running pre-action listener: _resource_record_pre_action 07:52:59 INFO - Running main action method: populate_webroot 07:52:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:52:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:52:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:52:59 INFO - '--tppagecycles', 07:52:59 INFO - '7'], 07:52:59 INFO - 'tests': ['tsvgm']}}, 07:52:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:52:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:52:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:52:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:52:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:52:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:52:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:52:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:59 INFO - 'talos_options': ['--e10s'], 07:52:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:52:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:59 INFO - 'tests': ['damp', 'tps']}, 07:52:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:59 INFO - 'talos_options': ['--e10s'], 07:52:59 INFO - 'tests': ['damp', 'tps']}, 07:52:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:52:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:52:59 INFO - 'other': {'tests': ['a11yr', 07:52:59 INFO - 'ts_paint', 07:52:59 INFO - 'tpaint', 07:52:59 INFO - 'sessionrestore', 07:52:59 INFO - 'sessionrestore_no_auto_restore']}, 07:52:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:52:59 INFO - 'tests': ['a11yr', 07:52:59 INFO - 'ts_paint', 07:52:59 INFO - 'tpaint', 07:52:59 INFO - 'sessionrestore', 07:52:59 INFO - 'sessionrestore_no_auto_restore']}, 07:52:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:52:59 INFO - 'tests': ['a11yr', 07:52:59 INFO - 'ts_paint', 07:52:59 INFO - 'tpaint', 07:52:59 INFO - 'sessionrestore', 07:52:59 INFO - 'sessionrestore_no_auto_restore']}, 07:52:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:52:59 INFO - 'tests': ['a11yr', 07:52:59 INFO - 'ts_paint', 07:52:59 INFO - 'tpaint', 07:52:59 INFO - 'sessionrestore', 07:52:59 INFO - 'sessionrestore_no_auto_restore']}, 07:52:59 INFO - 'other_l64': {'tests': ['a11yr', 07:52:59 INFO - 'ts_paint', 07:52:59 INFO - 'tpaint', 07:52:59 INFO - 'sessionrestore', 07:52:59 INFO - 'sessionrestore_no_auto_restore']}, 07:52:59 INFO - 'other_nol64': {'tests': ['a11yr', 07:52:59 INFO - 'ts_paint', 07:52:59 INFO - 'tpaint', 07:52:59 INFO - 'sessionrestore', 07:52:59 INFO - 'sessionrestore_no_auto_restore']}, 07:52:59 INFO - 'svgr': {'tests': ['tsvgx', 07:52:59 INFO - 'tsvgr_opacity', 07:52:59 INFO - 'tart', 07:52:59 INFO - 'tscrollx', 07:52:59 INFO - 'cart']}, 07:52:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:52:59 INFO - 'tests': ['tsvgx', 07:52:59 INFO - 'tsvgr_opacity', 07:52:59 INFO - 'tart', 07:52:59 INFO - 'tscrollx', 07:52:59 INFO - 'cart']}, 07:52:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:59 INFO - 'tests': ['tp5o']}, 07:52:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:59 INFO - 'talos_options': ['--e10s'], 07:52:59 INFO - 'tests': ['tp5o']}, 07:52:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:59 INFO - 'talos_options': ['--xperf_path', 07:52:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:52:59 INFO - 'tests': ['tp5n']}, 07:52:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:59 INFO - 'talos_options': ['--e10s', 07:52:59 INFO - '--xperf_path', 07:52:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:52:59 INFO - 'tests': ['tp5n']}}, 07:52:59 INFO - 'talos.zip': {'path': '', 07:52:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:52:59 INFO - Running post-action listener: _resource_record_post_action 07:52:59 INFO - ##### 07:52:59 INFO - ##### Running create-virtualenv step. 07:52:59 INFO - ##### 07:52:59 INFO - Running pre-action listener: _resource_record_pre_action 07:52:59 INFO - Running main action method: create_virtualenv 07:52:59 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:52:59 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 07:52:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:52:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:52:59 INFO - Using real prefix '/usr' 07:52:59 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:52:59 INFO - Installing distribute.............................................................................................................................................................................................done. 07:53:01 INFO - Installing pip.................done. 07:53:01 INFO - Return code: 0 07:53:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7754c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2732630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c3840>, '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 0x27306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730b60>, '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': '0c96bf5caf0e090009e1a122000001b2-1450969329.971396-692637892', '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 07:53:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 07:53:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:53:01 INFO - Using env: {'DISPLAY': ':0', 07:53:01 INFO - 'HOME': '/home/cltbld', 07:53:01 INFO - 'LANG': 'en_US.UTF-8', 07:53:01 INFO - 'LANGUAGE': 'en_US:en', 07:53:01 INFO - 'LOGNAME': 'cltbld', 07:53:01 INFO - 'MAIL': '/var/mail/cltbld', 07:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:01 INFO - 'MOZ_NO_REMOTE': '1', 07:53:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:01 INFO - 'NO_EM_RESTART': '1', 07:53:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:01 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:01 INFO - 'SHELL': '/bin/bash', 07:53:01 INFO - 'SHLVL': '1', 07:53:01 INFO - 'TERM': 'linux', 07:53:01 INFO - 'TMOUT': '86400', 07:53:01 INFO - 'USER': 'cltbld', 07:53:01 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450969329.971396-692637892', 07:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:01 INFO - '_': '/tools/buildbot/bin/python'} 07:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:01 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 07:53:01 INFO - Cleaning up... 07:53:01 INFO - Return code: 0 07:53:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc7754c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2732630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c3840>, '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 0x27306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730b60>, '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': '0c96bf5caf0e090009e1a122000001b2-1450969329.971396-692637892', '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 07:53:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 07:53:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:53:01 INFO - Using env: {'DISPLAY': ':0', 07:53:01 INFO - 'HOME': '/home/cltbld', 07:53:01 INFO - 'LANG': 'en_US.UTF-8', 07:53:01 INFO - 'LANGUAGE': 'en_US:en', 07:53:01 INFO - 'LOGNAME': 'cltbld', 07:53:01 INFO - 'MAIL': '/var/mail/cltbld', 07:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:01 INFO - 'MOZ_NO_REMOTE': '1', 07:53:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:01 INFO - 'NO_EM_RESTART': '1', 07:53:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:01 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:01 INFO - 'SHELL': '/bin/bash', 07:53:01 INFO - 'SHLVL': '1', 07:53:01 INFO - 'TERM': 'linux', 07:53:01 INFO - 'TMOUT': '86400', 07:53:01 INFO - 'USER': 'cltbld', 07:53:01 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450969329.971396-692637892', 07:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:01 INFO - '_': '/tools/buildbot/bin/python'} 07:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:02 INFO - Downloading/unpacking psutil>=0.7.1 07:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:03 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:53:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:53:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:53:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:53:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:53:03 INFO - Installing collected packages: psutil 07:53:03 INFO - Running setup.py install for psutil 07:53:04 INFO - building 'psutil._psutil_linux' extension 07:53:04 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 07:53:04 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 07:53:04 INFO - building 'psutil._psutil_posix' extension 07:53:04 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 07:53:04 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 07:53:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:53:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:53:04 INFO - Successfully installed psutil 07:53:04 INFO - Cleaning up... 07:53:04 INFO - Return code: 0 07:53:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc7754c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2732630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c3840>, '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 0x27306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730b60>, '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': '0c96bf5caf0e090009e1a122000001b2-1450969329.971396-692637892', '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 07:53:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 07:53:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:53:04 INFO - Using env: {'DISPLAY': ':0', 07:53:04 INFO - 'HOME': '/home/cltbld', 07:53:04 INFO - 'LANG': 'en_US.UTF-8', 07:53:04 INFO - 'LANGUAGE': 'en_US:en', 07:53:04 INFO - 'LOGNAME': 'cltbld', 07:53:04 INFO - 'MAIL': '/var/mail/cltbld', 07:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:04 INFO - 'MOZ_NO_REMOTE': '1', 07:53:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:04 INFO - 'NO_EM_RESTART': '1', 07:53:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:04 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:04 INFO - 'SHELL': '/bin/bash', 07:53:04 INFO - 'SHLVL': '1', 07:53:04 INFO - 'TERM': 'linux', 07:53:04 INFO - 'TMOUT': '86400', 07:53:04 INFO - 'USER': 'cltbld', 07:53:04 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450969329.971396-692637892', 07:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:04 INFO - '_': '/tools/buildbot/bin/python'} 07:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:53:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:53:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:53:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:53:06 INFO - Installing collected packages: mozsystemmonitor 07:53:06 INFO - Running setup.py install for mozsystemmonitor 07:53:06 INFO - Successfully installed mozsystemmonitor 07:53:06 INFO - Cleaning up... 07:53:06 INFO - Return code: 0 07:53:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:53: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')]} 07:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53: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')]} 07:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:06 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 0x7fc7754c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2732630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c3840>, '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 0x27306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730b60>, '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': '0c96bf5caf0e090009e1a122000001b2-1450969329.971396-692637892', '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 07:53:06 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 07:53:06 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 07:53:06 INFO - Using env: {'DISPLAY': ':0', 07:53:06 INFO - 'HOME': '/home/cltbld', 07:53:06 INFO - 'LANG': 'en_US.UTF-8', 07:53:06 INFO - 'LANGUAGE': 'en_US:en', 07:53:06 INFO - 'LOGNAME': 'cltbld', 07:53:06 INFO - 'MAIL': '/var/mail/cltbld', 07:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:06 INFO - 'MOZ_NO_REMOTE': '1', 07:53:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:06 INFO - 'NO_EM_RESTART': '1', 07:53:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:06 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:06 INFO - 'SHELL': '/bin/bash', 07:53:06 INFO - 'SHLVL': '1', 07:53:06 INFO - 'TERM': 'linux', 07:53:06 INFO - 'TMOUT': '86400', 07:53:06 INFO - 'USER': 'cltbld', 07:53:06 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450969329.971396-692637892', 07:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:06 INFO - '_': '/tools/buildbot/bin/python'} 07:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:06 INFO - Downloading/unpacking blobuploader==1.2.4 07:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:08 INFO - Downloading blobuploader-1.2.4.tar.gz 07:53:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:53:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:53:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:53:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:53:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:09 INFO - Downloading docopt-0.6.1.tar.gz 07:53:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:53:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:53:09 INFO - Installing collected packages: blobuploader, requests, docopt 07:53:09 INFO - Running setup.py install for blobuploader 07:53:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:53:09 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:53:09 INFO - Running setup.py install for requests 07:53:09 INFO - Running setup.py install for docopt 07:53:09 INFO - Successfully installed blobuploader requests docopt 07:53:09 INFO - Cleaning up... 07:53:09 INFO - Return code: 0 07:53:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:53:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:09 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 0x7fc7754c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2732630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c3840>, '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 0x27306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730b60>, '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': '0c96bf5caf0e090009e1a122000001b2-1450969329.971396-692637892', '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 07:53:09 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 07:53:09 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 07:53:09 INFO - Using env: {'DISPLAY': ':0', 07:53:09 INFO - 'HOME': '/home/cltbld', 07:53:09 INFO - 'LANG': 'en_US.UTF-8', 07:53:09 INFO - 'LANGUAGE': 'en_US:en', 07:53:09 INFO - 'LOGNAME': 'cltbld', 07:53:09 INFO - 'MAIL': '/var/mail/cltbld', 07:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:09 INFO - 'MOZ_NO_REMOTE': '1', 07:53:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:09 INFO - 'NO_EM_RESTART': '1', 07:53:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:09 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:09 INFO - 'SHELL': '/bin/bash', 07:53:09 INFO - 'SHLVL': '1', 07:53:09 INFO - 'TERM': 'linux', 07:53:09 INFO - 'TMOUT': '86400', 07:53:09 INFO - 'USER': 'cltbld', 07:53:09 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450969329.971396-692637892', 07:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:09 INFO - '_': '/tools/buildbot/bin/python'} 07:53:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:53:10 INFO - Running setup.py (path:/tmp/pip-pX2_7Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:53:10 INFO - Running setup.py (path:/tmp/pip-kPfFKh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:53:10 INFO - Running setup.py (path:/tmp/pip-wK5P1W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:53:10 INFO - Running setup.py (path:/tmp/pip-sIxnF9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:53:10 INFO - Running setup.py (path:/tmp/pip-kQHXfj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:53:10 INFO - Running setup.py (path:/tmp/pip-8nLsXY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:53:10 INFO - Running setup.py (path:/tmp/pip-XV4TXJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:53:10 INFO - Running setup.py (path:/tmp/pip-U8pMr9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:53:10 INFO - Running setup.py (path:/tmp/pip-xEbWvB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:53:10 INFO - Running setup.py (path:/tmp/pip-KF7pbz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:53:10 INFO - Running setup.py (path:/tmp/pip-N32drL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:53:10 INFO - Running setup.py (path:/tmp/pip-tI2nQ0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:53:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:53:10 INFO - Running setup.py (path:/tmp/pip-7DaHUV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:53:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:53:11 INFO - Running setup.py (path:/tmp/pip-sJqD8l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:53:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:53:11 INFO - Running setup.py (path:/tmp/pip-swwi76-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:53:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:53:11 INFO - Running setup.py (path:/tmp/pip-1DFPrY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:53:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:53:11 INFO - Running setup.py (path:/tmp/pip-wKv_ev-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:53:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:53:11 INFO - Running setup.py install for manifestparser 07:53:11 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:53:11 INFO - Running setup.py install for mozcrash 07:53:11 INFO - Running setup.py install for mozdebug 07:53:11 INFO - Running setup.py install for mozdevice 07:53:11 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:53:11 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:53:11 INFO - Running setup.py install for mozfile 07:53:11 INFO - Running setup.py install for mozhttpd 07:53:11 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:53:11 INFO - Running setup.py install for mozinfo 07:53:12 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:53:12 INFO - Running setup.py install for mozInstall 07:53:12 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:53:12 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:53:12 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:53:12 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:53:12 INFO - Running setup.py install for mozleak 07:53:12 INFO - Running setup.py install for mozlog 07:53:12 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:53:12 INFO - Running setup.py install for moznetwork 07:53:12 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:53:12 INFO - Running setup.py install for mozprocess 07:53:12 INFO - Running setup.py install for mozprofile 07:53:12 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:53:12 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:53:12 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:53:12 INFO - Running setup.py install for mozrunner 07:53:12 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:53:12 INFO - Running setup.py install for mozscreenshot 07:53:12 INFO - Running setup.py install for moztest 07:53:13 INFO - Running setup.py install for mozversion 07:53:13 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:53:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:53:13 INFO - Cleaning up... 07:53:13 INFO - Return code: 0 07:53:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:53:13 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')]} 07:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:13 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')]} 07:53:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:13 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 0x7fc7754c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2732630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c3840>, '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 0x27306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730b60>, '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': '0c96bf5caf0e090009e1a122000001b2-1450969329.971396-692637892', '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 07:53:13 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 07:53:13 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 07:53:13 INFO - Using env: {'DISPLAY': ':0', 07:53:13 INFO - 'HOME': '/home/cltbld', 07:53:13 INFO - 'LANG': 'en_US.UTF-8', 07:53:13 INFO - 'LANGUAGE': 'en_US:en', 07:53:13 INFO - 'LOGNAME': 'cltbld', 07:53:13 INFO - 'MAIL': '/var/mail/cltbld', 07:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:13 INFO - 'MOZ_NO_REMOTE': '1', 07:53:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:13 INFO - 'NO_EM_RESTART': '1', 07:53:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:13 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:13 INFO - 'SHELL': '/bin/bash', 07:53:13 INFO - 'SHLVL': '1', 07:53:13 INFO - 'TERM': 'linux', 07:53:13 INFO - 'TMOUT': '86400', 07:53:13 INFO - 'USER': 'cltbld', 07:53:13 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450969329.971396-692637892', 07:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:13 INFO - '_': '/tools/buildbot/bin/python'} 07:53:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:53:13 INFO - Running setup.py (path:/tmp/pip-t37VS8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:53:13 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)) 07:53:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:53:13 INFO - Running setup.py (path:/tmp/pip-xMlF2r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:53:13 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)) 07:53:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:53:13 INFO - Running setup.py (path:/tmp/pip-1fWnxT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:53:13 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)) 07:53:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:53:13 INFO - Running setup.py (path:/tmp/pip-W1S708-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:53:13 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)) 07:53:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:53:13 INFO - Running setup.py (path:/tmp/pip-VyM9Ll-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:53:13 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)) 07:53:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:53:13 INFO - Running setup.py (path:/tmp/pip-1S1igl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:53:13 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)) 07:53:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:53:13 INFO - Running setup.py (path:/tmp/pip-0nDTnt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:53:13 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)) 07:53:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:53:13 INFO - Running setup.py (path:/tmp/pip-wWA4g2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:53:13 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)) 07:53:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:53:13 INFO - Running setup.py (path:/tmp/pip-pZFGMP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:53:13 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)) 07:53:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:53:13 INFO - Running setup.py (path:/tmp/pip-pPxQhw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:53:14 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)) 07:53:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:53:14 INFO - Running setup.py (path:/tmp/pip-B0xsmx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:53:14 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)) 07:53:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:53:14 INFO - Running setup.py (path:/tmp/pip-ztBNmR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:53:14 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)) 07:53:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:53:14 INFO - Running setup.py (path:/tmp/pip-OV3NSa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:53:14 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)) 07:53:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:53:14 INFO - Running setup.py (path:/tmp/pip-QNPuK1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:53:14 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)) 07:53:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:53:14 INFO - Running setup.py (path:/tmp/pip-VSLhyt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:53:14 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)) 07:53:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:53:14 INFO - Running setup.py (path:/tmp/pip-vYOtXK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:53:14 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)) 07:53:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:53:14 INFO - Running setup.py (path:/tmp/pip-pG5RQx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:53:14 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)) 07:53:14 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)) 07:53:14 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)) 07:53:14 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)) 07:53:14 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)) 07:53:14 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)) 07:53:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53:16 INFO - Downloading blessings-1.5.1.tar.gz 07:53:16 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 07:53:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:53:16 INFO - Installing collected packages: blessings 07:53:16 INFO - Running setup.py install for blessings 07:53:16 INFO - Successfully installed blessings 07:53:16 INFO - Cleaning up... 07:53:16 INFO - Return code: 0 07:53:16 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:53:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:53:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:53:16 INFO - Reading from file tmpfile_stdout 07:53:16 INFO - Current package versions: 07:53:16 INFO - argparse == 1.2.1 07:53:16 INFO - blessings == 1.5.1 07:53:16 INFO - blobuploader == 1.2.4 07:53:16 INFO - docopt == 0.6.1 07:53:16 INFO - manifestparser == 1.1 07:53:16 INFO - mozInstall == 1.12 07:53:16 INFO - mozcrash == 0.16 07:53:16 INFO - mozdebug == 0.1 07:53:16 INFO - mozdevice == 0.47 07:53:16 INFO - mozfile == 1.2 07:53:16 INFO - mozhttpd == 0.7 07:53:16 INFO - mozinfo == 0.9 07:53:16 INFO - mozleak == 0.1 07:53:16 INFO - mozlog == 3.1 07:53:16 INFO - moznetwork == 0.27 07:53:16 INFO - mozprocess == 0.22 07:53:16 INFO - mozprofile == 0.28 07:53:16 INFO - mozrunner == 6.11 07:53:16 INFO - mozscreenshot == 0.1 07:53:16 INFO - mozsystemmonitor == 0.0 07:53:16 INFO - moztest == 0.7 07:53:16 INFO - mozversion == 1.4 07:53:16 INFO - psutil == 3.1.1 07:53:16 INFO - requests == 1.2.3 07:53:16 INFO - wsgiref == 0.1.2 07:53:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:53: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')]} 07:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53: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')]} 07:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53: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', '-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 0x7fc7754c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2732630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c3840>, '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 0x27306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730b60>, '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': '0c96bf5caf0e090009e1a122000001b2-1450969329.971396-692637892', '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 07:53:16 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 07:53:16 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 07:53:16 INFO - Using env: {'DISPLAY': ':0', 07:53:16 INFO - 'HOME': '/home/cltbld', 07:53:16 INFO - 'LANG': 'en_US.UTF-8', 07:53:16 INFO - 'LANGUAGE': 'en_US:en', 07:53:16 INFO - 'LOGNAME': 'cltbld', 07:53:16 INFO - 'MAIL': '/var/mail/cltbld', 07:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:16 INFO - 'MOZ_NO_REMOTE': '1', 07:53:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:16 INFO - 'NO_EM_RESTART': '1', 07:53:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:16 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:16 INFO - 'SHELL': '/bin/bash', 07:53:16 INFO - 'SHLVL': '1', 07:53:16 INFO - 'TERM': 'linux', 07:53:16 INFO - 'TMOUT': '86400', 07:53:16 INFO - 'USER': 'cltbld', 07:53:16 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450969329.971396-692637892', 07:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:16 INFO - '_': '/tools/buildbot/bin/python'} 07:53:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:16 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)) 07:53:16 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)) 07:53:16 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)) 07:53:16 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)) 07:53:16 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)) 07:53:16 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)) 07:53:16 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)) 07:53:16 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)) 07:53:16 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)) 07:53:16 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)) 07:53:16 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)) 07:53:16 INFO - Cleaning up... 07:53:16 INFO - Return code: 0 07:53:16 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:53: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')]} 07:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53: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')]} 07:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7754c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2732630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c3840>, '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 0x27306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730b60>, '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': '0c96bf5caf0e090009e1a122000001b2-1450969329.971396-692637892', '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 07:53: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', 'jsonschema'] in /builds/slave/test-pgo/build 07:53: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 jsonschema 07:53:16 INFO - Using env: {'DISPLAY': ':0', 07:53:16 INFO - 'HOME': '/home/cltbld', 07:53:16 INFO - 'LANG': 'en_US.UTF-8', 07:53:16 INFO - 'LANGUAGE': 'en_US:en', 07:53:16 INFO - 'LOGNAME': 'cltbld', 07:53:16 INFO - 'MAIL': '/var/mail/cltbld', 07:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:16 INFO - 'MOZ_NO_REMOTE': '1', 07:53:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:16 INFO - 'NO_EM_RESTART': '1', 07:53:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:16 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:16 INFO - 'SHELL': '/bin/bash', 07:53:16 INFO - 'SHLVL': '1', 07:53:16 INFO - 'TERM': 'linux', 07:53:16 INFO - 'TMOUT': '86400', 07:53:16 INFO - 'USER': 'cltbld', 07:53:16 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450969329.971396-692637892', 07:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:16 INFO - '_': '/tools/buildbot/bin/python'} 07:53:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:17 INFO - Downloading/unpacking jsonschema 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:53:18 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 07:53:18 INFO - Downloading/unpacking functools32 (from jsonschema) 07:53:18 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 07:53:18 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 07:53:18 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 07:53:18 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 07:53:18 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 07:53:18 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 07:53:18 INFO - Downloading functools32-3.2.3-2.tar.gz 07:53:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:53:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:53:19 INFO - warning: no files found matching '*.txt' 07:53:19 INFO - no previously-included directories found matching 'build' 07:53:19 INFO - no previously-included directories found matching 'dist' 07:53:19 INFO - no previously-included directories found matching '.git*' 07:53:19 INFO - Installing collected packages: jsonschema, functools32 07:53:19 INFO - Running setup.py install for functools32 07:53:19 INFO - warning: no files found matching '*.txt' 07:53:19 INFO - no previously-included directories found matching 'build' 07:53:19 INFO - no previously-included directories found matching 'dist' 07:53:19 INFO - no previously-included directories found matching '.git*' 07:53:19 INFO - Successfully installed jsonschema functools32 07:53:19 INFO - Cleaning up... 07:53:19 INFO - Return code: 0 07:53:19 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:53: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')]} 07:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53: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')]} 07:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7754c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2732630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c3840>, '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 0x27306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730b60>, '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': '0c96bf5caf0e090009e1a122000001b2-1450969329.971396-692637892', '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 07:53: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', 'flake8'] in /builds/slave/test-pgo/build 07:53: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 flake8 07:53:19 INFO - Using env: {'DISPLAY': ':0', 07:53:19 INFO - 'HOME': '/home/cltbld', 07:53:19 INFO - 'LANG': 'en_US.UTF-8', 07:53:19 INFO - 'LANGUAGE': 'en_US:en', 07:53:19 INFO - 'LOGNAME': 'cltbld', 07:53:19 INFO - 'MAIL': '/var/mail/cltbld', 07:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:19 INFO - 'MOZ_NO_REMOTE': '1', 07:53:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:19 INFO - 'NO_EM_RESTART': '1', 07:53:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:19 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:19 INFO - 'SHELL': '/bin/bash', 07:53:19 INFO - 'SHLVL': '1', 07:53:19 INFO - 'TERM': 'linux', 07:53:19 INFO - 'TMOUT': '86400', 07:53:19 INFO - 'USER': 'cltbld', 07:53:19 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450969329.971396-692637892', 07:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:19 INFO - '_': '/tools/buildbot/bin/python'} 07:53:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:19 INFO - Downloading/unpacking flake8 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:53:21 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 07:53:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:53:21 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 07:53:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53:21 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 07:53:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53: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 07:53:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:53:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:53:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:53:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:53:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:53:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:53:21 INFO - no previously-included directories found matching 'docs/_build' 07:53:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:53:21 INFO - Running setup.py install for pep8 07:53:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:53:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:53:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:53:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:53:21 INFO - no previously-included directories found matching 'docs/_build' 07:53:21 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:53:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:53:21 INFO - Cleaning up... 07:53:22 INFO - Return code: 0 07:53:22 INFO - Running post-action listener: _resource_record_post_action 07:53:22 INFO - Running post-action listener: _start_resource_monitoring 07:53:22 INFO - Starting resource monitoring. 07:53:22 INFO - ##### 07:53:22 INFO - ##### Running install step. 07:53:22 INFO - ##### 07:53:22 INFO - Running pre-action listener: _resource_record_pre_action 07:53:22 INFO - Running main action method: install 07:53:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:53:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:53:22 INFO - Reading from file tmpfile_stdout 07:53:22 INFO - Detecting whether we're running mozinstall >=1.0... 07:53:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:53:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:53:22 INFO - Reading from file tmpfile_stdout 07:53:22 INFO - Output received: 07:53:22 INFO - Usage: mozinstall [options] installer 07:53:22 INFO - Options: 07:53:22 INFO - -h, --help show this help message and exit 07:53:22 INFO - -d DEST, --destination=DEST 07:53:22 INFO - Directory to install application into. [default: 07:53:22 INFO - "/builds/slave/test-pgo"] 07:53:22 INFO - --app=APP Application being installed. [default: firefox] 07:53:22 INFO - mkdir: /builds/slave/test-pgo/build/application 07:53:22 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'] 07:53:22 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 07:53:38 INFO - Reading from file tmpfile_stdout 07:53:38 INFO - Output received: 07:53:38 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:53:38 INFO - Running post-action listener: _resource_record_post_action 07:53:38 INFO - ##### 07:53:38 INFO - ##### Running run-tests step. 07:53:38 INFO - ##### 07:53:38 INFO - Running pre-action listener: _resource_record_pre_action 07:53:38 INFO - Running main action method: run_tests 07:53:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:53:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:53:38 INFO - Python 2.7.3 07:53:38 INFO - Return code: 0 07:53:38 INFO - grabbing minidump binary from tooltool 07:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:53:38 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 0x27c3840>, '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 0x27306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2730b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:53:38 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 07:53:38 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 07:53:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:53:38 INFO - Return code: 0 07:53:38 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:53:38 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:53:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:53:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:53:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:53:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:53:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:53:39 INFO - Return code: 0 07:53:39 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/GEvTG34xSTaZ-Dbd0-hcCg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 07:53:39 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/GEvTG34xSTaZ-Dbd0-hcCg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 07:53:39 INFO - Using env: {'DISPLAY': ':0', 07:53:39 INFO - 'HOME': '/home/cltbld', 07:53:39 INFO - 'LANG': 'en_US.UTF-8', 07:53:39 INFO - 'LANGUAGE': 'en_US:en', 07:53:39 INFO - 'LOGNAME': 'cltbld', 07:53:39 INFO - 'MAIL': '/var/mail/cltbld', 07:53:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:53:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:53:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:39 INFO - 'MOZ_NO_REMOTE': '1', 07:53:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:53:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:39 INFO - 'NO_EM_RESTART': '1', 07:53:39 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:53:39 INFO - 'PWD': '/builds/slave/test-pgo', 07:53:39 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:53:39 INFO - 'SHELL': '/bin/bash', 07:53:39 INFO - 'SHLVL': '1', 07:53:39 INFO - 'TERM': 'linux', 07:53:39 INFO - 'TMOUT': '86400', 07:53:39 INFO - 'USER': 'cltbld', 07:53:39 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1450969329.971396-692637892', 07:53:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:39 INFO - '_': '/tools/buildbot/bin/python'} 07:53:39 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/GEvTG34xSTaZ-Dbd0-hcCg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 07:53:39 INFO - mozversion application_buildid: 20151224053002 07:53:39 INFO - mozversion application_changeset: ea9e749bb86bfb584e8591959ac57278bf43c0e4 07:53:39 INFO - mozversion application_display_name: Nightly 07:53:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:53:39 INFO - mozversion application_name: Firefox 07:53:39 INFO - mozversion application_remotingname: firefox 07:53:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:53:39 INFO - mozversion application_vendor: Mozilla 07:53:39 INFO - mozversion application_version: 46.0a1 07:53:39 INFO - mozversion platform_buildid: 20151224053002 07:53:39 INFO - mozversion platform_changeset: ea9e749bb86bfb584e8591959ac57278bf43c0e4 07:53:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:53:39 INFO - mozversion platform_version: 46.0a1 07:53:39 INFO - using testdate: 1450972419 07:53:39 INFO - actual date: 1450972419 07:53:39 INFO - starting webserver on 'localhost:44194' 07:53:39 INFO - SUITE-START | Running 3 tests 07:53:39 INFO - TEST-START | dromaeo_css 07:53:39 INFO - operating with platform_type : linux_ 07:53:39 INFO - Initialising browser for dromaeo_css test... 07:53:39 INFO - TEST-INFO | started process 15481 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDqC692/profile http://localhost:44194/getInfo.html) 07:53:43 INFO - PROCESS | 15481 | __metrics Screen width/height:1600/1200 07:53:43 INFO - PROCESS | 15481 | colorDepth:24 07:53:43 INFO - PROCESS | 15481 | Browser inner width/height: 1024/697 07:53:43 INFO - PROCESS | 15481 | __metrics 07:53:43 INFO - PROCESS | 15481 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:53:43 INFO - PROCESS | 15481 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:53:44 INFO - TEST-INFO | 15481: exit 0 07:53:44 INFO - Browser initialized. 07:53:44 INFO - Running cycle 1/1 for dromaeo_css test... 07:53:44 INFO - TEST-INFO | started process 15574 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDqC692/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:53:56 INFO - PROCESS | 15574 | RSS: Main: 148881408 07:53:56 INFO - PROCESS | 15574 | 07:54:47 INFO - PROCESS | 15574 | 1450972487919 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] 07:56:56 INFO - PROCESS | 15574 | Cycle 1(1): loaded http://localhost:44194/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44194/tests/dromaeo/cssquery-ext.html) 07:56:57 INFO - PROCESS | 15574 | RSS: Main: 275177472 07:56:57 INFO - PROCESS | 15574 | 08:00:00 INFO - PROCESS | 15574 | Cycle 1(1): loaded http://localhost:44194/tests/dromaeo/cssquery-ext.html (next: http://localhost:44194/tests/dromaeo/cssquery-jquery.html) 08:00:00 INFO - PROCESS | 15574 | RSS: Main: 229384192 08:00:00 INFO - PROCESS | 15574 | 08:03:02 INFO - PROCESS | 15574 | Cycle 1(1): loaded http://localhost:44194/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44194/tests/dromaeo/cssquery-mootools.html) 08:03:03 INFO - PROCESS | 15574 | RSS: Main: 219705344 08:03:03 INFO - PROCESS | 15574 | 08:06:04 INFO - PROCESS | 15574 | Cycle 1(1): loaded http://localhost:44194/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44194/tests/dromaeo/cssquery-prototype.html) 08:06:05 INFO - PROCESS | 15574 | RSS: Main: 209596416 08:06:05 INFO - PROCESS | 15574 | 08:09:08 INFO - PROCESS | 15574 | Cycle 1(1): loaded http://localhost:44194/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44194/tests/dromaeo/cssquery-yui.html) 08:09:08 INFO - PROCESS | 15574 | RSS: Main: 213536768 08:09:08 INFO - PROCESS | 15574 | 08:12:11 INFO - PROCESS | 15574 | Cycle 1(1): loaded http://localhost:44194/tests/dromaeo/cssquery-yui.html (next: http://localhost:44194/tests/dromaeo/cssquery-dojo.html) 08:12:11 INFO - PROCESS | 15574 | RSS: Main: 280227840 08:12:11 INFO - PROCESS | 15574 | 08:12:11 INFO - PROCESS | 15574 | __start_tp_report 08:12:11 INFO - PROCESS | 15574 | _x_x_mozilla_page_load 08:12:11 INFO - PROCESS | 15574 | _x_x_mozilla_page_load_details 08:12:11 INFO - PROCESS | 15574 | |i|pagename|runs| 08:12:11 INFO - PROCESS | 15574 | |0;dojo.html;3046.7714921380903;3104.5808815809864;3149.2756665966826;3160.510120931255;3178.3961047400985;5127.025865085631;5166.483351664836;5189.662671926322;5190.429052804188;5239.633225674204;5117.462666420028;5169.948300516994;5221.86945326367;5252.474752524746;5261.210818377245;4755.45312289086;4766.332713420124;4810.927836082462;4992.725400102993;5017.272495488152;4922.433920099199;4931;4972;4995.150824359867;5009.849704508871;4651.2790517469675;4741.644376671763;4775.259834725605;4877.244027175793;4881.902361952741;4806.951930480685;4821.590164835993;4845.030993801254;4847.103285892122;4888.608911287124;4796.304535842283;4817.903641927177;4829.154897892855;4831.178699621073;4893.535114164149;4898.5591296783105;4986.127427700174;4993.6005119590345;5130.71781052042;5147.202183661539;5661.5187709044785;5667.319921609434;5667.659940403589;5669.716514174316;5677.318721753375;5663.377028526858;5687;5692.174634677948;5692.17463467799;5694.487496125327;5152.098382782998;5186.507281808223;5239.73801309933;5253.264542963988;5279.260903473517;5779.190913272145;5817;5824.213731146326;5863.70681465925;5872.119182122716;5615.101583746581;5615.185798059259;5619;5622.381538030813;5622.718864056781;5459.918101228484;5504.284443022381;5597.3003374578175;5690.374058853523;5710.371859095496;5605.7197140142825;5679.176519404663;5684.857878553069;5685.658860468302;5689.203511508392;5658.292713410824;5672.14917762339;5672.858178545487;5673.716314184357;5682.232898558642;4303.763293018851;4312.762798046075;4355.760433176142;4371.912561748747;4399.64802815774;3876.612338766101;3926.632661676854;3940.0543869471694;3969.80150992455;3971.5035620547433;5028.220625803006;5175.5970598627655;5224.686518808883;5229.346331708536;5229.50319719626;5521.668699878021;5575.721213939287;5611.6352437091455;5657.490825825613;5658.7170641467765;5165.690058596496;5170.457102004236;5173.922391164136;5175.301334319894;5184.196449550326;4870.342503762017;4871.025794841046;4871.074495845778;4874.268859671078;4914.410270767531;5405.513503784599;5417.756200970887;5454.59090568209;5506.311711036121;5520.972395137998;5558.972205138948;5560.221568980427;5565.1374037024325;5590.720463976866;5663;5587.608867379245;5589.301337332833;5589.720513974204;5592.916106258491;5610.4670056344585;5345.305110335631;5435.510804027498;5445.292112025411;5499;5541.16882467617;5611.2424822650055;5650.773969041193;5663.745131469176;5669.092945128759;5675.0636145035605;5244.501772331622;5529.419410961791;5539.667619942817;5546.694931778629;5547.41752116022;5425.457454254543;5440.727963601725;5494.09347457665;5494.120940649477;5536.363318218296;5447.346318441654;5453.454654534515;5457.399686034612;5459.481349271813;5462.289902312674;5291.814786482455;5513.035218836607;5552.333719953632;5594.524465420485;5598.188262701804;5300.893982120413;5360.70516121617;5376.677399356051;5379.973100134474;5416.187571864252 08:12:11 INFO - PROCESS | 15574 | |1;ext.html;554.4962839020974;588.4439204951317;600.6006006006006;606.299723818989;608.4888693497461;31011.379772404565;39868.60131398685;40273;40292.19415611689;40379.394309085386;44518.55481445185;45059.77470112653;45086.0982780345;45138.54861451393;45216;7579;7685.577293248869;8859.867101993459;8953.865692014626;9019.774505637346;10549.314294570866;10688.572457101707;10759.62341318054;10777.299475534104;10787.67636970892;10519.316244444124;10608.20438467118;10615.57537698495;10621.362718236931;10625.256232063759;7847.882281765778;8032.036155661358;8033.076196237449;8041.3968952328805;10476;10643.414612196326;10881.564737410494;10893.782124357547;10896.40069796161;10907.563697452093;40710.79644601788;40784.592154078375;40835.59164408348;41230.79384603088;41282;3318.6515415881468;3328.916777080568;3571.62497937718;3931.626495482953;4123.422720819088;30514.54228186579;30801.537976930365;30852.845735771403;30972;31803.363932721215;3811.428285757131;3891.3579259422163;3898.8245528951265;3903.1413089120347;3921.509811273591;272510;272654;272786;272806;273071;52383.47616523862;53455;61994.070088948705;67835.3216467829;68607.65696171488;62149.68925155346;62173;62267;62373;62408;13427.462901484027;13681.589552313248;13682.179069255877;13813.792793108112;13852.722945541032;10293.3823970562;10316.638917637847;10350.896491035144;10375.94812025935;10435.426051567236;20574.58850822975;20773.376798696063;20936.895315523325;20951.161953521994;20975.37073887755;7895.565743884026;8038.839223215503;8087.595620218965;8100.918990810134;8184.468009579358;935.691221896786;1037.040737317993;1050.5062620568322;1121.2151493954264;1147.0651419093413;28789;29280.560791588145;31042;31626.841865790524;32290.28661703887;1001.519270750044;1062.6227689170232;1080.897314755097;1101.7025403141267;1115.2694984784978;14661.266936653125;14676.04605700626;14701.852981470049;14756.40974361035;14764.51476897903;310292;314446;315361;315648;316101;51830.740846296285;51851.22223166656;51976.22035669468;52052.739736301075;52158.217626735626;1205.4153735438306;1245.302630526908;1248.5754843353304;1329.5811819276703;1334.946602135923;25510.74489255158;27484.725152748215;27728.861355693094;27837.304067398476;27913.162605121877;42317.71028621422;42597.5740242606;42632.78683606562;42641;42881.57118428776;214909;384615;387375;390947;398211;30641.387172255985;30718.385632286783;30726;30789.23026924345;30903.291605006645;42549.78725106355;43123.9219019527;43264.35103473513;44033.77983110064;44048;35790.821045895646;36273;36499.27001460009;36705;36910.077248069014;32457.837710811295;32511;32777.18057048593;33350.66649333476;33378.66621333756;33963.320733585686;34014.829925850216;34424.13939651529;35347.64652353546;35461;28517.714822851507;30032.849835751556;31896;31942.840285798422;31964.68035319617;24033.158839440537;24127.39681507906;24331;24705.629415558422;24744.25767226986 08:12:11 INFO - PROCESS | 15574 | |2;jquery.html;355.1957297139085;355.5999500561868;358.69331721378205;359.50567969042567;359.86864794350055;13752.243626600533;13892.802206281347;16526.91736541317;16739.33042678293;17305.653886922253;11820.113491488151;12224.266544007365;14194;14551.563453096398;14877.553673389788;5307.442718514559;5429.864253393677;5430.972845135789;5431.918521222185;5438.3473983122085;4019.638232559069;4158.521769996459;5328.6269961102735;5435.211894275328;5466.699331536764;5822.446867547576;5967.701614919259;5978.850528736794;5979.880402391949;5992.221011268529;5846.795362162326;5942.762289508414;5966.194563733884;6027.397260273981;6033.879322413527;5297.099493086184;5306;5310.548603368718;5314.681119132864;5316.548093412064;20552.28067017662;20651.896740516353;20897.791022089736;20920.686189707165;21293.36119916405;2165.7076294700173;2185.890705464736;2256.368216899271;2403.891824867885;2452.730199678034;12664.240145591202;12731.745365092738;12820.358982050953;13131.277779722112;13256.734865302737;1572;1609.7263465210824;1658.8672906167478;1670.4821505333264;1733.246037973473;56652;59605.7019714903;59668.701656491874;60071.69964150239;60686;9590.376625519459;9788.755281118029;9990.600375984879;9992.25058120644;10006.79986400268;12928.676783080498;12936.094473386773;12961.15752476086;13014.15407998477;13037.804432933513;7161.641917904084;7192.388646965067;7197.568145911157;7259.382952448996;7266;7006.824829379307;7022.578645281299;7028.332308430691;7076.009358689787;7077.858442831114;5900.085486749561;5967.343592204854;5979.5515336349945;5993;6081.422264884829;1652.5044834424864;1721.4147189955224;1755.6488702259599;1766.240516577884;1770.6989811732037;924.6624981881565;928.4568527411404;977.9070988256104;985.4235272365746;1059.8500626819987;16379.83620163783;16564.917175414288;16949.661006779796;16951.576210594587;17153.485395438158;847.7626264645909;917.6742256498981;927.4388994658269;944.3200895355333;950.4249928793118;9651.517424128906;10523.737151541864;10534.104601108991;10549.683509494575;10552.419616921143;349239;526142;532546;532967;551092;40081.79959100186;41586.584134158875;68143.63244368468;77569.61215193888;80001.59999200083;1167.53882216524;1169.2750494693175;1189.4052973513244;1205.5780476833038;1221.9327936963552;14957.476488322856;15543.222838857786;15685.29416176252;15726.634008958197;15999.760003600188;34157.48763768496;34433;34448;34543.481847772804;35296.29407411786;46246.53753462422;46765.2985205229;47080.52919470761;48363.75818120887;50268;9436.95281523588;9462.858057129011;9608.807823843625;9800.509974501103;9852.802943941224;16445.506634800975;17127.22927468242;17207.483775486755;17611.735823962907;17690.292388304322;13960.930195348958;14005.719885602435;14247.572572822832;14370.568882933529;14376.35306411193;13597.11618744818;13736.244506552235;14442.638934026734;14775.778363324343;14948.701025979637;14053.22707251111;14268.357923893242;14564.708705826037;14934.626634334229;15048.516994695752;9175.403598766059;9397.574787334028;9630.32587718853;9664.855027174457;9673.806523869624;13829.861701382857;13956.441742330193;14110.223937683526;14140.43438262458;14321.57035288943 08:12:11 INFO - PROCESS | 15574 | |3;mootools.html;1497.8277498087723;1681.6048228666266;1698.7791587093675;1711.2727090986327;1747.2486830662817;6616.470682345413;7380.704771809128;7543;7544.773656790298;7562.054743157106;7387.519811212267;7526;7559.50863193892;7576.96211518943;7592.27873352032;1898.5253686578355;1923.384516954575;2128.0849234829016;2142.8714277143345;2162.7945345192184;2235.642297232443;2241.7421996470453;2250.2799104286637;2250.6173950428465;2252.5720113178527;2109.60972220139;2129.58473097746;2131.6482780341225;2134.1996751218294;2135.9252426165085;2150.569886022794;2156.644153714635;2183.094015983365;2183.858049226803;2185.9890700546393;2168.046059733728;2189.9233526826483;2211.8562293450873;2217.0466699319286;2218.5119273759747;7523.435742319348;7570.129435114977;7582.469227154102;7589.430792690515;7590.0891892973195;4337.783110844477;4437.378766972626;4440.089781594766;4440.245158323093;4443.800028998703;2868.4836729388703;2916.460454815866;2939.6325459317586;2958.541426078961;2997.895073672411;923.9769005774909;938.2540880000416;938.85917112433;955.0544960489066;961.3991255465335;10485.895141048568;10508.422036787973;10511.947440262826;10516.947415262875;10524.15806735467;3965.345717956505;4004.579519150447;4052.473178486837;4065.7763822989427;4076.470058892325;9043.502607356528;9050.456972581665;9057.728268151966;9060.456372617664;9065.909340906639;4392.05570802279;4395.1868904252815;4419.292913133948;4423.867283981485;4429.512753597101;3947.5657677655436;3997.060690737674;3999.8000099995465;4002.3796311571755;4003.339448990942;3093.3658599986948;3129.937401252008;3468.8265586720563;3498.2303893143976;3540.4689296605716;1146.128942004083;1159.9362035088152;1166.9824952625718;1174.4127936031985;1175.6002958993984;1019.9898001020043;1046.2519298701466;1049.6168898352046;1148.3454430974432;1288.9548865789652;6944.270851560514;6949.548279361927;7029.648517574203;7049.189343225492;7058.11773528309;1099.7085772270354;1102.3716481605568;1119.4234968990977;1136.86926003509;1144.9771004579861;5299.894002120013;5368.1679339702405;5372.57019438444;5376.542993845489;5389.299391079135;8788.903251466665;8799.604017819214;8998.10018998108;9047.457152570867;9194.49430281341;8966.641334346683;9109.362344635945;9112.8633070504;9128.3153763468;9136.360454768102;7201.3518783309755;7209.819754506075;7326.230745771723;7385.4460915431555;7398.852022959511;6986.371226589428;7023.543469674455;7036.155661320674;7046.647667616701;7053;7945.686457320814;8298.709545166132;8299.502029878227;8310.33517318601;8322.62548185321;8135.064467586303;8214.13751556078;8297.04583972851;8399.950006249219;8445.619947102272;6533.771318003847;6687.966560167362;6713.899291510534;6719.193696756421;6722.193336799615;6294.464970477377;6441.581297215666;6700.363465470772;6962.268961758942;7059.470539709439;6759.695813688494;6768.458523318024;6929.861402771816;7021.227664956748;7069.469789765685;6773.89839152423;6777.085093512313;6828.419584335387;6931.410830079298;6963.09479767627;6708.966455167693;6747.257801641717;6773.05177275172;6779.694913728993;6785.491088168308;6081.939180608314;6089.117078023751;6089.69551522431;6107.480864126422;6168.537359697951;6104.908426373519;6129.601575897553;6140.293866205444;6148.323684394623;6149.108379285068 08:12:11 INFO - PROCESS | 15574 | |4;prototype.html;339.0963083382785;342.1463448695505;343.3287922112271;344.6691176470587;350.56704969362835;5897.970510147443;5971;5980.312264089625;5993.700314984249;6014.278286605613;5789.421057894208;5911.290645122581;5929.318128415222;5933.910991335133;5934.88130237395;4601.3558101865765;4605.493395726484;4616.907661846761;4622.8150873965005;4625.699329543586;4386.166628340621;4471.642268618502;4504.864854054384;4620.584147426731;4625.398698169233;4547.477040140393;4575.885602859922;4577;4601.608863246612;4601.723896566216;4559.270516717326;4571.588557029867;4580.473245576734;4583.770811459413;4586.105709386671;4036.091879327157;4036.2734707752593;4039.7576145431076;4053.3312003519677;4061.918761624751;5529.612927095105;5647.068233741427;5649;5664.178694089334;5677.432256774289;5289.682619042831;5292.497212764782;5294.788208471657;5297.708626025567;5337.8131765388025;6293.716782744787;6294.213223347082;6295.842603934892;6297.716602752887;6301.936980630181;4207.726497777665;4277.101808620194;4324.070324880135;4430.889227769299;4467.865964021084;6521.217453905514;6552;6552.3447655234095;6562.44219241365;6579.374959378852;4555.977220113945;4563.406757121619;4564.475085365159;4576.244919588297;4577.084583083397;4551.590356867831;4628.490866004737;4630.583247507673;4630.58324750774;4635.513271106553;5325.893482130413;5326.893462130735;5327.387350454747;5329.467053294639;5330.253764472977;6328.778492752824;6334.873302534015;6345.1434056401795;6345.17512723343;6348.968255158695;1629.7310943694395;1647.9340826367052;1650.1749125437282;1650.2161473300087;1650.2656317938402;1116.4808364110727;1120.6413947536873;1130.6834086455806;1130.7851508213414;1146.7706458708292;5896.911546326808;5946.613470124515;5947.1376650385455;5955.315138759098;5957.731902064331;6497.610143391317;6501.414872661483;6504.544681872224;6506.674666266667;6517.51118666102;5826;5938.435848594377;5945.10823376497;5948.196993405835;5952.107183922446;3454.360943225461;3509.876839411415;3540.061883600848;3544.7164226861787;3551.1654761131113;6464.321246269168;6469.967650161813;6471.6764161791725;6517.120188774549;6536.052272420472;6605.768798092044;6608;6612.206535215805;6616.603003819786;6619.536632435684;6395.20059992501;6506.642134682638;6519.967400162969;6522.934770652328;6530.216374035146;6308.526860485574;6487.124238227779;6499.252585952487;6504.577202481823;6507.316731743099;6335.683215839282;6345.873082538231;6472.093906852951;6479.31967143462;6480.805575832733;6536;6557.9344206557325;6559.245686745894;6564.409203171546;6569.277379488157;4557.908841823211;4558.36182934396;4569.428821397325;4569.977150114228;4570.840020599263;6452.870942581216;6577.6053436793945;6586.4401525870835;6588.8352791180605;6594.274629790815;6403.167588213689;6406.423421892052;6414.583052101599;6422.807315780534;6426.228852537725;6257.09272155544;6379.4896408286295;6386.265579458422;6387;6389.87220255583;6278.645507934524;6287.591306565058;6291.748330066746;6292.489802447288;6296.748130074746;6369.649669268235;6434.935650643433;6439.356064393523;6439.839004024937;6442.9691249399875;6077.118817771487;6264.780732674517;6274.466670333073;6279;6292 08:12:11 INFO - PROCESS | 15574 | |5;yui.html;844.9564787487448;850.8936382952131;851.450814224825;857.8327226190887;861.9181177788109;11861.584844530433;12196.451159697812;12197.756044879097;12200.20698654588;12228.02175825934;11384.430778461085;11528.538858445672;11611.419429028558;11625.651230463078;11627.651170464878;814.7148498025688;829.8713699376606;830.0288662265134;830.0537387378394;831.3972370031739;699.8635266123108;700.3976580141075;829.6598394658191;832.592029905345;836.3392919593514;862.4394143806513;863.7365603490932;869.5565261716507;869.5565261716539;870.3820287595782;717.3113810741694;861.8233262181269;861.8664107063415;861.8879545659087;864.9221570058694;525.4194115502391;643.584887747405;643.8165122939939;644.2816259870211;645.3514218210669;12495.06326519382;12582.811257831048;12666.176698514659;12678.112532122756;12685.746285074247;11308.547658093748;11572.884271157349;11786.17496775226;11844.46699898498;12038.217515861528;9142.588583513758;9409;9512.33413661044;9526.90473095267;9692.75768105803;3489.4416893296952;3514.595821480537;3518.6833185013215;3543.433050711874;3560.946585801215;45495;45500.544994549964;45620.54379456229;46596.3010554842;46696.299555506695;9156.313276504288;9163.58763855628;9206.861897071549;9241.3531052827;9264.212541934012;18327.450176494727;18455.53861153482;18487.352942646943;18497.630047398976;18498.075096245135;6954.165500140016;7061.752838650726;7069.82325441868;7128.92871071293;7185.6047917364;4094.4677191965447;4241.300185469363;4326.610605045561;4337.50118736343;4337.7397356158735;3184.45864203086;3197.936041279208;3210.839458027089;3213.4697774867354;3215.405150047202;561.53673219594;570.7716913234656;579.0185635348045;580.4427749360576;589.7169358707758;634.1312402009277;634.2737565487491;646.6572716460283;651.7458191305394;656.6257233377024;7162.46281528877;7445.7766267012075;7700.691972321157;8272.503649780912;8353.624086916103;432.4745434297281;594.9702514874239;612.1643956000116;619.294004834489;644.320242144542;3354.6429516067406;3512.1921957949817;3524.4008518551395;3625.2386998730035;3654.5066416033496;50533;51248.74375628098;51807.48192518102;52092.47907520952;54371.45628543743;49261.261081083816;49407.75296123496;49602;49687.50312496901;49718;43073.56926430758;43504.347434788506;43864;44077.55922440799;44139.337909931375;7067.399271062018;7197.280271972971;7299;7334.816629584303;7460.4031677466755;32735.508967365986;33439;33622;33865.49201762025;34004.319913601095;38278.61721382751;42210.36684449797;42592.78703606462;42727.14545709006;42845.143097138505;9211.40125891815;9234.95382523083;9283.257339412696;9320.440773553608;9384.57769400365;10163.542640581043;10302.690919272434;10312.381257124596;10317;10392.636257730943;8960.417572857743;9045.864312035457;9274.072592740671;9454.574544145667;9460.858087128561;9560.40716181014;9753.12221900004;9824.263180261367;10131.493425328557;10137.949310253402;9047.547622618711;9305.441673499612;9323.20752736025;9324.860127098234;9461.101195386427;8051.4766540174705;8173;8191.719392162798;8360.331173505983;8478.576071196292;7623.809404764926;7750.496217745828;7872.724454644289;8475.491470511543;8635.222829945084 08:12:11 INFO - PROCESS | 15574 | __end_tp_report 08:12:11 INFO - PROCESS | 15574 | __start_cc_report 08:12:11 INFO - PROCESS | 15574 | _x_x_mozilla_cycle_collect,949 08:12:11 INFO - PROCESS | 15574 | __end_cc_report 08:12:11 INFO - PROCESS | 15574 | __startTimestamp1450973531266__endTimestamp 08:12:11 INFO - PROCESS | 15574 | 08:12:11 INFO - PROCESS | 15574 | ------- Summary: start ------- 08:12:11 INFO - PROCESS | 15574 | Number of tests: 6 08:12:11 INFO - PROCESS | 15574 | 08:12:11 INFO - PROCESS | 15574 | [#0] dojo.html Cycles:165 Average:5211.12 Median:5405.51 stddev:558.32 (10.3%) stddev-sans-first:533.59 08:12:11 INFO - PROCESS | 15574 | Values: 3046.8 3104.6 3149.3 3160.5 3178.4 5127.0 5166.5 5189.7 5190.4 5239.6 5117.5 5169.9 5221.9 5252.5 5261.2 4755.5 4766.3 4810.9 4992.7 5017.3 4922.4 4931.0 4972.0 4995.2 5009.8 4651.3 4741.6 4775.3 4877.2 4881.9 4807.0 4821.6 4845.0 4847.1 4888.6 4796.3 4817.9 4829.2 4831.2 4893.5 4898.6 4986.1 4993.6 5130.7 5147.2 5661.5 5667.3 5667.7 5669.7 5677.3 5663.4 5687.0 5692.2 5692.2 5694.5 5152.1 5186.5 5239.7 5253.3 5279.3 5779.2 5817.0 5824.2 5863.7 5872.1 5615.1 5615.2 5619.0 5622.4 5622.7 5459.9 5504.3 5597.3 5690.4 5710.4 5605.7 5679.2 5684.9 5685.7 5689.2 5658.3 5672.1 5672.9 5673.7 5682.2 4303.8 4312.8 4355.8 4371.9 4399.6 3876.6 3926.6 3940.1 3969.8 3971.5 5028.2 5175.6 5224.7 5229.3 5229.5 5521.7 5575.7 5611.6 5657.5 5658.7 5165.7 5170.5 5173.9 5175.3 5184.2 4870.3 4871.0 4871.1 4874.3 4914.4 5405.5 5417.8 5454.6 5506.3 5521.0 5559.0 5560.2 5565.1 5590.7 5663.0 5587.6 5589.3 5589.7 5592.9 5610.5 5345.3 5435.5 5445.3 5499.0 5541.2 5611.2 5650.8 5663.7 5669.1 5675.1 5244.5 5529.4 5539.7 5546.7 5547.4 5425.5 5440.7 5494.1 5494.1 5536.4 5447.3 5453.5 5457.4 5459.5 5462.3 5291.8 5513.0 5552.3 5594.5 5598.2 5300.9 5360.7 5376.7 5380.0 5416.2 08:12:11 INFO - PROCESS | 15574 | 08:12:11 INFO - PROCESS | 15574 | [#1] ext.html Cycles:180 Average:48192.78 Median:32127.48 stddev:83606.26 (260.2%) stddev-sans-first:83764.29 08:12:11 INFO - PROCESS | 15574 | Values: 554.5 588.4 600.6 606.3 608.5 31011.4 39868.6 40273.0 40292.2 40379.4 44518.6 45059.8 45086.1 45138.5 45216.0 7579.0 7685.6 8859.9 8953.9 9019.8 10549.3 10688.6 10759.6 10777.3 10787.7 10519.3 10608.2 10615.6 10621.4 10625.3 7847.9 8032.0 8033.1 8041.4 10476.0 10643.4 10881.6 10893.8 10896.4 10907.6 40710.8 40784.6 40835.6 41230.8 41282.0 3318.7 3328.9 3571.6 3931.6 4123.4 30514.5 30801.5 30852.8 30972.0 31803.4 3811.4 3891.4 3898.8 3903.1 3921.5 272510.0 272654.0 272786.0 272806.0 273071.0 52383.5 53455.0 61994.1 67835.3 68607.7 62149.7 62173.0 62267.0 62373.0 62408.0 13427.5 13681.6 13682.2 13813.8 13852.7 10293.4 10316.6 10350.9 10375.9 10435.4 20574.6 20773.4 20936.9 20951.2 20975.4 7895.6 8038.8 8087.6 8100.9 8184.5 935.7 1037.0 1050.5 1121.2 1147.1 28789.0 29280.6 31042.0 31626.8 32290.3 1001.5 1062.6 1080.9 1101.7 1115.3 14661.3 14676.0 14701.9 14756.4 14764.5 310292.0 314446.0 315361.0 315648.0 316101.0 51830.7 51851.2 51976.2 52052.7 52158.2 1205.4 1245.3 1248.6 1329.6 1334.9 25510.7 27484.7 27728.9 27837.3 27913.2 42317.7 42597.6 42632.8 42641.0 42881.6 214909.0 384615.0 387375.0 390947.0 398211.0 30641.4 30718.4 30726.0 30789.2 30903.3 42549.8 43123.9 43264.4 44033.8 44048.0 35790.8 36273.0 36499.3 36705.0 36910.1 32457.8 32511.0 32777.2 33350.7 33378.7 33963.3 34014.8 34424.1 35347.6 35461.0 28517.7 30032.8 31896.0 31942.8 31964.7 24033.2 24127.4 24331.0 24705.6 24744.3 08:12:11 INFO - PROCESS | 15574 | 08:12:11 INFO - PROCESS | 15574 | [#2] jquery.html Cycles:180 Average:27234.71 Median:192267.65 stddev:82208.00 (42.8%) stddev-sans-first:82413.84 08:12:11 INFO - PROCESS | 15574 | Values: 355.2 355.6 358.7 359.5 359.9 13752.2 13892.8 16526.9 16739.3 17305.7 11820.1 12224.3 14194.0 14551.6 14877.6 5307.4 5429.9 5431.0 5431.9 5438.3 4019.6 4158.5 5328.6 5435.2 5466.7 5822.4 5967.7 5978.9 5979.9 5992.2 5846.8 5942.8 5966.2 6027.4 6033.9 5297.1 5306.0 5310.5 5314.7 5316.5 20552.3 20651.9 20897.8 20920.7 21293.4 2165.7 2185.9 2256.4 2403.9 2452.7 12664.2 12731.7 12820.4 13131.3 13256.7 1572.0 1609.7 1658.9 1670.5 1733.2 56652.0 59605.7 59668.7 60071.7 60686.0 9590.4 9788.8 9990.6 9992.3 10006.8 12928.7 12936.1 12961.2 13014.2 13037.8 7161.6 7192.4 7197.6 7259.4 7266.0 7006.8 7022.6 7028.3 7076.0 7077.9 5900.1 5967.3 5979.6 5993.0 6081.4 1652.5 1721.4 1755.6 1766.2 1770.7 924.7 928.5 977.9 985.4 1059.9 16379.8 16564.9 16949.7 16951.6 17153.5 847.8 917.7 927.4 944.3 950.4 9651.5 10523.7 10534.1 10549.7 10552.4 349239.0 526142.0 532546.0 532967.0 551092.0 40081.8 41586.6 68143.6 77569.6 80001.6 1167.5 1169.3 1189.4 1205.6 1221.9 14957.5 15543.2 15685.3 15726.6 15999.8 34157.5 34433.0 34448.0 34543.5 35296.3 46246.5 46765.3 47080.5 48363.8 50268.0 9437.0 9462.9 9608.8 9800.5 9852.8 16445.5 17127.2 17207.5 17611.7 17690.3 13960.9 14005.7 14247.6 14370.6 14376.4 13597.1 13736.2 14442.6 14775.8 14948.7 14053.2 14268.4 14564.7 14934.6 15048.5 9175.4 9397.6 9630.3 9664.9 9673.8 13829.9 13956.4 14110.2 14140.4 14321.6 08:12:11 INFO - PROCESS | 15574 | 08:12:11 INFO - PROCESS | 15574 | [#3] mootools.html Cycles:180 Average:5260.00 Median:6134.95 stddev:2753.32 (44.9%) stddev-sans-first:2746.52 08:12:11 INFO - PROCESS | 15574 | Values: 1497.8 1681.6 1698.8 1711.3 1747.2 6616.5 7380.7 7543.0 7544.8 7562.1 7387.5 7526.0 7559.5 7577.0 7592.3 1898.5 1923.4 2128.1 2142.9 2162.8 2235.6 2241.7 2250.3 2250.6 2252.6 2109.6 2129.6 2131.6 2134.2 2135.9 2150.6 2156.6 2183.1 2183.9 2186.0 2168.0 2189.9 2211.9 2217.0 2218.5 7523.4 7570.1 7582.5 7589.4 7590.1 4337.8 4437.4 4440.1 4440.2 4443.8 2868.5 2916.5 2939.6 2958.5 2997.9 924.0 938.3 938.9 955.1 961.4 10485.9 10508.4 10511.9 10516.9 10524.2 3965.3 4004.6 4052.5 4065.8 4076.5 9043.5 9050.5 9057.7 9060.5 9065.9 4392.1 4395.2 4419.3 4423.9 4429.5 3947.6 3997.1 3999.8 4002.4 4003.3 3093.4 3129.9 3468.8 3498.2 3540.5 1146.1 1159.9 1167.0 1174.4 1175.6 1020.0 1046.3 1049.6 1148.3 1289.0 6944.3 6949.5 7029.6 7049.2 7058.1 1099.7 1102.4 1119.4 1136.9 1145.0 5299.9 5368.2 5372.6 5376.5 5389.3 8788.9 8799.6 8998.1 9047.5 9194.5 8966.6 9109.4 9112.9 9128.3 9136.4 7201.4 7209.8 7326.2 7385.4 7398.9 6986.4 7023.5 7036.2 7046.6 7053.0 7945.7 8298.7 8299.5 8310.3 8322.6 8135.1 8214.1 8297.0 8400.0 8445.6 6533.8 6688.0 6713.9 6719.2 6722.2 6294.5 6441.6 6700.4 6962.3 7059.5 6759.7 6768.5 6929.9 7021.2 7069.5 6773.9 6777.1 6828.4 6931.4 6963.1 6709.0 6747.3 6773.1 6779.7 6785.5 6081.9 6089.1 6089.7 6107.5 6168.5 6104.9 6129.6 6140.3 6148.3 6149.1 08:12:11 INFO - PROCESS | 15574 | 08:12:11 INFO - PROCESS | 15574 | [#4] prototype.html Cycles:180 Average:5280.24 Median:5946.88 stddev:1561.95 (26.3%) stddev-sans-first:1521.66 08:12:11 INFO - PROCESS | 15574 | Values: 339.1 342.1 343.3 344.7 350.6 5898.0 5971.0 5980.3 5993.7 6014.3 5789.4 5911.3 5929.3 5933.9 5934.9 4601.4 4605.5 4616.9 4622.8 4625.7 4386.2 4471.6 4504.9 4620.6 4625.4 4547.5 4575.9 4577.0 4601.6 4601.7 4559.3 4571.6 4580.5 4583.8 4586.1 4036.1 4036.3 4039.8 4053.3 4061.9 5529.6 5647.1 5649.0 5664.2 5677.4 5289.7 5292.5 5294.8 5297.7 5337.8 6293.7 6294.2 6295.8 6297.7 6301.9 4207.7 4277.1 4324.1 4430.9 4467.9 6521.2 6552.0 6552.3 6562.4 6579.4 4556.0 4563.4 4564.5 4576.2 4577.1 4551.6 4628.5 4630.6 4630.6 4635.5 5325.9 5326.9 5327.4 5329.5 5330.3 6328.8 6334.9 6345.1 6345.2 6349.0 1629.7 1647.9 1650.2 1650.2 1650.3 1116.5 1120.6 1130.7 1130.8 1146.8 5896.9 5946.6 5947.1 5955.3 5957.7 6497.6 6501.4 6504.5 6506.7 6517.5 5826.0 5938.4 5945.1 5948.2 5952.1 3454.4 3509.9 3540.1 3544.7 3551.2 6464.3 6470.0 6471.7 6517.1 6536.1 6605.8 6608.0 6612.2 6616.6 6619.5 6395.2 6506.6 6520.0 6522.9 6530.2 6308.5 6487.1 6499.3 6504.6 6507.3 6335.7 6345.9 6472.1 6479.3 6480.8 6536.0 6557.9 6559.2 6564.4 6569.3 4557.9 4558.4 4569.4 4570.0 4570.8 6452.9 6577.6 6586.4 6588.8 6594.3 6403.2 6406.4 6414.6 6422.8 6426.2 6257.1 6379.5 6386.3 6387.0 6389.9 6278.6 6287.6 6291.7 6292.5 6296.7 6369.6 6434.9 6439.4 6439.8 6443.0 6077.1 6264.8 6274.5 6279.0 6292.0 08:12:11 INFO - PROCESS | 15574 | 08:12:11 INFO - PROCESS | 15574 | [#5] yui.html Cycles:180 Average:12756.60 Median:615.73 stddev:15049.45 (2444.2%) stddev-sans-first:15065.08 08:12:11 INFO - PROCESS | 15574 | Values: 845.0 850.9 851.5 857.8 861.9 11861.6 12196.5 12197.8 12200.2 12228.0 11384.4 11528.5 11611.4 11625.7 11627.7 814.7 829.9 830.0 830.1 831.4 699.9 700.4 829.7 832.6 836.3 862.4 863.7 869.6 869.6 870.4 717.3 861.8 861.9 861.9 864.9 525.4 643.6 643.8 644.3 645.4 12495.1 12582.8 12666.2 12678.1 12685.7 11308.5 11572.9 11786.2 11844.5 12038.2 9142.6 9409.0 9512.3 9526.9 9692.8 3489.4 3514.6 3518.7 3543.4 3560.9 45495.0 45500.5 45620.5 46596.3 46696.3 9156.3 9163.6 9206.9 9241.4 9264.2 18327.5 18455.5 18487.4 18497.6 18498.1 6954.2 7061.8 7069.8 7128.9 7185.6 4094.5 4241.3 4326.6 4337.5 4337.7 3184.5 3197.9 3210.8 3213.5 3215.4 561.5 570.8 579.0 580.4 589.7 634.1 634.3 646.7 651.7 656.6 7162.5 7445.8 7700.7 8272.5 8353.6 432.5 595.0 612.2 619.3 644.3 3354.6 3512.2 3524.4 3625.2 3654.5 50533.0 51248.7 51807.5 52092.5 54371.5 49261.3 49407.8 49602.0 49687.5 49718.0 43073.6 43504.3 43864.0 44077.6 44139.3 7067.4 7197.3 7299.0 7334.8 7460.4 32735.5 33439.0 33622.0 33865.5 34004.3 38278.6 42210.4 42592.8 42727.1 42845.1 9211.4 9235.0 9283.3 9320.4 9384.6 10163.5 10302.7 10312.4 10317.0 10392.6 8960.4 9045.9 9274.1 9454.6 9460.9 9560.4 9753.1 9824.3 10131.5 10137.9 9047.5 9305.4 9323.2 9324.9 9461.1 8051.5 8173.0 8191.7 8360.3 8478.6 7623.8 7750.5 7872.7 8475.5 8635.2 08:12:11 INFO - PROCESS | 15574 | -------- Summary: end -------- 08:12:11 INFO - PROCESS | 15574 | 08:12:11 INFO - TEST-INFO | 15574: exit 0 08:12:11 INFO - TEST-OK | dromaeo_css | took 1112579ms 08:12:11 INFO - TEST-START | kraken 08:12:11 INFO - operating with platform_type : linux_ 08:12:11 INFO - Initialising browser for kraken test... 08:12:11 INFO - TEST-INFO | started process 15764 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKrJm09/profile http://localhost:44194/getInfo.html) 08:12:16 INFO - PROCESS | 15764 | __metrics Screen width/height:1600/1200 08:12:16 INFO - PROCESS | 15764 | colorDepth:24 08:12:16 INFO - PROCESS | 15764 | Browser inner width/height: 1024/697 08:12:16 INFO - PROCESS | 15764 | __metrics 08:12:16 INFO - PROCESS | 15764 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:12:16 INFO - PROCESS | 15764 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:12:17 INFO - TEST-INFO | 15764: exit 0 08:12:17 INFO - Browser initialized. 08:12:17 INFO - Running cycle 1/1 for kraken test... 08:12:17 INFO - TEST-INFO | started process 15851 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKrJm09/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:12:28 INFO - PROCESS | 15851 | RSS: Main: 149086208 08:12:28 INFO - PROCESS | 15851 | 08:12:31 INFO - PROCESS | 15851 | Cycle 1(1): loaded http://localhost:44194/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44194/tests/kraken/driver.html?testName=audio-beat-detection) 08:12:31 INFO - PROCESS | 15851 | RSS: Main: 185380864 08:12:31 INFO - PROCESS | 15851 | 08:12:34 INFO - PROCESS | 15851 | Cycle 1(1): loaded http://localhost:44194/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44194/tests/kraken/driver.html?testName=audio-dft) 08:12:35 INFO - PROCESS | 15851 | RSS: Main: 174993408 08:12:35 INFO - PROCESS | 15851 | 08:12:37 INFO - PROCESS | 15851 | Cycle 1(1): loaded http://localhost:44194/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44194/tests/kraken/driver.html?testName=audio-fft) 08:12:38 INFO - PROCESS | 15851 | RSS: Main: 160194560 08:12:38 INFO - PROCESS | 15851 | 08:12:40 INFO - PROCESS | 15851 | Cycle 1(1): loaded http://localhost:44194/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44194/tests/kraken/driver.html?testName=audio-oscillator) 08:12:41 INFO - PROCESS | 15851 | RSS: Main: 161972224 08:12:41 INFO - PROCESS | 15851 | 08:12:43 INFO - PROCESS | 15851 | Cycle 1(1): loaded http://localhost:44194/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44194/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:12:43 INFO - PROCESS | 15851 | RSS: Main: 165494784 08:12:43 INFO - PROCESS | 15851 | 08:12:46 INFO - PROCESS | 15851 | Cycle 1(1): loaded http://localhost:44194/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44194/tests/kraken/driver.html?testName=imaging-darkroom) 08:12:47 INFO - PROCESS | 15851 | RSS: Main: 164286464 08:12:47 INFO - PROCESS | 15851 | 08:12:50 INFO - PROCESS | 15851 | Cycle 1(1): loaded http://localhost:44194/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44194/tests/kraken/driver.html?testName=imaging-desaturate) 08:12:51 INFO - PROCESS | 15851 | RSS: Main: 166076416 08:12:51 INFO - PROCESS | 15851 | 08:12:53 INFO - PROCESS | 15851 | Cycle 1(1): loaded http://localhost:44194/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44194/tests/kraken/driver.html?testName=json-parse-financial) 08:12:54 INFO - PROCESS | 15851 | RSS: Main: 164454400 08:12:54 INFO - PROCESS | 15851 | 08:12:56 INFO - PROCESS | 15851 | Cycle 1(1): loaded http://localhost:44194/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44194/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:12:56 INFO - PROCESS | 15851 | RSS: Main: 176467968 08:12:56 INFO - PROCESS | 15851 | 08:12:58 INFO - PROCESS | 15851 | Cycle 1(1): loaded http://localhost:44194/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44194/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:12:59 INFO - PROCESS | 15851 | RSS: Main: 173551616 08:12:59 INFO - PROCESS | 15851 | 08:13:01 INFO - PROCESS | 15851 | Cycle 1(1): loaded http://localhost:44194/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44194/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:13:01 INFO - PROCESS | 15851 | RSS: Main: 186916864 08:13:01 INFO - PROCESS | 15851 | 08:13:04 INFO - PROCESS | 15851 | Cycle 1(1): loaded http://localhost:44194/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44194/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:13:04 INFO - PROCESS | 15851 | RSS: Main: 194670592 08:13:04 INFO - PROCESS | 15851 | 08:13:07 INFO - PROCESS | 15851 | Cycle 1(1): loaded http://localhost:44194/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44194/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:13:07 INFO - PROCESS | 15851 | RSS: Main: 193839104 08:13:07 INFO - PROCESS | 15851 | 08:13:09 INFO - PROCESS | 15851 | Cycle 1(1): loaded http://localhost:44194/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44194/tests/kraken/driver.html?testName=ai-astar) 08:13:09 INFO - PROCESS | 15851 | RSS: Main: 251596800 08:13:09 INFO - PROCESS | 15851 | 08:13:09 INFO - PROCESS | 15851 | __start_tp_report 08:13:09 INFO - PROCESS | 15851 | _x_x_mozilla_page_load 08:13:09 INFO - PROCESS | 15851 | _x_x_mozilla_page_load_details 08:13:09 INFO - PROCESS | 15851 | |i|pagename|runs| 08:13:09 INFO - PROCESS | 15851 | |0;ai-astar;109;110;105;111;112;110;99;109;109;110 08:13:09 INFO - PROCESS | 15851 | |1;audio-beat-detection;151;125;153;163;124;152;152;126;174;123 08:13:09 INFO - PROCESS | 15851 | |2;audio-dft;160;161;160;160;171;161;159;159;160;161 08:13:09 INFO - PROCESS | 15851 | |3;audio-fft;72;70;87;97;73;74;73;106;87;71 08:13:09 INFO - PROCESS | 15851 | |4;audio-oscillator;94;94;137;93;92;93;140;92;92;132 08:13:09 INFO - PROCESS | 15851 | |5;imaging-gaussian-blur;109;109;109;109;109;110;109;109;110;109 08:13:09 INFO - PROCESS | 15851 | |6;imaging-darkroom;147;145;144;146;145;146;144;145;146;145 08:13:09 INFO - PROCESS | 15851 | |7;imaging-desaturate;96;96;95;95;95;96;95;95;95;95 08:13:09 INFO - PROCESS | 15851 | |8;json-parse-financial;60;58;58;57;58;57;57;65;55;57 08:13:09 INFO - PROCESS | 15851 | |9;json-stringify-tinderbox;68;68;68;68;69;76;68;68;68;68 08:13:09 INFO - PROCESS | 15851 | |10;stanford-crypto-aes;89;83;84;84;91;83;82;83;84;84 08:13:09 INFO - PROCESS | 15851 | |11;stanford-crypto-ccm;122;112;122;115;117;119;117;125;138;115 08:13:09 INFO - PROCESS | 15851 | |12;stanford-crypto-pbkdf2;141;152;151;159;150;152;152;154;151;142 08:13:09 INFO - PROCESS | 15851 | |13;stanford-crypto-sha256-iterative;67;67;66;68;68;65;66;68;66;65 08:13:09 INFO - PROCESS | 15851 | __end_tp_report 08:13:09 INFO - PROCESS | 15851 | __start_cc_report 08:13:09 INFO - PROCESS | 15851 | _x_x_mozilla_cycle_collect,927 08:13:09 INFO - PROCESS | 15851 | __end_cc_report 08:13:09 INFO - PROCESS | 15851 | __startTimestamp1450973589669__endTimestamp 08:13:09 INFO - PROCESS | 15851 | 08:13:09 INFO - PROCESS | 15851 | ------- Summary: start ------- 08:13:09 INFO - PROCESS | 15851 | Number of tests: 14 08:13:09 INFO - PROCESS | 15851 | 08:13:09 INFO - PROCESS | 15851 | [#0] ai-astar Cycles:10 Average:108.40 Median:110.00 stddev:3.78 (3.4%) stddev-sans-first:4.00 08:13:09 INFO - PROCESS | 15851 | Values: 109.0 110.0 105.0 111.0 112.0 110.0 99.0 109.0 109.0 110.0 08:13:09 INFO - PROCESS | 15851 | 08:13:09 INFO - PROCESS | 15851 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:152.00 stddev:18.39 (12.1%) stddev-sans-first:19.35 08:13:09 INFO - PROCESS | 15851 | Values: 151.0 125.0 153.0 163.0 124.0 152.0 152.0 126.0 174.0 123.0 08:13:09 INFO - PROCESS | 15851 | 08:13:09 INFO - PROCESS | 15851 | [#2] audio-dft Cycles:10 Average:161.20 Median:160.50 stddev:3.52 (2.2%) stddev-sans-first:3.71 08:13:09 INFO - PROCESS | 15851 | Values: 160.0 161.0 160.0 160.0 171.0 161.0 159.0 159.0 160.0 161.0 08:13:09 INFO - PROCESS | 15851 | 08:13:09 INFO - PROCESS | 15851 | [#3] audio-fft Cycles:10 Average:81.00 Median:73.50 stddev:12.61 (17.2%) stddev-sans-first:12.95 08:13:09 INFO - PROCESS | 15851 | Values: 72.0 70.0 87.0 97.0 73.0 74.0 73.0 106.0 87.0 71.0 08:13:09 INFO - PROCESS | 15851 | 08:13:09 INFO - PROCESS | 15851 | [#4] audio-oscillator Cycles:10 Average:105.90 Median:92.50 stddev:21.10 (22.8%) stddev-sans-first:21.94 08:13:09 INFO - PROCESS | 15851 | Values: 94.0 94.0 137.0 93.0 92.0 93.0 140.0 92.0 92.0 132.0 08:13:09 INFO - PROCESS | 15851 | 08:13:09 INFO - PROCESS | 15851 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:13:09 INFO - PROCESS | 15851 | Values: 109.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 110.0 109.0 08:13:09 INFO - PROCESS | 15851 | 08:13:09 INFO - PROCESS | 15851 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.50 stddev:0.95 (0.7%) stddev-sans-first:0.78 08:13:09 INFO - PROCESS | 15851 | Values: 147.0 145.0 144.0 146.0 145.0 146.0 144.0 145.0 146.0 145.0 08:13:09 INFO - PROCESS | 15851 | 08:13:09 INFO - PROCESS | 15851 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 08:13:09 INFO - PROCESS | 15851 | Values: 96.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 08:13:09 INFO - PROCESS | 15851 | 08:13:09 INFO - PROCESS | 15851 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.00 stddev:2.70 (4.7%) stddev-sans-first:2.78 08:13:09 INFO - PROCESS | 15851 | Values: 60.0 58.0 58.0 57.0 58.0 57.0 57.0 65.0 55.0 57.0 08:13:09 INFO - PROCESS | 15851 | 08:13:09 INFO - PROCESS | 15851 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:68.00 stddev:2.51 (3.7%) stddev-sans-first:2.65 08:13:09 INFO - PROCESS | 15851 | Values: 68.0 68.0 68.0 68.0 69.0 76.0 68.0 68.0 68.0 68.0 08:13:09 INFO - PROCESS | 15851 | 08:13:09 INFO - PROCESS | 15851 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.00 stddev:2.91 (3.5%) stddev-sans-first:2.64 08:13:09 INFO - PROCESS | 15851 | Values: 89.0 83.0 84.0 84.0 91.0 83.0 82.0 83.0 84.0 84.0 08:13:09 INFO - PROCESS | 15851 | 08:13:09 INFO - PROCESS | 15851 | [#11] stanford-crypto-ccm Cycles:10 Average:120.20 Median:120.50 stddev:7.38 (6.1%) stddev-sans-first:7.79 08:13:09 INFO - PROCESS | 15851 | Values: 122.0 112.0 122.0 115.0 117.0 119.0 117.0 125.0 138.0 115.0 08:13:09 INFO - PROCESS | 15851 | 08:13:09 INFO - PROCESS | 15851 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.40 Median:152.00 stddev:5.32 (3.5%) stddev-sans-first:4.42 08:13:09 INFO - PROCESS | 15851 | Values: 141.0 152.0 151.0 159.0 150.0 152.0 152.0 154.0 151.0 142.0 08:13:09 INFO - PROCESS | 15851 | 08:13:09 INFO - PROCESS | 15851 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.17 (1.8%) stddev-sans-first:1.24 08:13:09 INFO - PROCESS | 15851 | Values: 67.0 67.0 66.0 68.0 68.0 65.0 66.0 68.0 66.0 65.0 08:13:09 INFO - PROCESS | 15851 | -------- Summary: end -------- 08:13:09 INFO - PROCESS | 15851 | 08:13:10 INFO - TEST-INFO | 15851: exit 0 08:13:10 INFO - TEST-OK | kraken | took 58567ms 08:13:10 INFO - TEST-START | v8_7 08:13:10 INFO - operating with platform_type : linux_ 08:13:10 INFO - Initialising browser for v8_7 test... 08:13:10 INFO - TEST-INFO | started process 16100 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKLAjzD/profile http://localhost:44194/getInfo.html) 08:13:14 INFO - PROCESS | 16100 | __metrics Screen width/height:1600/1200 08:13:14 INFO - PROCESS | 16100 | colorDepth:24 08:13:14 INFO - PROCESS | 16100 | Browser inner width/height: 1024/697 08:13:14 INFO - PROCESS | 16100 | __metrics 08:13:14 INFO - PROCESS | 16100 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:13:14 INFO - PROCESS | 16100 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:13:15 INFO - TEST-INFO | 16100: exit 0 08:13:15 INFO - Browser initialized. 08:13:15 INFO - Running cycle 1/1 for v8_7 test... 08:13:15 INFO - TEST-INFO | started process 16181 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKLAjzD/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:13:27 INFO - PROCESS | 16181 | RSS: Main: 148590592 08:13:27 INFO - PROCESS | 16181 | 08:13:48 INFO - PROCESS | 16181 | Cycle 1(1): loaded http://localhost:44194/tests/v8_7/run.html (next: http://localhost:44194/tests/v8_7/run.html) 08:13:48 INFO - PROCESS | 16181 | RSS: Main: 621981696 08:13:48 INFO - PROCESS | 16181 | 08:13:48 INFO - PROCESS | 16181 | __start_tp_report 08:13:48 INFO - PROCESS | 16181 | _x_x_mozilla_page_load 08:13:48 INFO - PROCESS | 16181 | _x_x_mozilla_page_load_details 08:13:48 INFO - PROCESS | 16181 | |i|pagename|runs| 08:13:48 INFO - PROCESS | 16181 | |0;Richards;166.27868307283006 08:13:48 INFO - PROCESS | 16181 | |1;DeltaBlue;194.81784531463083 08:13:48 INFO - PROCESS | 16181 | |2;Encrypt;282.80542986425337 08:13:48 INFO - PROCESS | 16181 | |3;Decrypt;5186.5284974093265 08:13:48 INFO - PROCESS | 16181 | |4;RayTrace;1077.5862068965516 08:13:48 INFO - PROCESS | 16181 | |5;Earley;786.1635220125786 08:13:48 INFO - PROCESS | 16181 | |6;Boyer;12358.024691358025 08:13:48 INFO - PROCESS | 16181 | |7;RegExp;25666.666666666668 08:13:48 INFO - PROCESS | 16181 | |8;Splay;697.5138121546961 08:13:48 INFO - PROCESS | 16181 | |9;NavierStokes;4826.923076923077 08:13:48 INFO - PROCESS | 16181 | __end_tp_report 08:13:48 INFO - PROCESS | 16181 | __startTimestamp1450973628950__endTimestamp 08:13:48 INFO - PROCESS | 16181 | 08:13:48 INFO - PROCESS | 16181 | ------- Summary: start ------- 08:13:48 INFO - PROCESS | 16181 | Number of tests: 10 08:13:48 INFO - PROCESS | 16181 | 08:13:48 INFO - PROCESS | 16181 | [#0] Richards Cycles:1 Average:166.28 Median:166.28 stddev:0.00 (0.0%) 08:13:48 INFO - PROCESS | 16181 | Values: 166.3 08:13:48 INFO - PROCESS | 16181 | 08:13:48 INFO - PROCESS | 16181 | [#1] DeltaBlue Cycles:1 Average:194.82 Median:194.82 stddev:0.00 (0.0%) 08:13:48 INFO - PROCESS | 16181 | Values: 194.8 08:13:48 INFO - PROCESS | 16181 | 08:13:48 INFO - PROCESS | 16181 | [#2] Encrypt Cycles:1 Average:282.81 Median:282.81 stddev:0.00 (0.0%) 08:13:48 INFO - PROCESS | 16181 | Values: 282.8 08:13:48 INFO - PROCESS | 16181 | 08:13:48 INFO - PROCESS | 16181 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 08:13:48 INFO - PROCESS | 16181 | Values: 5186.5 08:13:48 INFO - PROCESS | 16181 | 08:13:48 INFO - PROCESS | 16181 | [#4] RayTrace Cycles:1 Average:1077.59 Median:1077.59 stddev:0.00 (0.0%) 08:13:48 INFO - PROCESS | 16181 | Values: 1077.6 08:13:48 INFO - PROCESS | 16181 | 08:13:48 INFO - PROCESS | 16181 | [#5] Earley Cycles:1 Average:786.16 Median:786.16 stddev:0.00 (0.0%) 08:13:48 INFO - PROCESS | 16181 | Values: 786.2 08:13:48 INFO - PROCESS | 16181 | 08:13:48 INFO - PROCESS | 16181 | [#6] Boyer Cycles:1 Average:12358.02 Median:12358.02 stddev:0.00 (0.0%) 08:13:48 INFO - PROCESS | 16181 | Values: 12358.0 08:13:48 INFO - PROCESS | 16181 | 08:13:48 INFO - PROCESS | 16181 | [#7] RegExp Cycles:1 Average:25666.67 Median:25666.67 stddev:0.00 (0.0%) 08:13:48 INFO - PROCESS | 16181 | Values: 25666.7 08:13:48 INFO - PROCESS | 16181 | 08:13:48 INFO - PROCESS | 16181 | [#8] Splay Cycles:1 Average:697.51 Median:697.51 stddev:0.00 (0.0%) 08:13:48 INFO - PROCESS | 16181 | Values: 697.5 08:13:48 INFO - PROCESS | 16181 | 08:13:48 INFO - PROCESS | 16181 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 08:13:48 INFO - PROCESS | 16181 | Values: 4826.9 08:13:48 INFO - PROCESS | 16181 | -------- Summary: end -------- 08:13:48 INFO - PROCESS | 16181 | 08:13:49 INFO - TEST-INFO | 16181: exit 0 08:13:49 INFO - TEST-OK | v8_7 | took 39283ms 08:13:49 INFO - SUITE-END | took 1210s 08:13:49 INFO - Completed test suite (00:20:10) 08:13:49 INFO - Working with test: dromaeo_css 08:13:49 INFO - Generating results file: dromaeo_css 08:13:49 INFO - Working with test: kraken 08:13:49 INFO - Generating results file: kraken 08:13:49 INFO - javascript benchmark 08:13:49 INFO - Working with test: v8_7 08:13:49 INFO - Generating results file: v8_7 08:13:49 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:13:50 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 08:13:50 INFO - process_Request line: dromaeo_css 6868.27 graph.html#tests=[[72,64,35]] 08:13:50 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:13:50 INFO - process_Request line: kraken 1499.60 graph.html#tests=[[232,64,35]] 08:13:50 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:13:50 INFO - process_Request line: v8_7 20708.61 graph.html#tests=[[230,64,35]] 08:13:50 INFO - RETURN: dromaeo_css: 6868.27 08:13:50 INFO - RETURN: kraken: 1499.60 08:13:50 INFO - RETURN: v8_7: 20708.61 08:13:50 INFO - javascript benchmark 08:13:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3046.7714921380903, 3104.5808815809864, 3149.2756665966826, 3160.510120931255, 3178.3961047400985, 5127.025865085631, 5166.483351664836, 5189.662671926322, 5190.429052804188, 5239.633225674204, 5117.462666420028, 5169.948300516994, 5221.86945326367, 5252.474752524746, 5261.210818377245, 4755.45312289086, 4766.332713420124, 4810.927836082462, 4992.725400102993, 5017.272495488152, 4922.433920099199, 4931.0, 4972.0, 4995.150824359867, 5009.849704508871, 4651.2790517469675, 4741.644376671763, 4775.259834725605, 4877.244027175793, 4881.902361952741, 4806.951930480685, 4821.590164835993, 4845.030993801254, 4847.103285892122, 4888.608911287124, 4796.304535842283, 4817.903641927177, 4829.154897892855, 4831.178699621073, 4893.535114164149, 4898.5591296783105, 4986.127427700174, 4993.6005119590345, 5130.71781052042, 5147.202183661539, 5661.5187709044785, 5667.319921609434, 5667.659940403589, 5669.716514174316, 5677.318721753375, 5663.377028526858, 5687.0, 5692.174634677948, 5692.17463467799, 5694.487496125327, 5152.098382782998, 5186.507281808223, 5239.73801309933, 5253.264542963988, 5279.260903473517, 5779.190913272145, 5817.0, 5824.213731146326, 5863.70681465925, 5872.119182122716, 5615.101583746581, 5615.185798059259, 5619.0, 5622.381538030813, 5622.718864056781, 5459.918101228484, 5504.284443022381, 5597.3003374578175, 5690.374058853523, 5710.371859095496, 5605.7197140142825, 5679.176519404663, 5684.857878553069, 5685.658860468302, 5689.203511508392, 5658.292713410824, 5672.14917762339, 5672.858178545487, 5673.716314184357, 5682.232898558642, 4303.763293018851, 4312.762798046075, 4355.760433176142, 4371.912561748747, 4399.64802815774, 3876.612338766101, 3926.632661676854, 3940.0543869471694, 3969.80150992455, 3971.5035620547433, 5028.220625803006, 5175.5970598627655, 5224.686518808883, 5229.346331708536, 5229.50319719626, 5521.668699878021, 5575.721213939287, 5611.6352437091455, 5657.490825825613, 5658.7170641467765, 5165.690058596496, 5170.457102004236, 5173.922391164136, 5175.301334319894, 5184.196449550326, 4870.342503762017, 4871.025794841046, 4871.074495845778, 4874.268859671078, 4914.410270767531, 5405.513503784599, 5417.756200970887, 5454.59090568209, 5506.311711036121, 5520.972395137998, 5558.972205138948, 5560.221568980427, 5565.1374037024325, 5590.720463976866, 5663.0, 5587.608867379245, 5589.301337332833, 5589.720513974204, 5592.916106258491, 5610.4670056344585, 5345.305110335631, 5435.510804027498, 5445.292112025411, 5499.0, 5541.16882467617, 5611.2424822650055, 5650.773969041193, 5663.745131469176, 5669.092945128759, 5675.0636145035605, 5244.501772331622, 5529.419410961791, 5539.667619942817, 5546.694931778629, 5547.41752116022, 5425.457454254543, 5440.727963601725, 5494.09347457665, 5494.120940649477, 5536.363318218296, 5447.346318441654, 5453.454654534515, 5457.399686034612, 5459.481349271813, 5462.289902312674, 5291.814786482455, 5513.035218836607, 5552.333719953632, 5594.524465420485, 5598.188262701804, 5300.893982120413, 5360.70516121617, 5376.677399356051, 5379.973100134474, 5416.187571864252], "unit": "score", "name": "dojo.html", "value": 5176.023528831833}, {"lowerIsBetter": false, "replicates": [554.4962839020974, 588.4439204951317, 600.6006006006006, 606.299723818989, 608.4888693497461, 31011.379772404565, 39868.60131398685, 40273.0, 40292.19415611689, 40379.394309085386, 44518.55481445185, 45059.77470112653, 45086.0982780345, 45138.54861451393, 45216.0, 7579.0, 7685.577293248869, 8859.867101993459, 8953.865692014626, 9019.774505637346, 10549.314294570866, 10688.572457101707, 10759.62341318054, 10777.299475534104, 10787.67636970892, 10519.316244444124, 10608.20438467118, 10615.57537698495, 10621.362718236931, 10625.256232063759, 7847.882281765778, 8032.036155661358, 8033.076196237449, 8041.3968952328805, 10476.0, 10643.414612196326, 10881.564737410494, 10893.782124357547, 10896.40069796161, 10907.563697452093, 40710.79644601788, 40784.592154078375, 40835.59164408348, 41230.79384603088, 41282.0, 3318.6515415881468, 3328.916777080568, 3571.62497937718, 3931.626495482953, 4123.422720819088, 30514.54228186579, 30801.537976930365, 30852.845735771403, 30972.0, 31803.363932721215, 3811.428285757131, 3891.3579259422163, 3898.8245528951265, 3903.1413089120347, 3921.509811273591, 272510.0, 272654.0, 272786.0, 272806.0, 273071.0, 52383.47616523862, 53455.0, 61994.070088948705, 67835.3216467829, 68607.65696171488, 62149.68925155346, 62173.0, 62267.0, 62373.0, 62408.0, 13427.462901484027, 13681.589552313248, 13682.179069255877, 13813.792793108112, 13852.722945541032, 10293.3823970562, 10316.638917637847, 10350.896491035144, 10375.94812025935, 10435.426051567236, 20574.58850822975, 20773.376798696063, 20936.895315523325, 20951.161953521994, 20975.37073887755, 7895.565743884026, 8038.839223215503, 8087.595620218965, 8100.918990810134, 8184.468009579358, 935.691221896786, 1037.040737317993, 1050.5062620568322, 1121.2151493954264, 1147.0651419093413, 28789.0, 29280.560791588145, 31042.0, 31626.841865790524, 32290.28661703887, 1001.519270750044, 1062.6227689170232, 1080.897314755097, 1101.7025403141267, 1115.2694984784978, 14661.266936653125, 14676.04605700626, 14701.852981470049, 14756.40974361035, 14764.51476897903, 310292.0, 314446.0, 315361.0, 315648.0, 316101.0, 51830.740846296285, 51851.22223166656, 51976.22035669468, 52052.739736301075, 52158.217626735626, 1205.4153735438306, 1245.302630526908, 1248.5754843353304, 1329.5811819276703, 1334.946602135923, 25510.74489255158, 27484.725152748215, 27728.861355693094, 27837.304067398476, 27913.162605121877, 42317.71028621422, 42597.5740242606, 42632.78683606562, 42641.0, 42881.57118428776, 214909.0, 384615.0, 387375.0, 390947.0, 398211.0, 30641.387172255985, 30718.385632286783, 30726.0, 30789.23026924345, 30903.291605006645, 42549.78725106355, 43123.9219019527, 43264.35103473513, 44033.77983110064, 44048.0, 35790.821045895646, 36273.0, 36499.27001460009, 36705.0, 36910.077248069014, 32457.837710811295, 32511.0, 32777.18057048593, 33350.66649333476, 33378.66621333756, 33963.320733585686, 34014.829925850216, 34424.13939651529, 35347.64652353546, 35461.0, 28517.714822851507, 30032.849835751556, 31896.0, 31942.840285798422, 31964.68035319617, 24033.158839440537, 24127.39681507906, 24331.0, 24705.629415558422, 24744.25767226986], "unit": "score", "name": "ext.html", "value": 18795.267030722247}, {"lowerIsBetter": false, "replicates": [355.1957297139085, 355.5999500561868, 358.69331721378205, 359.50567969042567, 359.86864794350055, 13752.243626600533, 13892.802206281347, 16526.91736541317, 16739.33042678293, 17305.653886922253, 11820.113491488151, 12224.266544007365, 14194.0, 14551.563453096398, 14877.553673389788, 5307.442718514559, 5429.864253393677, 5430.972845135789, 5431.918521222185, 5438.3473983122085, 4019.638232559069, 4158.521769996459, 5328.6269961102735, 5435.211894275328, 5466.699331536764, 5822.446867547576, 5967.701614919259, 5978.850528736794, 5979.880402391949, 5992.221011268529, 5846.795362162326, 5942.762289508414, 5966.194563733884, 6027.397260273981, 6033.879322413527, 5297.099493086184, 5306.0, 5310.548603368718, 5314.681119132864, 5316.548093412064, 20552.28067017662, 20651.896740516353, 20897.791022089736, 20920.686189707165, 21293.36119916405, 2165.7076294700173, 2185.890705464736, 2256.368216899271, 2403.891824867885, 2452.730199678034, 12664.240145591202, 12731.745365092738, 12820.358982050953, 13131.277779722112, 13256.734865302737, 1572.0, 1609.7263465210824, 1658.8672906167478, 1670.4821505333264, 1733.246037973473, 56652.0, 59605.7019714903, 59668.701656491874, 60071.69964150239, 60686.0, 9590.376625519459, 9788.755281118029, 9990.600375984879, 9992.25058120644, 10006.79986400268, 12928.676783080498, 12936.094473386773, 12961.15752476086, 13014.15407998477, 13037.804432933513, 7161.641917904084, 7192.388646965067, 7197.568145911157, 7259.382952448996, 7266.0, 7006.824829379307, 7022.578645281299, 7028.332308430691, 7076.009358689787, 7077.858442831114, 5900.085486749561, 5967.343592204854, 5979.5515336349945, 5993.0, 6081.422264884829, 1652.5044834424864, 1721.4147189955224, 1755.6488702259599, 1766.240516577884, 1770.6989811732037, 924.6624981881565, 928.4568527411404, 977.9070988256104, 985.4235272365746, 1059.8500626819987, 16379.83620163783, 16564.917175414288, 16949.661006779796, 16951.576210594587, 17153.485395438158, 847.7626264645909, 917.6742256498981, 927.4388994658269, 944.3200895355333, 950.4249928793118, 9651.517424128906, 10523.737151541864, 10534.104601108991, 10549.683509494575, 10552.419616921143, 349239.0, 526142.0, 532546.0, 532967.0, 551092.0, 40081.79959100186, 41586.584134158875, 68143.63244368468, 77569.61215193888, 80001.59999200083, 1167.53882216524, 1169.2750494693175, 1189.4052973513244, 1205.5780476833038, 1221.9327936963552, 14957.476488322856, 15543.222838857786, 15685.29416176252, 15726.634008958197, 15999.760003600188, 34157.48763768496, 34433.0, 34448.0, 34543.481847772804, 35296.29407411786, 46246.53753462422, 46765.2985205229, 47080.52919470761, 48363.75818120887, 50268.0, 9436.95281523588, 9462.858057129011, 9608.807823843625, 9800.509974501103, 9852.802943941224, 16445.506634800975, 17127.22927468242, 17207.483775486755, 17611.735823962907, 17690.292388304322, 13960.930195348958, 14005.719885602435, 14247.572572822832, 14370.568882933529, 14376.35306411193, 13597.11618744818, 13736.244506552235, 14442.638934026734, 14775.778363324343, 14948.701025979637, 14053.22707251111, 14268.357923893242, 14564.708705826037, 14934.626634334229, 15048.516994695752, 9175.403598766059, 9397.574787334028, 9630.32587718853, 9664.855027174457, 9673.806523869624, 13829.861701382857, 13956.441742330193, 14110.223937683526, 14140.43438262458, 14321.57035288943], "unit": "score", "name": "jquery.html", "value": 8896.276899369528}, {"lowerIsBetter": false, "replicates": [1497.8277498087723, 1681.6048228666266, 1698.7791587093675, 1711.2727090986327, 1747.2486830662817, 6616.470682345413, 7380.704771809128, 7543.0, 7544.773656790298, 7562.054743157106, 7387.519811212267, 7526.0, 7559.50863193892, 7576.96211518943, 7592.27873352032, 1898.5253686578355, 1923.384516954575, 2128.0849234829016, 2142.8714277143345, 2162.7945345192184, 2235.642297232443, 2241.7421996470453, 2250.2799104286637, 2250.6173950428465, 2252.5720113178527, 2109.60972220139, 2129.58473097746, 2131.6482780341225, 2134.1996751218294, 2135.9252426165085, 2150.569886022794, 2156.644153714635, 2183.094015983365, 2183.858049226803, 2185.9890700546393, 2168.046059733728, 2189.9233526826483, 2211.8562293450873, 2217.0466699319286, 2218.5119273759747, 7523.435742319348, 7570.129435114977, 7582.469227154102, 7589.430792690515, 7590.0891892973195, 4337.783110844477, 4437.378766972626, 4440.089781594766, 4440.245158323093, 4443.800028998703, 2868.4836729388703, 2916.460454815866, 2939.6325459317586, 2958.541426078961, 2997.895073672411, 923.9769005774909, 938.2540880000416, 938.85917112433, 955.0544960489066, 961.3991255465335, 10485.895141048568, 10508.422036787973, 10511.947440262826, 10516.947415262875, 10524.15806735467, 3965.345717956505, 4004.579519150447, 4052.473178486837, 4065.7763822989427, 4076.470058892325, 9043.502607356528, 9050.456972581665, 9057.728268151966, 9060.456372617664, 9065.909340906639, 4392.05570802279, 4395.1868904252815, 4419.292913133948, 4423.867283981485, 4429.512753597101, 3947.5657677655436, 3997.060690737674, 3999.8000099995465, 4002.3796311571755, 4003.339448990942, 3093.3658599986948, 3129.937401252008, 3468.8265586720563, 3498.2303893143976, 3540.4689296605716, 1146.128942004083, 1159.9362035088152, 1166.9824952625718, 1174.4127936031985, 1175.6002958993984, 1019.9898001020043, 1046.2519298701466, 1049.6168898352046, 1148.3454430974432, 1288.9548865789652, 6944.270851560514, 6949.548279361927, 7029.648517574203, 7049.189343225492, 7058.11773528309, 1099.7085772270354, 1102.3716481605568, 1119.4234968990977, 1136.86926003509, 1144.9771004579861, 5299.894002120013, 5368.1679339702405, 5372.57019438444, 5376.542993845489, 5389.299391079135, 8788.903251466665, 8799.604017819214, 8998.10018998108, 9047.457152570867, 9194.49430281341, 8966.641334346683, 9109.362344635945, 9112.8633070504, 9128.3153763468, 9136.360454768102, 7201.3518783309755, 7209.819754506075, 7326.230745771723, 7385.4460915431555, 7398.852022959511, 6986.371226589428, 7023.543469674455, 7036.155661320674, 7046.647667616701, 7053.0, 7945.686457320814, 8298.709545166132, 8299.502029878227, 8310.33517318601, 8322.62548185321, 8135.064467586303, 8214.13751556078, 8297.04583972851, 8399.950006249219, 8445.619947102272, 6533.771318003847, 6687.966560167362, 6713.899291510534, 6719.193696756421, 6722.193336799615, 6294.464970477377, 6441.581297215666, 6700.363465470772, 6962.268961758942, 7059.470539709439, 6759.695813688494, 6768.458523318024, 6929.861402771816, 7021.227664956748, 7069.469789765685, 6773.89839152423, 6777.085093512313, 6828.419584335387, 6931.410830079298, 6963.09479767627, 6708.966455167693, 6747.257801641717, 6773.05177275172, 6779.694913728993, 6785.491088168308, 6081.939180608314, 6089.117078023751, 6089.69551522431, 6107.480864126422, 6168.537359697951, 6104.908426373519, 6129.601575897553, 6140.293866205444, 6148.323684394623, 6149.108379285068], "unit": "score", "name": "mootools.html", "value": 4320.31536593431}, {"lowerIsBetter": false, "replicates": [339.0963083382785, 342.1463448695505, 343.3287922112271, 344.6691176470587, 350.56704969362835, 5897.970510147443, 5971.0, 5980.312264089625, 5993.700314984249, 6014.278286605613, 5789.421057894208, 5911.290645122581, 5929.318128415222, 5933.910991335133, 5934.88130237395, 4601.3558101865765, 4605.493395726484, 4616.907661846761, 4622.8150873965005, 4625.699329543586, 4386.166628340621, 4471.642268618502, 4504.864854054384, 4620.584147426731, 4625.398698169233, 4547.477040140393, 4575.885602859922, 4577.0, 4601.608863246612, 4601.723896566216, 4559.270516717326, 4571.588557029867, 4580.473245576734, 4583.770811459413, 4586.105709386671, 4036.091879327157, 4036.2734707752593, 4039.7576145431076, 4053.3312003519677, 4061.918761624751, 5529.612927095105, 5647.068233741427, 5649.0, 5664.178694089334, 5677.432256774289, 5289.682619042831, 5292.497212764782, 5294.788208471657, 5297.708626025567, 5337.8131765388025, 6293.716782744787, 6294.213223347082, 6295.842603934892, 6297.716602752887, 6301.936980630181, 4207.726497777665, 4277.101808620194, 4324.070324880135, 4430.889227769299, 4467.865964021084, 6521.217453905514, 6552.0, 6552.3447655234095, 6562.44219241365, 6579.374959378852, 4555.977220113945, 4563.406757121619, 4564.475085365159, 4576.244919588297, 4577.084583083397, 4551.590356867831, 4628.490866004737, 4630.583247507673, 4630.58324750774, 4635.513271106553, 5325.893482130413, 5326.893462130735, 5327.387350454747, 5329.467053294639, 5330.253764472977, 6328.778492752824, 6334.873302534015, 6345.1434056401795, 6345.17512723343, 6348.968255158695, 1629.7310943694395, 1647.9340826367052, 1650.1749125437282, 1650.2161473300087, 1650.2656317938402, 1116.4808364110727, 1120.6413947536873, 1130.6834086455806, 1130.7851508213414, 1146.7706458708292, 5896.911546326808, 5946.613470124515, 5947.1376650385455, 5955.315138759098, 5957.731902064331, 6497.610143391317, 6501.414872661483, 6504.544681872224, 6506.674666266667, 6517.51118666102, 5826.0, 5938.435848594377, 5945.10823376497, 5948.196993405835, 5952.107183922446, 3454.360943225461, 3509.876839411415, 3540.061883600848, 3544.7164226861787, 3551.1654761131113, 6464.321246269168, 6469.967650161813, 6471.6764161791725, 6517.120188774549, 6536.052272420472, 6605.768798092044, 6608.0, 6612.206535215805, 6616.603003819786, 6619.536632435684, 6395.20059992501, 6506.642134682638, 6519.967400162969, 6522.934770652328, 6530.216374035146, 6308.526860485574, 6487.124238227779, 6499.252585952487, 6504.577202481823, 6507.316731743099, 6335.683215839282, 6345.873082538231, 6472.093906852951, 6479.31967143462, 6480.805575832733, 6536.0, 6557.9344206557325, 6559.245686745894, 6564.409203171546, 6569.277379488157, 4557.908841823211, 4558.36182934396, 4569.428821397325, 4569.977150114228, 4570.840020599263, 6452.870942581216, 6577.6053436793945, 6586.4401525870835, 6588.8352791180605, 6594.274629790815, 6403.167588213689, 6406.423421892052, 6414.583052101599, 6422.807315780534, 6426.228852537725, 6257.09272155544, 6379.4896408286295, 6386.265579458422, 6387.0, 6389.87220255583, 6278.645507934524, 6287.591306565058, 6291.748330066746, 6292.489802447288, 6296.748130074746, 6369.649669268235, 6434.935650643433, 6439.356064393523, 6439.839004024937, 6442.9691249399875, 6077.118817771487, 6264.780732674517, 6274.466670333073, 6279.0, 6292.0], "unit": "score", "name": "prototype.html", "value": 4779.375268827092}, {"lowerIsBetter": false, "replicates": [844.9564787487448, 850.8936382952131, 851.450814224825, 857.8327226190887, 861.9181177788109, 11861.584844530433, 12196.451159697812, 12197.756044879097, 12200.20698654588, 12228.02175825934, 11384.430778461085, 11528.538858445672, 11611.419429028558, 11625.651230463078, 11627.651170464878, 814.7148498025688, 829.8713699376606, 830.0288662265134, 830.0537387378394, 831.3972370031739, 699.8635266123108, 700.3976580141075, 829.6598394658191, 832.592029905345, 836.3392919593514, 862.4394143806513, 863.7365603490932, 869.5565261716507, 869.5565261716539, 870.3820287595782, 717.3113810741694, 861.8233262181269, 861.8664107063415, 861.8879545659087, 864.9221570058694, 525.4194115502391, 643.584887747405, 643.8165122939939, 644.2816259870211, 645.3514218210669, 12495.06326519382, 12582.811257831048, 12666.176698514659, 12678.112532122756, 12685.746285074247, 11308.547658093748, 11572.884271157349, 11786.17496775226, 11844.46699898498, 12038.217515861528, 9142.588583513758, 9409.0, 9512.33413661044, 9526.90473095267, 9692.75768105803, 3489.4416893296952, 3514.595821480537, 3518.6833185013215, 3543.433050711874, 3560.946585801215, 45495.0, 45500.544994549964, 45620.54379456229, 46596.3010554842, 46696.299555506695, 9156.313276504288, 9163.58763855628, 9206.861897071549, 9241.3531052827, 9264.212541934012, 18327.450176494727, 18455.53861153482, 18487.352942646943, 18497.630047398976, 18498.075096245135, 6954.165500140016, 7061.752838650726, 7069.82325441868, 7128.92871071293, 7185.6047917364, 4094.4677191965447, 4241.300185469363, 4326.610605045561, 4337.50118736343, 4337.7397356158735, 3184.45864203086, 3197.936041279208, 3210.839458027089, 3213.4697774867354, 3215.405150047202, 561.53673219594, 570.7716913234656, 579.0185635348045, 580.4427749360576, 589.7169358707758, 634.1312402009277, 634.2737565487491, 646.6572716460283, 651.7458191305394, 656.6257233377024, 7162.46281528877, 7445.7766267012075, 7700.691972321157, 8272.503649780912, 8353.624086916103, 432.4745434297281, 594.9702514874239, 612.1643956000116, 619.294004834489, 644.320242144542, 3354.6429516067406, 3512.1921957949817, 3524.4008518551395, 3625.2386998730035, 3654.5066416033496, 50533.0, 51248.74375628098, 51807.48192518102, 52092.47907520952, 54371.45628543743, 49261.261081083816, 49407.75296123496, 49602.0, 49687.50312496901, 49718.0, 43073.56926430758, 43504.347434788506, 43864.0, 44077.55922440799, 44139.337909931375, 7067.399271062018, 7197.280271972971, 7299.0, 7334.816629584303, 7460.4031677466755, 32735.508967365986, 33439.0, 33622.0, 33865.49201762025, 34004.319913601095, 38278.61721382751, 42210.36684449797, 42592.78703606462, 42727.14545709006, 42845.143097138505, 9211.40125891815, 9234.95382523083, 9283.257339412696, 9320.440773553608, 9384.57769400365, 10163.542640581043, 10302.690919272434, 10312.381257124596, 10317.0, 10392.636257730943, 8960.417572857743, 9045.864312035457, 9274.072592740671, 9454.574544145667, 9460.858087128561, 9560.40716181014, 9753.12221900004, 9824.263180261367, 10131.493425328557, 10137.949310253402, 9047.547622618711, 9305.441673499612, 9323.20752736025, 9324.860127098234, 9461.101195386427, 8051.4766540174705, 8173.0, 8191.719392162798, 8360.331173505983, 8478.576071196292, 7623.809404764926, 7750.496217745828, 7872.724454644289, 8475.491470511543, 8635.222829945084], "unit": "score", "name": "yui.html", "value": 5873.567746615243}], "name": "dromaeo_css", "value": 6868.26789103561}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 105.0, 111.0, 112.0, 110.0, 99.0, 109.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.4}, {"lowerIsBetter": true, "replicates": [151.0, 125.0, 153.0, 163.0, 124.0, 152.0, 152.0, 126.0, 174.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 144.3}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 160.0, 160.0, 171.0, 161.0, 159.0, 159.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 87.0, 97.0, 73.0, 74.0, 73.0, 106.0, 87.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 137.0, 93.0, 92.0, 93.0, 140.0, 92.0, 92.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 144.0, 146.0, 145.0, 146.0, 144.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [60.0, 58.0, 58.0, 57.0, 58.0, 57.0, 57.0, 65.0, 55.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 69.0, 76.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [89.0, 83.0, 84.0, 84.0, 91.0, 83.0, 82.0, 83.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [122.0, 112.0, 122.0, 115.0, 117.0, 119.0, 117.0, 125.0, 138.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.2}, {"lowerIsBetter": true, "replicates": [141.0, 152.0, 151.0, 159.0, 150.0, 152.0, 152.0, 154.0, 151.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.4}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 68.0, 68.0, 65.0, 66.0, 68.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1499.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.27868307283006], "unit": "score", "name": "Richards", "value": 212.306228}, {"lowerIsBetter": false, "replicates": [194.81784531463083], "unit": "score", "name": "DeltaBlue", "value": 339.383694}, {"lowerIsBetter": false, "replicates": [282.80542986425337], "unit": "score", "name": "Encrypt", "value": 941.2160160000003}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1077.5862068965516], "unit": "score", "name": "RayTrace", "value": 686.7097920000001}, {"lowerIsBetter": false, "replicates": [786.1635220125786], "unit": "score", "name": "Earley", "value": 847.7409359999999}, {"lowerIsBetter": false, "replicates": [12358.024691358025], "unit": "score", "name": "Boyer", "value": 53.929573426573455}, {"lowerIsBetter": false, "replicates": [25666.666666666668], "unit": "score", "name": "RegExp", "value": 35.49292207792205}, {"lowerIsBetter": false, "replicates": [697.5138121546961], "unit": "score", "name": "Splay", "value": 116.83066138613862}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20708.612609918917}]} 08:13:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20708.61"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1499.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6868.27"}}} 08:13:50 INFO - Return code: 0 08:13:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:13:50 INFO - # TBPL SUCCESS # 08:13:50 INFO - Running post-action listener: _resource_record_post_action 08:13:50 INFO - Running post-run listener: _resource_record_post_run 08:13:51 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 36864; Write bytes: 551264256; Read time: 876; Write time: 611228 08:13:51 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 8192; Write bytes: 244723712; Read time: 624; Write time: 367236 08:13:51 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 28672; Write bytes: 305561600; Read time: 252; Write time: 243988 08:13:51 INFO - Running post-run listener: _upload_blobber_files 08:13:51 INFO - Blob upload gear active. 08:13:51 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:13:51 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 08:13:51 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'] 08:13:51 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 08:13:51 INFO - (blobuploader) - INFO - Open directory for files ... 08:13:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:13:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:13:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:13:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:13:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:13:52 INFO - (blobuploader) - INFO - Done attempting. 08:13:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:13:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:13:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:13:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:13:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:13:53 INFO - (blobuploader) - INFO - Done attempting. 08:13:53 INFO - (blobuploader) - INFO - Iteration through files over. 08:13:53 INFO - Return code: 0 08:13:53 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:13:53 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:13:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9152754c2b5fc19bd300d791d926b41b162287329300d487b2c2aed4de1ab2311803886f869432ec2dec6fe3f132d9a2319cd1ac6991d05c04f87f445ec53298", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/777e2d780c54cae08e57c48717c84611d1727d2413d3a83975766b7521f0ab970c25853652888df3c182e43ebf725553f86932e6cd494781b1b3ee080b04a8d2"} 08:13:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:13:53 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:13:53 INFO - Contents: 08:13:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9152754c2b5fc19bd300d791d926b41b162287329300d487b2c2aed4de1ab2311803886f869432ec2dec6fe3f132d9a2319cd1ac6991d05c04f87f445ec53298", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/777e2d780c54cae08e57c48717c84611d1727d2413d3a83975766b7521f0ab970c25853652888df3c182e43ebf725553f86932e6cd494781b1b3ee080b04a8d2"} 08:13:53 INFO - Copying logs to upload dir... 08:13:53 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.994124 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-24 08:13:53.133785) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-24 08:13:53.137867) ========= 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=0c96bf5caf0e090009e1a122000001b2-1450969329.971396-692637892 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/9152754c2b5fc19bd300d791d926b41b162287329300d487b2c2aed4de1ab2311803886f869432ec2dec6fe3f132d9a2319cd1ac6991d05c04f87f445ec53298", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/777e2d780c54cae08e57c48717c84611d1727d2413d3a83975766b7521f0ab970c25853652888df3c182e43ebf725553f86932e6cd494781b1b3ee080b04a8d2"} build_url:https://queue.taskcluster.net/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011289 build_url: 'https://queue.taskcluster.net/v1/task/GEvTG34xSTaZ-Dbd0-hcCg/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/9152754c2b5fc19bd300d791d926b41b162287329300d487b2c2aed4de1ab2311803886f869432ec2dec6fe3f132d9a2319cd1ac6991d05c04f87f445ec53298", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/777e2d780c54cae08e57c48717c84611d1727d2413d3a83975766b7521f0ab970c25853652888df3c182e43ebf725553f86932e6cd494781b1b3ee080b04a8d2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-24 08:13:53.163505) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 08:13:53.163895) ========= 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=0c96bf5caf0e090009e1a122000001b2-1450969329.971396-692637892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004415 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-24 08:13:53.247598) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-24 08:13:53.247973) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-24 08:13:53.248324) ========= ========= Total master_lag: 0.19 =========