builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-044 starttime: 1450841849.07 results: success (0) buildid: 20151222173012 builduid: ff21b19edbb74e3794727e624553b2b5 revision: acd00bf58a21e3783805c015c37b92731e5797f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 19:37:29.070031) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 19:37:29.071044) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 19:37:29.071457) ========= 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=0cff312cb257a7829adc5a5d000001df-1450840521.788027-651438517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004936 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 19:37:29.145116) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 19:37:29.145437) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 19:37:29.209130) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 19:37:29.211342) ========= 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=0cff312cb257a7829adc5a5d000001df-1450840521.788027-651438517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019653 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 19:37:29.261058) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 19:37:29.261368) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 19:37:29.261733) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 19:37:29.262047) ========= 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=0cff312cb257a7829adc5a5d000001df-1450840521.788027-651438517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-22 19:37:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 224M=0s 2015-12-22 19:37:29 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.194359 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 19:37:29.474885) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 19:37:29.475192) ========= 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=0cff312cb257a7829adc5a5d000001df-1450840521.788027-651438517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.059410 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 19:37:29.547052) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 19:37:29.547457) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev acd00bf58a21e3783805c015c37b92731e5797f2 --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/b2g-inbound --rev acd00bf58a21e3783805c015c37b92731e5797f2 --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=0cff312cb257a7829adc5a5d000001df-1450840521.788027-651438517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-22 19:37:29,625 truncating revision to first 12 chars 2015-12-22 19:37:29,625 Setting DEBUG logging. 2015-12-22 19:37:29,625 attempt 1/10 2015-12-22 19:37:29,625 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/acd00bf58a21?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-22 19:37:30,093 unpacking tar archive at: b2g-inbound-acd00bf58a21/testing/mozharness/ program finished with exit code 0 elapsedTime=0.772008 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 19:37:30.332253) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 19:37:30.332619) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 19:37:30.343608) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 19:37:30.343945) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 19:37:30.344498) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-12-22 19:37:30.344982) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 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', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] 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=0cff312cb257a7829adc5a5d000001df-1450840521.788027-651438517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:37:30 INFO - MultiFileLogger online at 20151222 19:37:30 in /builds/slave/test-pgo 19:37:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 19:37:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:37:30 INFO - {'append_to_log': False, 19:37:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:37:30 INFO - 'blob_upload_branch': 'B2G-Inbound', 19:37:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:37:30 INFO - 'branch': 'B2G-Inbound', 19:37:30 INFO - 'buildbot_json_path': 'buildprops.json', 19:37:30 INFO - 'config_files': ('talos/linux_config.py',), 19:37:30 INFO - 'default_actions': ('clobber', 19:37:30 INFO - 'read-buildbot-config', 19:37:30 INFO - 'download-and-extract', 19:37:30 INFO - 'populate-webroot', 19:37:30 INFO - 'create-virtualenv', 19:37:30 INFO - 'install', 19:37:30 INFO - 'run-tests'), 19:37:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:37:30 INFO - 'download_minidump_stackwalk': True, 19:37:30 INFO - 'download_symbols': 'ondemand', 19:37:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:37:30 INFO - 'tooltool.py': '/tools/tooltool.py', 19:37:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:37:30 INFO - '/tools/misc-python/virtualenv.py')}, 19:37:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:37:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:37:30 INFO - 'installer_path': 'installer.exe', 19:37:30 INFO - 'log_level': 'info', 19:37:30 INFO - 'log_name': 'talos', 19:37:30 INFO - 'log_to_console': True, 19:37:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:37:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:37:30 INFO - 'opt_config_files': (), 19:37:30 INFO - 'pip_index': False, 19:37:30 INFO - 'sps_profile': False, 19:37:30 INFO - 'sps_profile_interval': 0, 19:37:30 INFO - 'suite': 'dromaeojs', 19:37:30 INFO - 'system_bits': '64', 19:37:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:37:30 INFO - 'title': 'talos-linux64-ix-044', 19:37:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:37:30 INFO - 'use_talos_json': True, 19:37:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:37:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:37:30 INFO - 'work_dir': 'build'} 19:37:30 INFO - ##### 19:37:30 INFO - ##### Running clobber step. 19:37:30 INFO - ##### 19:37:30 INFO - Running pre-action listener: _resource_record_pre_action 19:37:30 INFO - Running main action method: clobber 19:37:30 INFO - rmtree: /builds/slave/test-pgo/build 19:37:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:37:37 INFO - Running post-action listener: _resource_record_post_action 19:37:37 INFO - ##### 19:37:37 INFO - ##### Running read-buildbot-config step. 19:37:37 INFO - ##### 19:37:37 INFO - Running pre-action listener: _resource_record_pre_action 19:37:37 INFO - Running main action method: read_buildbot_config 19:37:37 INFO - Using buildbot properties: 19:37:37 INFO - { 19:37:37 INFO - "project": "", 19:37:37 INFO - "product": "firefox", 19:37:37 INFO - "script_repo_revision": "production", 19:37:37 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 19:37:37 INFO - "repository": "", 19:37:37 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 19:37:37 INFO - "buildid": "20151222173012", 19:37:37 INFO - "pgo_build": "True", 19:37:37 INFO - "basedir": "/builds/slave/test-pgo", 19:37:37 INFO - "buildnumber": 147, 19:37:37 INFO - "slavename": "talos-linux64-ix-044", 19:37:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:37:37 INFO - "platform": "ubuntu64_hw", 19:37:37 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 19:37:37 INFO - "branch": "b2g-inbound", 19:37:37 INFO - "repo_path": "integration/b2g-inbound", 19:37:37 INFO - "revision": "acd00bf58a21e3783805c015c37b92731e5797f2", 19:37:37 INFO - "stage_platform": "linux64-pgo", 19:37:37 INFO - "builduid": "ff21b19edbb74e3794727e624553b2b5", 19:37:37 INFO - "slavebuilddir": "test" 19:37:37 INFO - } 19:37:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:37:37 INFO - Running post-action listener: _resource_record_post_action 19:37:37 INFO - ##### 19:37:37 INFO - ##### Running download-and-extract step. 19:37:37 INFO - ##### 19:37:37 INFO - Running pre-action listener: _resource_record_pre_action 19:37:37 INFO - Running main action method: download_and_extract 19:37:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:37 INFO - https://queue.taskcluster.net/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:37:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/test_packages.json 19:37:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/test_packages.json 19:37:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:37:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:37:37 INFO - Downloaded 1302 bytes. 19:37:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:37:37 INFO - Using the following test package requirements: 19:37:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:37:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:37:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:37:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:37:37 INFO - u'jsshell-linux-x86_64.zip'], 19:37:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:37:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:37:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:37:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:37:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:37:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:37:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:37:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:37:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:37:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:37:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:37:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:37:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:37 INFO - https://queue.taskcluster.net/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:37:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:37:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:37:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:37:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:37:39 INFO - Downloaded 23175584 bytes. 19:37:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 19:37:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:37:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:37:40 INFO - Return code: 0 19:37:40 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:40 INFO - https://queue.taskcluster.net/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:37:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:37:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:37:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:37:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:37:42 INFO - Downloaded 23175584 bytes. 19:37:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 19:37:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:37:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:37:43 INFO - Return code: 0 19:37:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:43 INFO - https://queue.taskcluster.net/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:37:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:37:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:37:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:37:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:37:45 INFO - Downloaded 11132277 bytes. 19:37:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 19:37:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:37:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 19:37:45 INFO - Return code: 0 19:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:45 INFO - https://queue.taskcluster.net/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:37:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:37:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:37:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:37:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:37:47 INFO - Downloaded 54965960 bytes. 19:37:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:37:47 INFO - mkdir: /builds/slave/test-pgo/properties 19:37:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:37:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:37:47 INFO - Contents: 19:37:47 INFO - build_url:https://queue.taskcluster.net/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:37:47 INFO - Running post-action listener: _resource_record_post_action 19:37:47 INFO - Running post-action listener: set_extra_try_arguments 19:37:47 INFO - ##### 19:37:47 INFO - ##### Running populate-webroot step. 19:37:47 INFO - ##### 19:37:47 INFO - Running pre-action listener: _resource_record_pre_action 19:37:47 INFO - Running main action method: populate_webroot 19:37:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:37:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:37:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:37:47 INFO - '--tppagecycles', 19:37:47 INFO - '7'], 19:37:47 INFO - 'tests': ['tsvgm']}}, 19:37:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:37:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:37:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:37:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:37:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:37:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:37:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:37:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:37:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:37:47 INFO - 'talos_options': ['--e10s'], 19:37:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:37:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:37:47 INFO - 'tests': ['damp', 'tps']}, 19:37:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:37:47 INFO - 'talos_options': ['--e10s'], 19:37:47 INFO - 'tests': ['damp', 'tps']}, 19:37:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:37:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:37:47 INFO - 'other': {'tests': ['a11yr', 19:37:47 INFO - 'ts_paint', 19:37:47 INFO - 'tpaint', 19:37:47 INFO - 'sessionrestore', 19:37:47 INFO - 'sessionrestore_no_auto_restore']}, 19:37:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:37:47 INFO - 'tests': ['a11yr', 19:37:47 INFO - 'ts_paint', 19:37:47 INFO - 'tpaint', 19:37:47 INFO - 'sessionrestore', 19:37:47 INFO - 'sessionrestore_no_auto_restore']}, 19:37:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:37:47 INFO - 'tests': ['a11yr', 19:37:47 INFO - 'ts_paint', 19:37:47 INFO - 'tpaint', 19:37:47 INFO - 'sessionrestore', 19:37:47 INFO - 'sessionrestore_no_auto_restore']}, 19:37:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:37:47 INFO - 'tests': ['a11yr', 19:37:47 INFO - 'ts_paint', 19:37:47 INFO - 'tpaint', 19:37:47 INFO - 'sessionrestore', 19:37:47 INFO - 'sessionrestore_no_auto_restore']}, 19:37:47 INFO - 'other_l64': {'tests': ['a11yr', 19:37:47 INFO - 'ts_paint', 19:37:47 INFO - 'tpaint', 19:37:47 INFO - 'sessionrestore', 19:37:47 INFO - 'sessionrestore_no_auto_restore']}, 19:37:47 INFO - 'other_nol64': {'tests': ['a11yr', 19:37:47 INFO - 'ts_paint', 19:37:47 INFO - 'tpaint', 19:37:47 INFO - 'sessionrestore', 19:37:47 INFO - 'sessionrestore_no_auto_restore']}, 19:37:47 INFO - 'svgr': {'tests': ['tsvgx', 19:37:47 INFO - 'tsvgr_opacity', 19:37:47 INFO - 'tart', 19:37:47 INFO - 'tscrollx', 19:37:47 INFO - 'cart']}, 19:37:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:37:47 INFO - 'tests': ['tsvgx', 19:37:47 INFO - 'tsvgr_opacity', 19:37:47 INFO - 'tart', 19:37:47 INFO - 'tscrollx', 19:37:47 INFO - 'cart']}, 19:37:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:37:47 INFO - 'tests': ['tp5o']}, 19:37:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:37:47 INFO - 'talos_options': ['--e10s'], 19:37:47 INFO - 'tests': ['tp5o']}, 19:37:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:37:47 INFO - 'talos_options': ['--xperf_path', 19:37:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:37:47 INFO - 'tests': ['tp5n']}, 19:37:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:37:47 INFO - 'talos_options': ['--e10s', 19:37:47 INFO - '--xperf_path', 19:37:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:37:47 INFO - 'tests': ['tp5n']}}, 19:37:47 INFO - 'talos.zip': {'path': '', 19:37:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:37:47 INFO - Running post-action listener: _resource_record_post_action 19:37:47 INFO - ##### 19:37:47 INFO - ##### Running create-virtualenv step. 19:37:47 INFO - ##### 19:37:47 INFO - Running pre-action listener: _resource_record_pre_action 19:37:47 INFO - Running main action method: create_virtualenv 19:37:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:37:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 19:37:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:37:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:37:47 INFO - Using real prefix '/usr' 19:37:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:37:47 INFO - Installing distribute.............................................................................................................................................................................................done. 19:37:49 INFO - Installing pip.................done. 19:37:49 INFO - Return code: 0 19:37:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4dcc82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2506850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25053f0>, '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 0x2597560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2597a10>, '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': '0cff312cb257a7829adc5a5d000001df-1450840521.788027-651438517', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:37:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 19:37:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:37:49 INFO - Using env: {'DISPLAY': ':0', 19:37:49 INFO - 'HOME': '/home/cltbld', 19:37:49 INFO - 'LANG': 'en_US.UTF-8', 19:37:49 INFO - 'LANGUAGE': 'en_US:en', 19:37:49 INFO - 'LOGNAME': 'cltbld', 19:37:49 INFO - 'MAIL': '/var/mail/cltbld', 19:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:49 INFO - 'MOZ_NO_REMOTE': '1', 19:37:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:37:49 INFO - 'NO_EM_RESTART': '1', 19:37:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:37:49 INFO - 'PWD': '/builds/slave/test-pgo', 19:37:49 INFO - 'SHELL': '/bin/bash', 19:37:49 INFO - 'SHLVL': '1', 19:37:49 INFO - 'TERM': 'linux', 19:37:49 INFO - 'TMOUT': '86400', 19:37:49 INFO - 'USER': 'cltbld', 19:37:49 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450840521.788027-651438517', 19:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:49 INFO - '_': '/tools/buildbot/bin/python'} 19:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:37:50 INFO - Cleaning up... 19:37:50 INFO - Return code: 0 19:37:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:37:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc4dcc82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2506850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25053f0>, '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 0x2597560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2597a10>, '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': '0cff312cb257a7829adc5a5d000001df-1450840521.788027-651438517', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:37:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 19:37:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:37:51 INFO - Using env: {'DISPLAY': ':0', 19:37:51 INFO - 'HOME': '/home/cltbld', 19:37:51 INFO - 'LANG': 'en_US.UTF-8', 19:37:51 INFO - 'LANGUAGE': 'en_US:en', 19:37:51 INFO - 'LOGNAME': 'cltbld', 19:37:51 INFO - 'MAIL': '/var/mail/cltbld', 19:37:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:51 INFO - 'MOZ_NO_REMOTE': '1', 19:37:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:37:51 INFO - 'NO_EM_RESTART': '1', 19:37:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:37:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:37:51 INFO - 'PWD': '/builds/slave/test-pgo', 19:37:51 INFO - 'SHELL': '/bin/bash', 19:37:51 INFO - 'SHLVL': '1', 19:37:51 INFO - 'TERM': 'linux', 19:37:51 INFO - 'TMOUT': '86400', 19:37:51 INFO - 'USER': 'cltbld', 19:37:51 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450840521.788027-651438517', 19:37:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:51 INFO - '_': '/tools/buildbot/bin/python'} 19:37:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:51 INFO - Downloading/unpacking psutil>=0.7.1 19:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:53 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:37:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:37:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:37:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:37:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:37:53 INFO - Installing collected packages: psutil 19:37:53 INFO - Running setup.py install for psutil 19:37:53 INFO - building 'psutil._psutil_linux' extension 19:37:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:37:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:37:54 INFO - building 'psutil._psutil_posix' extension 19:37:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:37:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:37:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:37:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:37:54 INFO - Successfully installed psutil 19:37:54 INFO - Cleaning up... 19:37:54 INFO - Return code: 0 19:37:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc4dcc82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2506850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25053f0>, '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 0x2597560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2597a10>, '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': '0cff312cb257a7829adc5a5d000001df-1450840521.788027-651438517', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:37:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 19:37:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:37:54 INFO - Using env: {'DISPLAY': ':0', 19:37:54 INFO - 'HOME': '/home/cltbld', 19:37:54 INFO - 'LANG': 'en_US.UTF-8', 19:37:54 INFO - 'LANGUAGE': 'en_US:en', 19:37:54 INFO - 'LOGNAME': 'cltbld', 19:37:54 INFO - 'MAIL': '/var/mail/cltbld', 19:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:54 INFO - 'MOZ_NO_REMOTE': '1', 19:37:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:37:54 INFO - 'NO_EM_RESTART': '1', 19:37:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:37:54 INFO - 'PWD': '/builds/slave/test-pgo', 19:37:54 INFO - 'SHELL': '/bin/bash', 19:37:54 INFO - 'SHLVL': '1', 19:37:54 INFO - 'TERM': 'linux', 19:37:54 INFO - 'TMOUT': '86400', 19:37:54 INFO - 'USER': 'cltbld', 19:37:54 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450840521.788027-651438517', 19:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:54 INFO - '_': '/tools/buildbot/bin/python'} 19:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:37:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:37:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:37:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:37:56 INFO - Installing collected packages: mozsystemmonitor 19:37:56 INFO - Running setup.py install for mozsystemmonitor 19:37:56 INFO - Successfully installed mozsystemmonitor 19:37:56 INFO - Cleaning up... 19:37:57 INFO - Return code: 0 19:37:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:37:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:57 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 0x7fc4dcc82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2506850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25053f0>, '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 0x2597560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2597a10>, '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': '0cff312cb257a7829adc5a5d000001df-1450840521.788027-651438517', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:37:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:37:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:37:57 INFO - Using env: {'DISPLAY': ':0', 19:37:57 INFO - 'HOME': '/home/cltbld', 19:37:57 INFO - 'LANG': 'en_US.UTF-8', 19:37:57 INFO - 'LANGUAGE': 'en_US:en', 19:37:57 INFO - 'LOGNAME': 'cltbld', 19:37:57 INFO - 'MAIL': '/var/mail/cltbld', 19:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:57 INFO - 'MOZ_NO_REMOTE': '1', 19:37:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:37:57 INFO - 'NO_EM_RESTART': '1', 19:37:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:37:57 INFO - 'PWD': '/builds/slave/test-pgo', 19:37:57 INFO - 'SHELL': '/bin/bash', 19:37:57 INFO - 'SHLVL': '1', 19:37:57 INFO - 'TERM': 'linux', 19:37:57 INFO - 'TMOUT': '86400', 19:37:57 INFO - 'USER': 'cltbld', 19:37:57 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450840521.788027-651438517', 19:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:57 INFO - '_': '/tools/buildbot/bin/python'} 19:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:57 INFO - Downloading/unpacking blobuploader==1.2.4 19:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:58 INFO - Downloading blobuploader-1.2.4.tar.gz 19:37:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:37:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:37:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:37:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:37:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:59 INFO - Downloading docopt-0.6.1.tar.gz 19:37:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:37:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:37:59 INFO - Installing collected packages: blobuploader, requests, docopt 19:37:59 INFO - Running setup.py install for blobuploader 19:37:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:37:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:37:59 INFO - Running setup.py install for requests 19:38:00 INFO - Running setup.py install for docopt 19:38:00 INFO - Successfully installed blobuploader requests docopt 19:38:00 INFO - Cleaning up... 19:38:00 INFO - Return code: 0 19:38:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38:00 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 0x7fc4dcc82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2506850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25053f0>, '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 0x2597560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2597a10>, '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': '0cff312cb257a7829adc5a5d000001df-1450840521.788027-651438517', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:38:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 19:38:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:38:00 INFO - Using env: {'DISPLAY': ':0', 19:38:00 INFO - 'HOME': '/home/cltbld', 19:38:00 INFO - 'LANG': 'en_US.UTF-8', 19:38:00 INFO - 'LANGUAGE': 'en_US:en', 19:38:00 INFO - 'LOGNAME': 'cltbld', 19:38:00 INFO - 'MAIL': '/var/mail/cltbld', 19:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:00 INFO - 'MOZ_NO_REMOTE': '1', 19:38:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:38:00 INFO - 'NO_EM_RESTART': '1', 19:38:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:38:00 INFO - 'PWD': '/builds/slave/test-pgo', 19:38:00 INFO - 'SHELL': '/bin/bash', 19:38:00 INFO - 'SHLVL': '1', 19:38:00 INFO - 'TERM': 'linux', 19:38:00 INFO - 'TMOUT': '86400', 19:38:00 INFO - 'USER': 'cltbld', 19:38:00 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450840521.788027-651438517', 19:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:00 INFO - '_': '/tools/buildbot/bin/python'} 19:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:38:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:38:00 INFO - Running setup.py (path:/tmp/pip-pVMA81-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:38:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:38:00 INFO - Running setup.py (path:/tmp/pip-mXbrAI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:38:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:38:00 INFO - Running setup.py (path:/tmp/pip-Oj3wD0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:38:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:38:00 INFO - Running setup.py (path:/tmp/pip-LQgkrF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:38:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:38:00 INFO - Running setup.py (path:/tmp/pip-Zs1qVO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:38:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:38:00 INFO - Running setup.py (path:/tmp/pip-dZsDKj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:38:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:38:00 INFO - Running setup.py (path:/tmp/pip-6Cck6f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:38:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:38:01 INFO - Running setup.py (path:/tmp/pip-yw6k98-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:38:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:38:01 INFO - Running setup.py (path:/tmp/pip-DjLF2k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:38:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:38:01 INFO - Running setup.py (path:/tmp/pip-Cu7V66-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:38:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:38:01 INFO - Running setup.py (path:/tmp/pip-oGJvWm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:38:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:38:01 INFO - Running setup.py (path:/tmp/pip-eTAdKS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:38:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:38:01 INFO - Running setup.py (path:/tmp/pip-EMVmfn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:38:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:38:01 INFO - Running setup.py (path:/tmp/pip-DifW6F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:38:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:38:01 INFO - Running setup.py (path:/tmp/pip-OkwA2m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:38:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:38:01 INFO - Running setup.py (path:/tmp/pip-tLIRzV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:38:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:38:01 INFO - Running setup.py (path:/tmp/pip-GgalON-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:38:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:38:01 INFO - Running setup.py install for manifestparser 19:38:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:38:01 INFO - Running setup.py install for mozcrash 19:38:01 INFO - Running setup.py install for mozdebug 19:38:02 INFO - Running setup.py install for mozdevice 19:38:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:38:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:38:02 INFO - Running setup.py install for mozfile 19:38:02 INFO - Running setup.py install for mozhttpd 19:38:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:38:02 INFO - Running setup.py install for mozinfo 19:38:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:38:02 INFO - Running setup.py install for mozInstall 19:38:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:38:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:38:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:38:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:38:02 INFO - Running setup.py install for mozleak 19:38:02 INFO - Running setup.py install for mozlog 19:38:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:38:02 INFO - Running setup.py install for moznetwork 19:38:02 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:38:02 INFO - Running setup.py install for mozprocess 19:38:02 INFO - Running setup.py install for mozprofile 19:38:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:38:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:38:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:38:03 INFO - Running setup.py install for mozrunner 19:38:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:38:03 INFO - Running setup.py install for mozscreenshot 19:38:03 INFO - Running setup.py install for moztest 19:38:03 INFO - Running setup.py install for mozversion 19:38:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:38:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:38:03 INFO - Cleaning up... 19:38:03 INFO - Return code: 0 19:38:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:38:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:38:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38:03 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 0x7fc4dcc82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2506850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25053f0>, '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 0x2597560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2597a10>, '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': '0cff312cb257a7829adc5a5d000001df-1450840521.788027-651438517', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:38:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 19:38:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:38:03 INFO - Using env: {'DISPLAY': ':0', 19:38:03 INFO - 'HOME': '/home/cltbld', 19:38:03 INFO - 'LANG': 'en_US.UTF-8', 19:38:03 INFO - 'LANGUAGE': 'en_US:en', 19:38:03 INFO - 'LOGNAME': 'cltbld', 19:38:03 INFO - 'MAIL': '/var/mail/cltbld', 19:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:03 INFO - 'MOZ_NO_REMOTE': '1', 19:38:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:38:03 INFO - 'NO_EM_RESTART': '1', 19:38:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:38:03 INFO - 'PWD': '/builds/slave/test-pgo', 19:38:03 INFO - 'SHELL': '/bin/bash', 19:38:03 INFO - 'SHLVL': '1', 19:38:03 INFO - 'TERM': 'linux', 19:38:03 INFO - 'TMOUT': '86400', 19:38:03 INFO - 'USER': 'cltbld', 19:38:03 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450840521.788027-651438517', 19:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:03 INFO - '_': '/tools/buildbot/bin/python'} 19:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:38:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:38:03 INFO - Running setup.py (path:/tmp/pip-O_ELok-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 19:38:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:38:03 INFO - Running setup.py (path:/tmp/pip-UKu5Xq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:38:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:38:03 INFO - Running setup.py (path:/tmp/pip-qZfRZx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 19:38:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:38:03 INFO - Running setup.py (path:/tmp/pip-N6XYST-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:38:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:38:04 INFO - Running setup.py (path:/tmp/pip-yOc5L3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 19:38:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:38:04 INFO - Running setup.py (path:/tmp/pip-RphspU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 19:38:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:38:04 INFO - Running setup.py (path:/tmp/pip-1DGBPk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 19:38:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:38:04 INFO - Running setup.py (path:/tmp/pip-qQhxOp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 19:38:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:38:04 INFO - Running setup.py (path:/tmp/pip-pKx355-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 19:38:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:38:04 INFO - Running setup.py (path:/tmp/pip-Pgrr2E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:38:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:38:04 INFO - Running setup.py (path:/tmp/pip-fHUmju-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 19:38:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:38:04 INFO - Running setup.py (path:/tmp/pip-lAKKgQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 19:38:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:38:04 INFO - Running setup.py (path:/tmp/pip-n4K0D8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 19:38:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:38:04 INFO - Running setup.py (path:/tmp/pip-IkT8gK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 19:38:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:38:04 INFO - Running setup.py (path:/tmp/pip-fNOYDf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 19:38:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:38:04 INFO - Running setup.py (path:/tmp/pip-ZzUXIj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 19:38:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:38:04 INFO - Running setup.py (path:/tmp/pip-wIE2QO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 19:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 19:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:38:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:38:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:38:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:38:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:38:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:38:06 INFO - Downloading blessings-1.5.1.tar.gz 19:38:06 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 19:38:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:38:06 INFO - Installing collected packages: blessings 19:38:06 INFO - Running setup.py install for blessings 19:38:06 INFO - Successfully installed blessings 19:38:06 INFO - Cleaning up... 19:38:06 INFO - Return code: 0 19:38:06 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:38:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:38:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:38:07 INFO - Reading from file tmpfile_stdout 19:38:07 INFO - Current package versions: 19:38:07 INFO - argparse == 1.2.1 19:38:07 INFO - blessings == 1.5.1 19:38:07 INFO - blobuploader == 1.2.4 19:38:07 INFO - docopt == 0.6.1 19:38:07 INFO - manifestparser == 1.1 19:38:07 INFO - mozInstall == 1.12 19:38:07 INFO - mozcrash == 0.16 19:38:07 INFO - mozdebug == 0.1 19:38:07 INFO - mozdevice == 0.47 19:38:07 INFO - mozfile == 1.2 19:38:07 INFO - mozhttpd == 0.7 19:38:07 INFO - mozinfo == 0.9 19:38:07 INFO - mozleak == 0.1 19:38:07 INFO - mozlog == 3.1 19:38:07 INFO - moznetwork == 0.27 19:38:07 INFO - mozprocess == 0.22 19:38:07 INFO - mozprofile == 0.28 19:38:07 INFO - mozrunner == 6.11 19:38:07 INFO - mozscreenshot == 0.1 19:38:07 INFO - mozsystemmonitor == 0.0 19:38:07 INFO - moztest == 0.7 19:38:07 INFO - mozversion == 1.4 19:38:07 INFO - psutil == 3.1.1 19:38:07 INFO - requests == 1.2.3 19:38:07 INFO - wsgiref == 0.1.2 19:38:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:38:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:38:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:38:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fc4dcc82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2506850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25053f0>, '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 0x2597560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2597a10>, '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': '0cff312cb257a7829adc5a5d000001df-1450840521.788027-651438517', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:38:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 19:38:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:38:07 INFO - Using env: {'DISPLAY': ':0', 19:38:07 INFO - 'HOME': '/home/cltbld', 19:38:07 INFO - 'LANG': 'en_US.UTF-8', 19:38:07 INFO - 'LANGUAGE': 'en_US:en', 19:38:07 INFO - 'LOGNAME': 'cltbld', 19:38:07 INFO - 'MAIL': '/var/mail/cltbld', 19:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:07 INFO - 'MOZ_NO_REMOTE': '1', 19:38:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:38:07 INFO - 'NO_EM_RESTART': '1', 19:38:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:38:07 INFO - 'PWD': '/builds/slave/test-pgo', 19:38:07 INFO - 'SHELL': '/bin/bash', 19:38:07 INFO - 'SHLVL': '1', 19:38:07 INFO - 'TERM': 'linux', 19:38:07 INFO - 'TMOUT': '86400', 19:38:07 INFO - 'USER': 'cltbld', 19:38:07 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450840521.788027-651438517', 19:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:07 INFO - '_': '/tools/buildbot/bin/python'} 19:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 19:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 19:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 19:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 19:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 19:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 19:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 19:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 19:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:38:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 19:38:07 INFO - Cleaning up... 19:38:07 INFO - Return code: 0 19:38:07 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:38:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:38:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:38:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4dcc82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2506850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25053f0>, '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 0x2597560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2597a10>, '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': '0cff312cb257a7829adc5a5d000001df-1450840521.788027-651438517', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:38:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 19:38:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:38:07 INFO - Using env: {'DISPLAY': ':0', 19:38:07 INFO - 'HOME': '/home/cltbld', 19:38:07 INFO - 'LANG': 'en_US.UTF-8', 19:38:07 INFO - 'LANGUAGE': 'en_US:en', 19:38:07 INFO - 'LOGNAME': 'cltbld', 19:38:07 INFO - 'MAIL': '/var/mail/cltbld', 19:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:07 INFO - 'MOZ_NO_REMOTE': '1', 19:38:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:38:07 INFO - 'NO_EM_RESTART': '1', 19:38:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:38:07 INFO - 'PWD': '/builds/slave/test-pgo', 19:38:07 INFO - 'SHELL': '/bin/bash', 19:38:07 INFO - 'SHLVL': '1', 19:38:07 INFO - 'TERM': 'linux', 19:38:07 INFO - 'TMOUT': '86400', 19:38:07 INFO - 'USER': 'cltbld', 19:38:07 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450840521.788027-651438517', 19:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:07 INFO - '_': '/tools/buildbot/bin/python'} 19:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:38:07 INFO - Downloading/unpacking jsonschema 19:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:38:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:38:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:38:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:38:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:38:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:38:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 19:38:09 INFO - Downloading/unpacking functools32 (from jsonschema) 19:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:38:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:38:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:38:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:38:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:38:09 INFO - Downloading functools32-3.2.3-2.tar.gz 19:38:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:38:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:38:09 INFO - warning: no files found matching '*.txt' 19:38:09 INFO - no previously-included directories found matching 'build' 19:38:09 INFO - no previously-included directories found matching 'dist' 19:38:09 INFO - no previously-included directories found matching '.git*' 19:38:09 INFO - Installing collected packages: jsonschema, functools32 19:38:09 INFO - Running setup.py install for functools32 19:38:09 INFO - warning: no files found matching '*.txt' 19:38:09 INFO - no previously-included directories found matching 'build' 19:38:09 INFO - no previously-included directories found matching 'dist' 19:38:09 INFO - no previously-included directories found matching '.git*' 19:38:09 INFO - Successfully installed jsonschema functools32 19:38:09 INFO - Cleaning up... 19:38:09 INFO - Return code: 0 19:38:09 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:38: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')]} 19:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:38:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38: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')]} 19:38:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:38:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:38:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc4dcc82f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2506850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25053f0>, '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 0x2597560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2597a10>, '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': '0cff312cb257a7829adc5a5d000001df-1450840521.788027-651438517', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:38:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 19:38:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:38:09 INFO - Using env: {'DISPLAY': ':0', 19:38:09 INFO - 'HOME': '/home/cltbld', 19:38:09 INFO - 'LANG': 'en_US.UTF-8', 19:38:09 INFO - 'LANGUAGE': 'en_US:en', 19:38:09 INFO - 'LOGNAME': 'cltbld', 19:38:09 INFO - 'MAIL': '/var/mail/cltbld', 19:38:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:09 INFO - 'MOZ_NO_REMOTE': '1', 19:38:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:38:09 INFO - 'NO_EM_RESTART': '1', 19:38:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:38:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:38:09 INFO - 'PWD': '/builds/slave/test-pgo', 19:38:09 INFO - 'SHELL': '/bin/bash', 19:38:09 INFO - 'SHLVL': '1', 19:38:09 INFO - 'TERM': 'linux', 19:38:09 INFO - 'TMOUT': '86400', 19:38:09 INFO - 'USER': 'cltbld', 19:38:09 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450840521.788027-651438517', 19:38:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:09 INFO - '_': '/tools/buildbot/bin/python'} 19:38:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:38:09 INFO - Downloading/unpacking flake8 19:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:38:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:38:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:38:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:38:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:38:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:38:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 19:38:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:38:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:38:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:38:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:38:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:38:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:38:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 19:38:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:38:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:38:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:38:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:38:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:38:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 19:38:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:38:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:38:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:38:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:38:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:38:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:38:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:38:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:38:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:38:12 INFO - no previously-included directories found matching 'docs/_build' 19:38:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:38:12 INFO - Running setup.py install for pep8 19:38:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:38:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:38:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:38:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:38:12 INFO - no previously-included directories found matching 'docs/_build' 19:38:12 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:38:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:38:12 INFO - Cleaning up... 19:38:12 INFO - Return code: 0 19:38:12 INFO - Running post-action listener: _resource_record_post_action 19:38:12 INFO - Running post-action listener: _start_resource_monitoring 19:38:12 INFO - Starting resource monitoring. 19:38:12 INFO - ##### 19:38:12 INFO - ##### Running install step. 19:38:12 INFO - ##### 19:38:12 INFO - Running pre-action listener: _resource_record_pre_action 19:38:12 INFO - Running main action method: install 19:38:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:38:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:38:12 INFO - Reading from file tmpfile_stdout 19:38:12 INFO - Detecting whether we're running mozinstall >=1.0... 19:38:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:38:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:38:12 INFO - Reading from file tmpfile_stdout 19:38:12 INFO - Output received: 19:38:12 INFO - Usage: mozinstall [options] installer 19:38:12 INFO - Options: 19:38:12 INFO - -h, --help show this help message and exit 19:38:12 INFO - -d DEST, --destination=DEST 19:38:12 INFO - Directory to install application into. [default: 19:38:12 INFO - "/builds/slave/test-pgo"] 19:38:12 INFO - --app=APP Application being installed. [default: firefox] 19:38:12 INFO - mkdir: /builds/slave/test-pgo/build/application 19:38:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 19:38:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 19:38:28 INFO - Reading from file tmpfile_stdout 19:38:28 INFO - Output received: 19:38:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:38:28 INFO - Running post-action listener: _resource_record_post_action 19:38:28 INFO - ##### 19:38:28 INFO - ##### Running run-tests step. 19:38:28 INFO - ##### 19:38:28 INFO - Running pre-action listener: _resource_record_pre_action 19:38:28 INFO - Running main action method: run_tests 19:38:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:38:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:38:28 INFO - Python 2.7.3 19:38:28 INFO - Return code: 0 19:38:28 INFO - grabbing minidump binary from tooltool 19:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:38:28 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 0x25053f0>, '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 0x2597560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2597a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:38:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 19:38:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:38:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:38:28 INFO - Return code: 0 19:38:28 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:38:28 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:38:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:38:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:38:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:38:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:38:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:38:29 INFO - Return code: 0 19:38:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 19:38:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 19:38:29 INFO - Using env: {'DISPLAY': ':0', 19:38:29 INFO - 'HOME': '/home/cltbld', 19:38:29 INFO - 'LANG': 'en_US.UTF-8', 19:38:29 INFO - 'LANGUAGE': 'en_US:en', 19:38:29 INFO - 'LOGNAME': 'cltbld', 19:38:29 INFO - 'MAIL': '/var/mail/cltbld', 19:38:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:38:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:38:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:38:29 INFO - 'MOZ_NO_REMOTE': '1', 19:38:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:38:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:38:29 INFO - 'NO_EM_RESTART': '1', 19:38:29 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:38:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:38:29 INFO - 'PWD': '/builds/slave/test-pgo', 19:38:29 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:38:29 INFO - 'SHELL': '/bin/bash', 19:38:29 INFO - 'SHLVL': '1', 19:38:29 INFO - 'TERM': 'linux', 19:38:29 INFO - 'TMOUT': '86400', 19:38:29 INFO - 'USER': 'cltbld', 19:38:29 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450840521.788027-651438517', 19:38:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:38:29 INFO - '_': '/tools/buildbot/bin/python'} 19:38:29 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 19:38:29 INFO - mozversion application_buildid: 20151222173012 19:38:29 INFO - mozversion application_changeset: acd00bf58a21e3783805c015c37b92731e5797f2 19:38:29 INFO - mozversion application_display_name: Nightly 19:38:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:38:29 INFO - mozversion application_name: Firefox 19:38:29 INFO - mozversion application_remotingname: firefox 19:38:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 19:38:29 INFO - mozversion application_vendor: Mozilla 19:38:29 INFO - mozversion application_version: 46.0a1 19:38:29 INFO - mozversion platform_buildid: 20151222173012 19:38:29 INFO - mozversion platform_changeset: acd00bf58a21e3783805c015c37b92731e5797f2 19:38:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 19:38:29 INFO - mozversion platform_version: 46.0a1 19:38:29 INFO - using testdate: 1450841909 19:38:29 INFO - actual date: 1450841909 19:38:30 INFO - starting webserver on 'localhost:47637' 19:38:30 INFO - SUITE-START | Running 3 tests 19:38:30 INFO - TEST-START | dromaeo_css 19:38:30 INFO - operating with platform_type : linux_ 19:38:30 INFO - Initialising browser for dromaeo_css test... 19:38:30 INFO - TEST-INFO | started process 3410 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUWSpvO/profile http://localhost:47637/getInfo.html) 19:38:37 INFO - PROCESS | 3410 | __metrics Screen width/height:1600/1200 19:38:37 INFO - PROCESS | 3410 | colorDepth:24 19:38:37 INFO - PROCESS | 3410 | Browser inner width/height: 1024/697 19:38:37 INFO - PROCESS | 3410 | __metrics 19:38:37 INFO - PROCESS | 3410 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:38:37 INFO - PROCESS | 3410 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:38:37 ERROR - PROCESS | 3410 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 19:38:38 INFO - TEST-INFO | 3410: exit 0 19:38:38 INFO - Browser initialized. 19:38:38 INFO - Running cycle 1/1 for dromaeo_css test... 19:38:38 INFO - TEST-INFO | started process 3508 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUWSpvO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:38:50 INFO - PROCESS | 3508 | RSS: Main: 150491136 19:38:50 INFO - PROCESS | 3508 | 19:39:41 INFO - PROCESS | 3508 | 1450841981622 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:41:50 INFO - PROCESS | 3508 | Cycle 1(1): loaded http://localhost:47637/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47637/tests/dromaeo/cssquery-ext.html) 19:41:51 INFO - PROCESS | 3508 | RSS: Main: 272429056 19:41:51 INFO - PROCESS | 3508 | 19:44:54 INFO - PROCESS | 3508 | Cycle 1(1): loaded http://localhost:47637/tests/dromaeo/cssquery-ext.html (next: http://localhost:47637/tests/dromaeo/cssquery-jquery.html) 19:44:54 INFO - PROCESS | 3508 | RSS: Main: 232157184 19:44:54 INFO - PROCESS | 3508 | 19:47:56 INFO - PROCESS | 3508 | Cycle 1(1): loaded http://localhost:47637/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47637/tests/dromaeo/cssquery-mootools.html) 19:47:57 INFO - PROCESS | 3508 | RSS: Main: 218537984 19:47:57 INFO - PROCESS | 3508 | 19:50:59 INFO - PROCESS | 3508 | Cycle 1(1): loaded http://localhost:47637/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47637/tests/dromaeo/cssquery-prototype.html) 19:50:59 INFO - PROCESS | 3508 | RSS: Main: 208670720 19:50:59 INFO - PROCESS | 3508 | 19:54:02 INFO - PROCESS | 3508 | Cycle 1(1): loaded http://localhost:47637/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47637/tests/dromaeo/cssquery-yui.html) 19:54:02 INFO - PROCESS | 3508 | RSS: Main: 214503424 19:54:02 INFO - PROCESS | 3508 | 19:57:05 INFO - PROCESS | 3508 | Cycle 1(1): loaded http://localhost:47637/tests/dromaeo/cssquery-yui.html (next: http://localhost:47637/tests/dromaeo/cssquery-dojo.html) 19:57:05 INFO - PROCESS | 3508 | RSS: Main: 262889472 19:57:05 INFO - PROCESS | 3508 | 19:57:05 INFO - PROCESS | 3508 | __start_tp_report 19:57:05 INFO - PROCESS | 3508 | _x_x_mozilla_page_load 19:57:05 INFO - PROCESS | 3508 | _x_x_mozilla_page_load_details 19:57:05 INFO - PROCESS | 3508 | |i|pagename|runs| 19:57:05 INFO - PROCESS | 3508 | |0;dojo.html;3174.1588479053057;3225.951610725841;3255.641879393266;3258.348330333934;3281.7210537104347;5161.380634323887;5275.709835959021;5423.240746295522;5492.588055895804;5497.862553436166;5343.519083282504;5375.139977603584;5378.946210537903;5458.1266997280345;5498.202760599711;4865.635077369194;4881.707097574139;4887.584555312794;4942.604591632678;5053.115704751672;4911.336969509124;5041;5057.988402319533;5086.898262034757;5124.4106927703415;4918.877028074309;4955.752212389384;4987.177115775893;4998.600111991032;5015.774290156952;4930.926036109461;4933.802647894116;4945.455999840015;4986.301917731521;4990.675606085593;4835.540623640749;4942.654014219006;4944.554990050877;4947.480514545993;4962.925556116661;5131.358580177478;5157.664751791159;5175.792968281265;5188.8183913563225;5216.295800067019;5848.941510584882;5854.648721076749;5862.589618726691;5862.882742345172;5864.53083753303;5749.137629355589;5806.1000544915605;5885.293764748215;5888.970555147197;5890.322612899528;5364.168553874156;5376.327959005124;5502.972485137549;5506.724663766836;5508.476694713996;5880.088586269135;5909.674967876808;5909.793157239476;5912.822615321547;5922.8815423691285;5723.7996670116345;5736.569757268222;5737.799177028867;5744.080947048452;5775.16260142277;5728.427157284322;5734.369219385864;5854.648721076749;5861.70691465425;5926.377730338339;5851.912221316684;5908.763649453974;5911.172435858984;5946.791862284799;5952.166696662471;5876.324222714443;5903.0555111182;5912.497437717756;5913.438223368773;5919.822405327847;4402.3836662867225;4421.602055814992;4447.266201076851;4449.1546606145375;4507.684462087688;4003.978985358715;4006.5192176938954;4012.3179059559943;4017.357222844331;4042.231975924624;5518.613697041169;5529.972350138223;5532.695701736363;5535.197396377503;5566;5643.40744221859;5769;5800.216970708984;5802.593818432669;5848.766049357978;5448.046591846411;5464.535514481234;5485.890282194334;5491.258680078218;5512.4211957744665;5113.9744301279;5115.693058416507;5116.56509196715;5125.79496820123;5171.63798534099;5855.619384740064;5888.882222355614;5974.761009559569;6024.57827952048;6032.849178770478;5803.506701930214;5883.264591926009;5889.587728858939;5890.617109887844;5901.085331773582;5948.851278718067;5949.762009519571;5950.880982380415;5954.553408494294;5966.642001479925;5564.972175139098;5662.065759149859;5662.065759149859;5738.397468265939;5799.76800927975;5818.534517238695;5884.7940322088525;5890.941090589039;5892.705364731832;5894.528437725057;5595.048841697003;5696.743646535999;5727.513161381329;5732.512736417451;5737.311522617146;5532.972335138459;5585.301837270341;5649.548036157015;5689.516391106637;5703.657780533182;5569.55443564522;5621.7189140542;5621.887562248814;5635.6618602883955;5677.063284558001;5728.856778580569;5787.958167529717;5790.131480277992;5793.507551858139;5850.327212370632;5466.371367292653;5553.278073850373;5556.888862222652;5702.37273899879;5725.312962444534 19:57:05 INFO - PROCESS | 3508 | |1;ext.html;558.9217509548664;604.9425304596065;607.6384551192041;609.8963176260036;610.2768219659704;29358;30136.39727205457;38412.807935960314;38927.026824329405;38959.22081558367;42249;42735.3589696154;42836.78581607095;42842.7857860711;42860;7486.962565187167;7605.695772169107;8710.12898710127;8882.15619516145;8886.644534218656;10407.115395191418;10678.145748340154;10680.946595267013;10684.51919663617;10692.411917344543;10376.273660843744;10443;10459.895401045967;10464.4767761612;10469.581216751321;7660.885086723676;7820.296173344369;7830.882536761953;10255.743606409862;10470.42412667303;10230.925752795998;10243.539040743184;10304.690859274233;10340.069393754524;10377.896221037769;39622;40037.19925601501;40123.595674151264;40141;40186.18231268025;3039;3051.938961220785;3319.9834000830083;3472.8437220324895;3541.486484459739;29986.700132998827;30251.394972100654;30310.393792124254;30733.231669208224;31358.686413135805;3943.2310699413624;3947.1118998225456;3980.900477488086;3990.68074554035;4035;267139;268976;269186.65406673035;269673;269792;55392.446075538726;56234.43765562374;58350.70824645935;58767.11849322264;58815;67373;68189;68514;68519;68554.65722671355;12843.614691559269;12977.35113244334;12980.805287920688;13047.282399467931;13089.541866034642;9950.950245248727;10087.344322619007;10094.343867648578;10095;10103;19688.90155549242;19890.90600017013;20061;20068.297609583595;20145.59708805845;7183.209846916835;7331.670074846645;7336.082989626297;7456.552606843607;7494.550326980289;833.3374966901328;969.060011788564;1008.8436292374694;1027.4688623171926;1083.00363665428;28380.432391352057;28424.857875710488;29881.517772334322;30493.390132197233;31109.8444507776;992.5384696116196;998.4658207858761;1016.6594190945968;1058.9093233969024;1098.2367254758026;13513.121647092907;13527;13796.517121900686;13826.30868456573;13855.653608659864;303256;308975;308981;310507.0543651082;310679.3786652414;50861.23708144381;51097.48902510927;51109;51149.23276150861;51227.48772512227;1237.10928131745;1237.7029512917015;1243.6269119264184;1266.9049821263443;1309.6267563744286;24530.63204051905;25596.8720156398;28204;30066.24834379158;31179.37641247117;47580;47863.28205076857;47949.760251199914;47991.52008479871;48023.279650804565;242635;244743;244965;245342;273853.1376234785;25621.3594660135;31753;32084.67915320817;32116.518252225767;32508.837455813515;37134.62865371312;37938.8103059483;38021.619783801805;38188.618113818506;38554;32250.677493225707;32481;32676.83661581677;33862.66137338595;35610;34086.31827363389;34733.30533389369;35489.467657984635;35519.82240088783;35567;33728.3254334907;34432.48351274783;34756.47865282073;34770.130746731535;34781.826090869385;29562.260943476584;30967.380652387277;32379;32454.513182301813;32544.83727581347;24484.328957943297;24692.38269043288;24739.25782226464;24806.37984050341;24992.250232493054 19:57:05 INFO - PROCESS | 3508 | |2;jquery.html;356.03336940207333;356.0901895656596;359.46619270383474;360.05844716067486;362.923786004939;13623.93188034061;13812.240326782023;16074.51776446707;16851.41020064298;17925.10374481274;13278.800817987738;13745.106568073068;15520.53438396847;15751.684966300667;16093;5206.531412172894;5451.454854514536;5456.672599644015;5458.9454105459035;5459.754311056012;3976.602339766029;4057.6550993165615;5290.285811415448;5409.783608655669;5413.242146099549;5760.279965004374;5845.5908086433965;5876.471117599415;5896.7051647417675;5903.852403689899;5716.714164291769;5820.447057529528;5835.5915085944;5854.4438278363705;5861.3552509223955;5173.430922598511;5174.534291913746;5178.40448348441;5180.974095129538;5184.403793563713;19860.60278794416;19951.90024049885;20005.49986250341;20030.499237519034;20607.896960515252;2212.070930209316;2236.3626366485473;2463.9137630183036;2470.654108424822;2575.490215516392;12999.675008124777;13021.60935171937;13295.86704132956;13352.132111412728;13395.10324042942;1722.345508706696;1734.6443978984405;1737.9565510862203;1761.4979730776668;1779.5106345754891;59966.70016649932;60682.696586517224;61420.078698819554;61985;62856.37143628551;9531.142197202285;9682.806343873082;9736.513174341255;9772.21822254218;9826.115649591427;12867.099303048884;12874.420651070724;12880.291583962784;12880.742385152245;12897.097203195874;6942.340477654615;6947.930520694829;6961.338672826073;6994;7001.63468123711;6551.508636852255;6598.274189839114;6645.269020407752;6645.700943457556;6645.700943457556;5840.912386314209;5908.847774683982;5919.230500035054;5958.463738263577;5963.2844058713235;1654.9751753723704;1718.1564510734754;1767.3814165042133;1770.9645807084044;1776.0764402510881;903.4940433357209;904.3262769236829;980.7548112971757;997.9850302245472;1035.876074459205;17276.395326163776;17961.7305740414;18100.818991810178;18316.816831831777;18514.259429622663;807.7294106474396;829.5147338806745;875.4222213339166;984.6947446291673;1002.3835341265216;8633;8828.161324674145;8829.218796079214;9185.724428267162;9252.722418327461;530201;536574;546343;548555;554645;79540.99999999884;80144.59927700325;80660.19339806645;80861.19138808655;81156;1148.5750272399098;1149.5401839264362;1194.3908606610516;1195;1203.807390817465;14464.927675361556;14496.130232186102;14577.708445831237;14662.853371466148;14840.480583179537;33622.327553449286;33699.83150084234;33809.15477113092;33949.66050339564;34011;45309;46248.768756156;47808.282875756195;50511.24233136432;51823;9391.342606017513;9412.858807118037;9559.187469065208;9583.616655333708;9657.372270802376;17189.742153867453;17336.479905602853;17487.387941422498;17537.824621753618;17699.557511062325;13791.448342066205;14527;14618.707625847635;14624.415023398944;14795.926020369829;13633.659158521117;14476.276186190858;14476.420943162155;14679.71530249088;15122.319495622503;14961;15087.849121508645;15138.545843624708;15561;15575.922120389325;8215.79460513468;8414.368922330972;9071.228945539702;9200.95399522998;9365.953170234105;14091;14092.506762263272;14136.78794818058;14295;14368 19:57:05 INFO - PROCESS | 3508 | |3;mootools.html;1302.6027061746177;1414.3069895751082;1474.2702362330645;1586.5161125856616;1741.3208848549075;6724.462043036558;7688.3849292056575;7819.178986206452;7835.608219589027;7839.333656639178;7631.1605723370385;7790.3767698584115;7811.92188078119;7813.140554539011;7813.6093195340145;2170.6418440957223;2203.6914831923546;2207.536417352358;2208.1167532986774;2208.9447763805874;2218.1681869299014;2249.6850440938283;2254;2255.210676263311;2255.616545187322;2162.772908844572;2207.812335951446;2210.6462965925457;2230.8661480311152;2234.497238121418;2176.804087632113;2180.5420861618923;2204.4488877780555;2206.2829580386438;2207.558488302338;2222.0445208560313;2245;2246.809021233197;2247;2249.3701763506247;7619.885701714478;7723.7682869514;7727.806804829925;7728.304452599237;7731.0336207974005;4374.475062992461;4460.687751857371;4463.933041004388;4487.39420178275;4496.078303947683;3064.4790385634496;3132.8276944768027;3150.842457877097;3188.0913939527354;3219.8551065201887;989.7331415787803;1023.0332335942537;1046.210111365914;1070.1599244592958;1099.230538622959;10587.364758114538;10597.258191926569;10603.204759643058;10605.045545900828;10617.84073238902;4157.937630935538;4209.20025195218;4210.242156411814;4226.112516371535;4257.765822879772;9049.276057915351;9088.909330880337;9106.817863642822;9108.316876234308;9115.772105697279;4621.514740952219;4623.768811559408;4629.282461218517;4647.16351056813;4654.394928659321;3781.0925377909102;3804.2201348723447;4173.457450531472;4202.579742025834;4239.703220774516;3526.8236588171003;3604.3512167810045;3609.3864043112735;3634.164142247298;3644.799536025491;1126.7577470843808;1127.667338135252;1128.7968165730247;1130.2088538023415;1133.6202372205403;865.9740207793776;874.6020560644891;1076.321917192164;1080.8324709670014;1312.5078095714107;7130.03744494497;7177.318154775392;7185.317394847481;7198.856022879513;7212.170600381023;1074.7957888001254;1084.3764835219781;1095.2497539185524;1101.3502033800096;1127.2954403497813;5601.6358936668985;5624;5629.887402251932;5631.549476041907;5634.549236061105;8929.955350223338;9419.434833909987;9526.714198574055;9532.23742100644;9564.4739539326;9271.768205794775;9362.672306469241;9396.812063758824;9398.765030874147;9435.292353073546;7028.929710702828;7207.279272072856;7208.747693830691;7227.566346019255;7290.744823931243;7426.4058875288765;7480.850382992418;7509.66206520697;7521.05986751656;7532.736354227576;8026.117127116129;8126.390520710852;8181.918180818116;8236.958815205886;8270.421070525006;8398.580070996304;8607.18231767981;8615.267702245379;8626.698065567674;8636.438631489185;6698.799036028927;6763.188417389944;6766.7969960901255;6768.052472653734;6778.457723382019;7367.115946086504;7413.147488038944;7441.255874412732;7441.776746697607;7451.850962980819;6529.836754081186;6839.829004274933;6974.511784175059;7034.402075823407;7116.466265030247;6580.868382632225;6761.256261811099;6783.966080169567;6893.965530172317;6931.514793964374;6610.206775187008;6714.429273511806;6717.966410167918;6739.831504212434;6740.494462915203;6174.722137503913;6187.566870319034;6188.597741146811;6206.10011548332;6208.658523781235;6189.938100618936;6263.96868015657;6284.088807123033;6486.1243732097455;6532.542722009413 19:57:05 INFO - PROCESS | 3508 | |4;prototype.html;339.20625735778276;342.125868406222;346.0604458894102;349.0819145646949;350.3098895176503;5905.586608937376;5955.583109182359;5958.970205148979;5965;5976.8206953791405;5649.519790817775;5696.914546281799;5798.246227990356;5854.736536855841;5876.236089308384;4554.111948170108;4574.245249533839;4583.03756211196;4601.677882548223;4601.930971035429;4394.340848872679;4568.406107206075;4583.770811459431;4585.70192937458;4593.035462552868;4411.558844115579;4475.149721552911;4560.9087818243615;4571.131485017836;4572.702774319675;4528.3660287559605;4548.636109111263;4557.680962332638;4557.977210113928;4563.726176429424;4033.0320723026557;4041.312976793952;4044.130511939947;4049.5545489996075;4053.898652533681;5537.501624853742;5643.097104463266;5654.406287339812;5657.2928383952;5659.7453114609525;5347.973260133714;5350.678959262456;5352.545033672142;5354.544863686591;5355.973220133875;6223.43989040984;6266.154069200645;6270.404311590391;6281.214848143982;6285.151504546873;4476.6418686505;4485.977570112129;4488.169688607585;4488.281874900033;4493.662975276835;6293.559450838443;6478.676066196718;6500.414962653336;6501.642409667466;6539.771108011244;4491.663125265618;4513.277875539898;4515.661325400542;4515.68390212682;4518.186726389215;4536.274196128669;4557.316402539579;4560.498345182027;4562.61217796491;4562.9771851141195;5215.452377500308;5242.816501422432;5244.711540865289;5246.947530524722;5266.3943646480375;6089.786857459968;6271.310155882849;6317.4630156437215;6320.146780184617;6341.873162536724;1581.8497242761919;1583.4299652125226;1592.3471376735483;1596.0822527046994;1597.5127586086355;1061.2253055269696;1080.475969154959;1081.3619964221148;1102.2669924500278;1103.4151899493281;6046.213992181077;6048;6053.939460605426;6055.878882422415;6059.21230240066;6488.059231411419;6498.252700939358;6501.0573466847045;6502.60984340941;6504.414602685686;5866.677332746654;5939.376365481562;6001.459868611759;6086.360932102154;6107.816765497042;3505.9657401066747;3518.964810351915;3521.8415171316838;3525.206828463575;3529.6823285904393;6602.8349291268105;6603.174603174603;6608.768693095719;6612.702428390734;6612.974988876732;6533.705983230766;6648.1025061616065;6705.932940670628;6709.932900671029;6761.966190169018;6624.8012559623285;6658.4673226141795;6660.56706314088;6665.233498147678;6667.799966001027;6562.343765623399;6574.737010519526;6583;6586.341365863375;6599.406053455212;6378.48972082223;6503.837404064936;6506;6506.089147519257;6507.642079685663;6653.2348779889;6653.800385988428;6655.600663960178;6659.866802664016;6661.933380666325;4514.164879497303;4554.339620755039;4560.977195114003;4563.452385713736;4568.223402021597;6483.675816209076;6580.868382632416;6582.11141495911;6593.835154121185;6595.472362210916;6352;6375.171227740364;6387.872242555216;6395.936040639534;6396.264429590657;6360.809175724736;6373.267074286517;6390.105385245976;6397.488200944006;6400.839979000562;6118.326984031664;6271.937280627318;6279.183706118358;6284.780032698834;6290.591111577733;6436.710348034256;6436.806895793134;6437.967810160919;6437.967810160919;6438.420542151041;6269.090981807703;6286.811395658137;6289.622622642473;6293.905591416041;6294.874102518015 19:57:05 INFO - PROCESS | 3508 | |5;yui.html;749.482856828788;760.44107580928;811.1807074854395;840.1817414405244;845.0957475501209;13118.93440532796;13171.934140329296;13220.074594778369;13253.668658283548;13276.867231327697;12187.939060304687;14464.532691217;14507.419703211885;14514.854851451482;14527.20100394478;807.5679511461369;813.9470934389245;821.0147822612859;821.4373154389233;822.2147848804408;678.4470656415006;684.8185230913812;801.1027649033063;808.5876203136384;811.2212276214841;838.4005436113177;842.9873551896726;846.2595229174473;849.6856163219586;850.0054935725217;694.1254019934919;701.6632016632045;845.5814371885925;846.0101681033175;846.5640195299426;614.9108379284978;623.6476390839161;623.847157446424;624.2883113250898;624.3194917539903;13061.151025183333;13136.86863131366;13146.408411621404;13161.60515184546;13173.341332933314;11667.766644667145;11738.329330344;12342.321172335518;12521.373931303398;12626.368681565886;10431.113355364803;10536.104431123364;10601.310914790514;10641.627543035956;10835.241533092687;3574.7318951078514;3627.6916462100753;3662.08447888028;3679.7240206984584;3750.9249815003545;47578.52421475775;47595.286070708964;47606;47637.76181119107;48031.75984120092;9457.858132128023;9874.654387096418;9951.353162044445;10091.444970526545;10506.369617822802;17743.201555930013;17753.378631747826;17772.377966771102;17775;17785.644287114184;7551.395888328921;7595.430342724318;7601.695932162652;7726.459147859596;7774.06711194649;4150.91698166035;4221.345691417835;4237.978810105929;4238.682098842599;4290.785460726951;3051.054173206313;3053.084074777558;3057.8165310081467;3082.5376193570696;3088.907332779975;524.5174439515655;546.4944925943487;556.2323992889867;561.764059095181;562.2409746841731;563.6082922368996;598.5042373303336;600.7236671131328;669.3707914560298;685.4345165238599;8404.453710508797;8753.606087726068;8830.823383532294;8844.115588441233;9003.594838232164;659.8746238214724;660.9306022867626;673.3132205150816;677.3869647968596;686.3822559696313;4033.334499807499;4204.3693445983345;4280.357946308079;4381.16757816014;4427.867163985021;52119;59400;59430.70284648549;59445.108323375185;60178.097328540105;50648.24027639588;53308.73345633247;53333.200002;53524;53947.73026134844;49176;49725.50274497281;53941.1908821368;54371;58750.412495874494;8936.329775267011;9015.14356136166;9046.683366082156;9083.68207112748;9098.226650734761;37545.62454375421;38035.809820950715;38142.42786358151;39060.80469597634;39722.80138599288;46694;46703.53296466992;46978.76510617425;47089.2936605958;48165.27752083792;9958.253131015057;11054.941336862908;11461.598844040418;11491.655250342503;11595.555136457855;11745;12007.75984480288;12366.938165309475;12488.500459981862;12965.805512917124;10866.05595444417;10989.450527473435;11223.775524489627;11241.156913231704;11543.728432070657;11468.079285731983;11734.530618775154;11794.528218871492;11807.645770626896;11854.762904742029;10847.945760271148;11163.441827908735;11270.985611295022;11428;11634.476448560004;9980.700578982642;10017.39895606266;10212.131968782736;10214.744631384276;10555.15558755313;9060.592273347584;9239.127720878638;9730.902690973;10282.126019288444;10393.220508461744 19:57:05 INFO - PROCESS | 3508 | __end_tp_report 19:57:05 INFO - PROCESS | 3508 | __start_cc_report 19:57:05 INFO - PROCESS | 3508 | _x_x_mozilla_cycle_collect,940 19:57:05 INFO - PROCESS | 3508 | __end_cc_report 19:57:05 INFO - PROCESS | 3508 | __startTimestamp1450843025439__endTimestamp 19:57:05 INFO - PROCESS | 3508 | 19:57:05 INFO - PROCESS | 3508 | ------- Summary: start ------- 19:57:05 INFO - PROCESS | 3508 | Number of tests: 6 19:57:05 INFO - PROCESS | 3508 | 19:57:05 INFO - PROCESS | 3508 | [#0] dojo.html Cycles:165 Average:5410.32 Median:5595.05 stddev:600.83 (10.7%) stddev-sans-first:576.50 19:57:05 INFO - PROCESS | 3508 | Values: 3174.2 3226.0 3255.6 3258.3 3281.7 5161.4 5275.7 5423.2 5492.6 5497.9 5343.5 5375.1 5378.9 5458.1 5498.2 4865.6 4881.7 4887.6 4942.6 5053.1 4911.3 5041.0 5058.0 5086.9 5124.4 4918.9 4955.8 4987.2 4998.6 5015.8 4930.9 4933.8 4945.5 4986.3 4990.7 4835.5 4942.7 4944.6 4947.5 4962.9 5131.4 5157.7 5175.8 5188.8 5216.3 5848.9 5854.6 5862.6 5862.9 5864.5 5749.1 5806.1 5885.3 5889.0 5890.3 5364.2 5376.3 5503.0 5506.7 5508.5 5880.1 5909.7 5909.8 5912.8 5922.9 5723.8 5736.6 5737.8 5744.1 5775.2 5728.4 5734.4 5854.6 5861.7 5926.4 5851.9 5908.8 5911.2 5946.8 5952.2 5876.3 5903.1 5912.5 5913.4 5919.8 4402.4 4421.6 4447.3 4449.2 4507.7 4004.0 4006.5 4012.3 4017.4 4042.2 5518.6 5530.0 5532.7 5535.2 5566.0 5643.4 5769.0 5800.2 5802.6 5848.8 5448.0 5464.5 5485.9 5491.3 5512.4 5114.0 5115.7 5116.6 5125.8 5171.6 5855.6 5888.9 5974.8 6024.6 6032.8 5803.5 5883.3 5889.6 5890.6 5901.1 5948.9 5949.8 5950.9 5954.6 5966.6 5565.0 5662.1 5662.1 5738.4 5799.8 5818.5 5884.8 5890.9 5892.7 5894.5 5595.0 5696.7 5727.5 5732.5 5737.3 5533.0 5585.3 5649.5 5689.5 5703.7 5569.6 5621.7 5621.9 5635.7 5677.1 5728.9 5788.0 5790.1 5793.5 5850.3 5466.4 5553.3 5556.9 5702.4 5725.3 19:57:05 INFO - PROCESS | 3508 | 19:57:05 INFO - PROCESS | 3508 | [#1] ext.html Cycles:180 Average:44728.30 Median:32100.60 stddev:72348.26 (225.4%) stddev-sans-first:72475.20 19:57:05 INFO - PROCESS | 3508 | Values: 558.9 604.9 607.6 609.9 610.3 29358.0 30136.4 38412.8 38927.0 38959.2 42249.0 42735.4 42836.8 42842.8 42860.0 7487.0 7605.7 8710.1 8882.2 8886.6 10407.1 10678.1 10680.9 10684.5 10692.4 10376.3 10443.0 10459.9 10464.5 10469.6 7660.9 7820.3 7830.9 10255.7 10470.4 10230.9 10243.5 10304.7 10340.1 10377.9 39622.0 40037.2 40123.6 40141.0 40186.2 3039.0 3051.9 3320.0 3472.8 3541.5 29986.7 30251.4 30310.4 30733.2 31358.7 3943.2 3947.1 3980.9 3990.7 4035.0 267139.0 268976.0 269186.7 269673.0 269792.0 55392.4 56234.4 58350.7 58767.1 58815.0 67373.0 68189.0 68514.0 68519.0 68554.7 12843.6 12977.4 12980.8 13047.3 13089.5 9951.0 10087.3 10094.3 10095.0 10103.0 19688.9 19890.9 20061.0 20068.3 20145.6 7183.2 7331.7 7336.1 7456.6 7494.6 833.3 969.1 1008.8 1027.5 1083.0 28380.4 28424.9 29881.5 30493.4 31109.8 992.5 998.5 1016.7 1058.9 1098.2 13513.1 13527.0 13796.5 13826.3 13855.7 303256.0 308975.0 308981.0 310507.1 310679.4 50861.2 51097.5 51109.0 51149.2 51227.5 1237.1 1237.7 1243.6 1266.9 1309.6 24530.6 25596.9 28204.0 30066.2 31179.4 47580.0 47863.3 47949.8 47991.5 48023.3 242635.0 244743.0 244965.0 245342.0 273853.1 25621.4 31753.0 32084.7 32116.5 32508.8 37134.6 37938.8 38021.6 38188.6 38554.0 32250.7 32481.0 32676.8 33862.7 35610.0 34086.3 34733.3 35489.5 35519.8 35567.0 33728.3 34432.5 34756.5 34770.1 34781.8 29562.3 30967.4 32379.0 32454.5 32544.8 24484.3 24692.4 24739.3 24806.4 24992.3 19:57:05 INFO - PROCESS | 3508 | 19:57:05 INFO - PROCESS | 3508 | [#2] jquery.html Cycles:180 Average:29038.92 Median:361.49 stddev:88773.83 (24557.7%) stddev-sans-first:88996.74 19:57:05 INFO - PROCESS | 3508 | Values: 356.0 356.1 359.5 360.1 362.9 13623.9 13812.2 16074.5 16851.4 17925.1 13278.8 13745.1 15520.5 15751.7 16093.0 5206.5 5451.5 5456.7 5458.9 5459.8 3976.6 4057.7 5290.3 5409.8 5413.2 5760.3 5845.6 5876.5 5896.7 5903.9 5716.7 5820.4 5835.6 5854.4 5861.4 5173.4 5174.5 5178.4 5181.0 5184.4 19860.6 19951.9 20005.5 20030.5 20607.9 2212.1 2236.4 2463.9 2470.7 2575.5 12999.7 13021.6 13295.9 13352.1 13395.1 1722.3 1734.6 1738.0 1761.5 1779.5 59966.7 60682.7 61420.1 61985.0 62856.4 9531.1 9682.8 9736.5 9772.2 9826.1 12867.1 12874.4 12880.3 12880.7 12897.1 6942.3 6947.9 6961.3 6994.0 7001.6 6551.5 6598.3 6645.3 6645.7 6645.7 5840.9 5908.8 5919.2 5958.5 5963.3 1655.0 1718.2 1767.4 1771.0 1776.1 903.5 904.3 980.8 998.0 1035.9 17276.4 17961.7 18100.8 18316.8 18514.3 807.7 829.5 875.4 984.7 1002.4 8633.0 8828.2 8829.2 9185.7 9252.7 530201.0 536574.0 546343.0 548555.0 554645.0 79541.0 80144.6 80660.2 80861.2 81156.0 1148.6 1149.5 1194.4 1195.0 1203.8 14464.9 14496.1 14577.7 14662.9 14840.5 33622.3 33699.8 33809.2 33949.7 34011.0 45309.0 46248.8 47808.3 50511.2 51823.0 9391.3 9412.9 9559.2 9583.6 9657.4 17189.7 17336.5 17487.4 17537.8 17699.6 13791.4 14527.0 14618.7 14624.4 14795.9 13633.7 14476.3 14476.4 14679.7 15122.3 14961.0 15087.8 15138.5 15561.0 15575.9 8215.8 8414.4 9071.2 9201.0 9366.0 14091.0 14092.5 14136.8 14295.0 14368.0 19:57:05 INFO - PROCESS | 3508 | 19:57:05 INFO - PROCESS | 3508 | [#3] mootools.html Cycles:180 Average:5385.73 Median:6198.02 stddev:2816.77 (45.4%) stddev-sans-first:2807.94 19:57:05 INFO - PROCESS | 3508 | Values: 1302.6 1414.3 1474.3 1586.5 1741.3 6724.5 7688.4 7819.2 7835.6 7839.3 7631.2 7790.4 7811.9 7813.1 7813.6 2170.6 2203.7 2207.5 2208.1 2208.9 2218.2 2249.7 2254.0 2255.2 2255.6 2162.8 2207.8 2210.6 2230.9 2234.5 2176.8 2180.5 2204.4 2206.3 2207.6 2222.0 2245.0 2246.8 2247.0 2249.4 7619.9 7723.8 7727.8 7728.3 7731.0 4374.5 4460.7 4463.9 4487.4 4496.1 3064.5 3132.8 3150.8 3188.1 3219.9 989.7 1023.0 1046.2 1070.2 1099.2 10587.4 10597.3 10603.2 10605.0 10617.8 4157.9 4209.2 4210.2 4226.1 4257.8 9049.3 9088.9 9106.8 9108.3 9115.8 4621.5 4623.8 4629.3 4647.2 4654.4 3781.1 3804.2 4173.5 4202.6 4239.7 3526.8 3604.4 3609.4 3634.2 3644.8 1126.8 1127.7 1128.8 1130.2 1133.6 866.0 874.6 1076.3 1080.8 1312.5 7130.0 7177.3 7185.3 7198.9 7212.2 1074.8 1084.4 1095.2 1101.4 1127.3 5601.6 5624.0 5629.9 5631.5 5634.5 8930.0 9419.4 9526.7 9532.2 9564.5 9271.8 9362.7 9396.8 9398.8 9435.3 7028.9 7207.3 7208.7 7227.6 7290.7 7426.4 7480.9 7509.7 7521.1 7532.7 8026.1 8126.4 8181.9 8237.0 8270.4 8398.6 8607.2 8615.3 8626.7 8636.4 6698.8 6763.2 6766.8 6768.1 6778.5 7367.1 7413.1 7441.3 7441.8 7451.9 6529.8 6839.8 6974.5 7034.4 7116.5 6580.9 6761.3 6784.0 6894.0 6931.5 6610.2 6714.4 6718.0 6739.8 6740.5 6174.7 6187.6 6188.6 6206.1 6208.7 6189.9 6264.0 6284.1 6486.1 6532.5 19:57:05 INFO - PROCESS | 3508 | 19:57:05 INFO - PROCESS | 3508 | [#4] prototype.html Cycles:180 Average:5287.54 Median:5970.91 stddev:1580.54 (26.5%) stddev-sans-first:1540.72 19:57:05 INFO - PROCESS | 3508 | Values: 339.2 342.1 346.1 349.1 350.3 5905.6 5955.6 5959.0 5965.0 5976.8 5649.5 5696.9 5798.2 5854.7 5876.2 4554.1 4574.2 4583.0 4601.7 4601.9 4394.3 4568.4 4583.8 4585.7 4593.0 4411.6 4475.1 4560.9 4571.1 4572.7 4528.4 4548.6 4557.7 4558.0 4563.7 4033.0 4041.3 4044.1 4049.6 4053.9 5537.5 5643.1 5654.4 5657.3 5659.7 5348.0 5350.7 5352.5 5354.5 5356.0 6223.4 6266.2 6270.4 6281.2 6285.2 4476.6 4486.0 4488.2 4488.3 4493.7 6293.6 6478.7 6500.4 6501.6 6539.8 4491.7 4513.3 4515.7 4515.7 4518.2 4536.3 4557.3 4560.5 4562.6 4563.0 5215.5 5242.8 5244.7 5246.9 5266.4 6089.8 6271.3 6317.5 6320.1 6341.9 1581.8 1583.4 1592.3 1596.1 1597.5 1061.2 1080.5 1081.4 1102.3 1103.4 6046.2 6048.0 6053.9 6055.9 6059.2 6488.1 6498.3 6501.1 6502.6 6504.4 5866.7 5939.4 6001.5 6086.4 6107.8 3506.0 3519.0 3521.8 3525.2 3529.7 6602.8 6603.2 6608.8 6612.7 6613.0 6533.7 6648.1 6705.9 6709.9 6762.0 6624.8 6658.5 6660.6 6665.2 6667.8 6562.3 6574.7 6583.0 6586.3 6599.4 6378.5 6503.8 6506.0 6506.1 6507.6 6653.2 6653.8 6655.6 6659.9 6661.9 4514.2 4554.3 4561.0 4563.5 4568.2 6483.7 6580.9 6582.1 6593.8 6595.5 6352.0 6375.2 6387.9 6395.9 6396.3 6360.8 6373.3 6390.1 6397.5 6400.8 6118.3 6271.9 6279.2 6284.8 6290.6 6436.7 6436.8 6438.0 6438.0 6438.4 6269.1 6286.8 6289.6 6293.9 6294.9 19:57:05 INFO - PROCESS | 3508 | 19:57:05 INFO - PROCESS | 3508 | [#5] yui.html Cycles:180 Average:14254.94 Median:47333.91 stddev:16765.80 (35.4%) stddev-sans-first:16782.16 19:57:05 INFO - PROCESS | 3508 | Values: 749.5 760.4 811.2 840.2 845.1 13118.9 13171.9 13220.1 13253.7 13276.9 12187.9 14464.5 14507.4 14514.9 14527.2 807.6 813.9 821.0 821.4 822.2 678.4 684.8 801.1 808.6 811.2 838.4 843.0 846.3 849.7 850.0 694.1 701.7 845.6 846.0 846.6 614.9 623.6 623.8 624.3 624.3 13061.2 13136.9 13146.4 13161.6 13173.3 11667.8 11738.3 12342.3 12521.4 12626.4 10431.1 10536.1 10601.3 10641.6 10835.2 3574.7 3627.7 3662.1 3679.7 3750.9 47578.5 47595.3 47606.0 47637.8 48031.8 9457.9 9874.7 9951.4 10091.4 10506.4 17743.2 17753.4 17772.4 17775.0 17785.6 7551.4 7595.4 7601.7 7726.5 7774.1 4150.9 4221.3 4238.0 4238.7 4290.8 3051.1 3053.1 3057.8 3082.5 3088.9 524.5 546.5 556.2 561.8 562.2 563.6 598.5 600.7 669.4 685.4 8404.5 8753.6 8830.8 8844.1 9003.6 659.9 660.9 673.3 677.4 686.4 4033.3 4204.4 4280.4 4381.2 4427.9 52119.0 59400.0 59430.7 59445.1 60178.1 50648.2 53308.7 53333.2 53524.0 53947.7 49176.0 49725.5 53941.2 54371.0 58750.4 8936.3 9015.1 9046.7 9083.7 9098.2 37545.6 38035.8 38142.4 39060.8 39722.8 46694.0 46703.5 46978.8 47089.3 48165.3 9958.3 11054.9 11461.6 11491.7 11595.6 11745.0 12007.8 12366.9 12488.5 12965.8 10866.1 10989.5 11223.8 11241.2 11543.7 11468.1 11734.5 11794.5 11807.6 11854.8 10847.9 11163.4 11271.0 11428.0 11634.5 9980.7 10017.4 10212.1 10214.7 10555.2 9060.6 9239.1 9730.9 10282.1 10393.2 19:57:05 INFO - PROCESS | 3508 | -------- Summary: end -------- 19:57:05 INFO - PROCESS | 3508 | 19:57:06 INFO - TEST-INFO | 3508: exit 0 19:57:06 INFO - TEST-OK | dromaeo_css | took 1116210ms 19:57:06 INFO - TEST-START | kraken 19:57:06 INFO - operating with platform_type : linux_ 19:57:06 INFO - Initialising browser for kraken test... 19:57:06 INFO - TEST-INFO | started process 3700 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpk7Bgwo/profile http://localhost:47637/getInfo.html) 19:57:10 INFO - PROCESS | 3700 | __metrics Screen width/height:1600/1200 19:57:10 INFO - PROCESS | 3700 | colorDepth:24 19:57:10 INFO - PROCESS | 3700 | Browser inner width/height: 1024/697 19:57:10 INFO - PROCESS | 3700 | __metrics 19:57:10 INFO - PROCESS | 3700 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:57:10 INFO - PROCESS | 3700 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:57:11 INFO - TEST-INFO | 3700: exit 0 19:57:11 INFO - Browser initialized. 19:57:11 INFO - Running cycle 1/1 for kraken test... 19:57:11 INFO - TEST-INFO | started process 3780 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpk7Bgwo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:57:23 INFO - PROCESS | 3780 | RSS: Main: 150421504 19:57:23 INFO - PROCESS | 3780 | 19:57:25 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47637/tests/kraken/driver.html?testName=audio-beat-detection) 19:57:26 INFO - PROCESS | 3780 | RSS: Main: 186507264 19:57:26 INFO - PROCESS | 3780 | 19:57:29 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47637/tests/kraken/driver.html?testName=audio-dft) 19:57:29 INFO - PROCESS | 3780 | RSS: Main: 175284224 19:57:29 INFO - PROCESS | 3780 | 19:57:32 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47637/tests/kraken/driver.html?testName=audio-fft) 19:57:32 INFO - PROCESS | 3780 | RSS: Main: 161329152 19:57:32 INFO - PROCESS | 3780 | 19:57:35 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47637/tests/kraken/driver.html?testName=audio-oscillator) 19:57:35 INFO - PROCESS | 3780 | RSS: Main: 162492416 19:57:35 INFO - PROCESS | 3780 | 19:57:37 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47637/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:57:38 INFO - PROCESS | 3780 | RSS: Main: 164864000 19:57:38 INFO - PROCESS | 3780 | 19:57:41 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47637/tests/kraken/driver.html?testName=imaging-darkroom) 19:57:41 INFO - PROCESS | 3780 | RSS: Main: 166326272 19:57:41 INFO - PROCESS | 3780 | 19:57:45 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47637/tests/kraken/driver.html?testName=imaging-desaturate) 19:57:45 INFO - PROCESS | 3780 | RSS: Main: 166383616 19:57:45 INFO - PROCESS | 3780 | 19:57:48 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47637/tests/kraken/driver.html?testName=json-parse-financial) 19:57:49 INFO - PROCESS | 3780 | RSS: Main: 166223872 19:57:49 INFO - PROCESS | 3780 | 19:57:50 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47637/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:57:51 INFO - PROCESS | 3780 | RSS: Main: 175415296 19:57:51 INFO - PROCESS | 3780 | 19:57:52 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47637/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:57:53 INFO - PROCESS | 3780 | RSS: Main: 172068864 19:57:53 INFO - PROCESS | 3780 | 19:57:55 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47637/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:57:56 INFO - PROCESS | 3780 | RSS: Main: 185896960 19:57:56 INFO - PROCESS | 3780 | 19:57:58 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47637/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:57:59 INFO - PROCESS | 3780 | RSS: Main: 193425408 19:57:59 INFO - PROCESS | 3780 | 19:58:01 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47637/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:58:02 INFO - PROCESS | 3780 | RSS: Main: 190394368 19:58:02 INFO - PROCESS | 3780 | 19:58:04 INFO - PROCESS | 3780 | Cycle 1(1): loaded http://localhost:47637/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47637/tests/kraken/driver.html?testName=ai-astar) 19:58:04 INFO - PROCESS | 3780 | RSS: Main: 248205312 19:58:04 INFO - PROCESS | 3780 | 19:58:04 INFO - PROCESS | 3780 | __start_tp_report 19:58:04 INFO - PROCESS | 3780 | _x_x_mozilla_page_load 19:58:04 INFO - PROCESS | 3780 | _x_x_mozilla_page_load_details 19:58:04 INFO - PROCESS | 3780 | |i|pagename|runs| 19:58:04 INFO - PROCESS | 3780 | |0;ai-astar;107;111;105;109;109;110;98;109;109;101 19:58:04 INFO - PROCESS | 3780 | |1;audio-beat-detection;147;124;158;166;132;147;158;126;175;124 19:58:04 INFO - PROCESS | 3780 | |2;audio-dft;162;160;159;159;163;162;161;160;161;160 19:58:04 INFO - PROCESS | 3780 | |3;audio-fft;71;71;85;105;71;71;74;123;93;71 19:58:04 INFO - PROCESS | 3780 | |4;audio-oscillator;94;93;136;92;93;93;135;93;92;143 19:58:04 INFO - PROCESS | 3780 | |5;imaging-gaussian-blur;109;110;109;109;109;109;109;109;109;109 19:58:04 INFO - PROCESS | 3780 | |6;imaging-darkroom;145;145;145;145;145;145;145;145;144;147 19:58:04 INFO - PROCESS | 3780 | |7;imaging-desaturate;96;95;96;96;95;96;96;95;95;96 19:58:04 INFO - PROCESS | 3780 | |8;json-parse-financial;58;57;61;59;56;58;58;67;56;54 19:58:04 INFO - PROCESS | 3780 | |9;json-stringify-tinderbox;67;67;67;68;67;68;68;69;69;68 19:58:04 INFO - PROCESS | 3780 | |10;stanford-crypto-aes;84;84;87;85;84;84;85;92;86;94 19:58:04 INFO - PROCESS | 3780 | |11;stanford-crypto-ccm;118;121;114;114;120;117;118;125;114;120 19:58:04 INFO - PROCESS | 3780 | |12;stanford-crypto-pbkdf2;141;144;155;146;161;142;164;151;143;142 19:58:04 INFO - PROCESS | 3780 | |13;stanford-crypto-sha256-iterative;75;68;67;68;66;66;68;67;67;65 19:58:04 INFO - PROCESS | 3780 | __end_tp_report 19:58:04 INFO - PROCESS | 3780 | __start_cc_report 19:58:04 INFO - PROCESS | 3780 | _x_x_mozilla_cycle_collect,908 19:58:04 INFO - PROCESS | 3780 | __end_cc_report 19:58:04 INFO - PROCESS | 3780 | __startTimestamp1450843084316__endTimestamp 19:58:04 INFO - PROCESS | 3780 | 19:58:04 INFO - PROCESS | 3780 | ------- Summary: start ------- 19:58:04 INFO - PROCESS | 3780 | Number of tests: 14 19:58:04 INFO - PROCESS | 3780 | 19:58:04 INFO - PROCESS | 3780 | [#0] ai-astar Cycles:10 Average:106.80 Median:109.00 stddev:4.24 (3.9%) stddev-sans-first:4.49 19:58:04 INFO - PROCESS | 3780 | Values: 107.0 111.0 105.0 109.0 109.0 110.0 98.0 109.0 109.0 101.0 19:58:04 INFO - PROCESS | 3780 | 19:58:04 INFO - PROCESS | 3780 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:152.50 stddev:18.54 (12.2%) stddev-sans-first:19.66 19:58:04 INFO - PROCESS | 3780 | Values: 147.0 124.0 158.0 166.0 132.0 147.0 158.0 126.0 175.0 124.0 19:58:04 INFO - PROCESS | 3780 | 19:58:04 INFO - PROCESS | 3780 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.34 (0.8%) stddev-sans-first:1.33 19:58:04 INFO - PROCESS | 3780 | Values: 162.0 160.0 159.0 159.0 163.0 162.0 161.0 160.0 161.0 160.0 19:58:04 INFO - PROCESS | 3780 | 19:58:04 INFO - PROCESS | 3780 | [#3] audio-fft Cycles:10 Average:83.50 Median:71.00 stddev:18.22 (25.7%) stddev-sans-first:18.75 19:58:04 INFO - PROCESS | 3780 | Values: 71.0 71.0 85.0 105.0 71.0 71.0 74.0 123.0 93.0 71.0 19:58:04 INFO - PROCESS | 3780 | 19:58:04 INFO - PROCESS | 3780 | [#4] audio-oscillator Cycles:10 Average:106.40 Median:93.00 stddev:21.91 (23.6%) stddev-sans-first:22.77 19:58:04 INFO - PROCESS | 3780 | Values: 94.0 93.0 136.0 92.0 93.0 93.0 135.0 93.0 92.0 143.0 19:58:04 INFO - PROCESS | 3780 | 19:58:04 INFO - PROCESS | 3780 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:58:04 INFO - PROCESS | 3780 | Values: 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 19:58:04 INFO - PROCESS | 3780 | 19:58:04 INFO - PROCESS | 3780 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 19:58:04 INFO - PROCESS | 3780 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 144.0 147.0 19:58:04 INFO - PROCESS | 3780 | 19:58:04 INFO - PROCESS | 3780 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 19:58:04 INFO - PROCESS | 3780 | Values: 96.0 95.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 96.0 19:58:04 INFO - PROCESS | 3780 | 19:58:04 INFO - PROCESS | 3780 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:58.00 stddev:3.57 (6.1%) stddev-sans-first:3.78 19:58:04 INFO - PROCESS | 3780 | Values: 58.0 57.0 61.0 59.0 56.0 58.0 58.0 67.0 56.0 54.0 19:58:04 INFO - PROCESS | 3780 | 19:58:04 INFO - PROCESS | 3780 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 19:58:04 INFO - PROCESS | 3780 | Values: 67.0 67.0 67.0 68.0 67.0 68.0 68.0 69.0 69.0 68.0 19:58:04 INFO - PROCESS | 3780 | 19:58:04 INFO - PROCESS | 3780 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:85.50 stddev:3.60 (4.2%) stddev-sans-first:3.70 19:58:04 INFO - PROCESS | 3780 | Values: 84.0 84.0 87.0 85.0 84.0 84.0 85.0 92.0 86.0 94.0 19:58:04 INFO - PROCESS | 3780 | 19:58:04 INFO - PROCESS | 3780 | [#11] stanford-crypto-ccm Cycles:10 Average:118.10 Median:119.00 stddev:3.57 (3.0%) stddev-sans-first:3.79 19:58:04 INFO - PROCESS | 3780 | Values: 118.0 121.0 114.0 114.0 120.0 117.0 118.0 125.0 114.0 120.0 19:58:04 INFO - PROCESS | 3780 | 19:58:04 INFO - PROCESS | 3780 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.90 Median:148.50 stddev:8.44 (5.7%) stddev-sans-first:8.45 19:58:04 INFO - PROCESS | 3780 | Values: 141.0 144.0 155.0 146.0 161.0 142.0 164.0 151.0 143.0 142.0 19:58:04 INFO - PROCESS | 3780 | 19:58:04 INFO - PROCESS | 3780 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.50 stddev:2.75 (4.1%) stddev-sans-first:1.05 19:58:04 INFO - PROCESS | 3780 | Values: 75.0 68.0 67.0 68.0 66.0 66.0 68.0 67.0 67.0 65.0 19:58:04 INFO - PROCESS | 3780 | -------- Summary: end -------- 19:58:04 INFO - PROCESS | 3780 | 19:58:05 INFO - TEST-INFO | 3780: exit 0 19:58:05 INFO - TEST-OK | kraken | took 58964ms 19:58:05 INFO - TEST-START | v8_7 19:58:05 INFO - operating with platform_type : linux_ 19:58:05 INFO - Initialising browser for v8_7 test... 19:58:05 INFO - TEST-INFO | started process 4026 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3Z4VGV/profile http://localhost:47637/getInfo.html) 19:58:09 INFO - PROCESS | 4026 | __metrics Screen width/height:1600/1200 19:58:09 INFO - PROCESS | 4026 | colorDepth:24 19:58:09 INFO - PROCESS | 4026 | Browser inner width/height: 1024/697 19:58:09 INFO - PROCESS | 4026 | __metrics 19:58:09 INFO - PROCESS | 4026 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:58:09 INFO - PROCESS | 4026 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:58:09 ERROR - PROCESS | 4026 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 19:58:10 INFO - TEST-INFO | 4026: exit 0 19:58:10 INFO - Browser initialized. 19:58:10 INFO - Running cycle 1/1 for v8_7 test... 19:58:10 INFO - TEST-INFO | started process 4107 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3Z4VGV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:58:22 INFO - PROCESS | 4107 | RSS: Main: 150343680 19:58:22 INFO - PROCESS | 4107 | 19:58:43 INFO - PROCESS | 4107 | Cycle 1(1): loaded http://localhost:47637/tests/v8_7/run.html (next: http://localhost:47637/tests/v8_7/run.html) 19:58:44 INFO - PROCESS | 4107 | RSS: Main: 570654720 19:58:44 INFO - PROCESS | 4107 | 19:58:44 INFO - PROCESS | 4107 | __start_tp_report 19:58:44 INFO - PROCESS | 4107 | _x_x_mozilla_page_load 19:58:44 INFO - PROCESS | 4107 | _x_x_mozilla_page_load_details 19:58:44 INFO - PROCESS | 4107 | |i|pagename|runs| 19:58:44 INFO - PROCESS | 4107 | |0;Richards;165.97510373443984 19:58:44 INFO - PROCESS | 4107 | |1;DeltaBlue;194.89378288832586 19:58:44 INFO - PROCESS | 4107 | |2;Encrypt;283.9295854628052 19:58:44 INFO - PROCESS | 4107 | |3;Decrypt;5143.589743589743 19:58:44 INFO - PROCESS | 4107 | |4;RayTrace;2040.7331975560082 19:58:44 INFO - PROCESS | 4107 | |5;Earley;790.5138339920949 19:58:44 INFO - PROCESS | 4107 | |6;Boyer;12219.512195121952 19:58:44 INFO - PROCESS | 4107 | |7;RegExp;25948.71794871795 19:58:44 INFO - PROCESS | 4107 | |8;Splay;584.4535359438925 19:58:44 INFO - PROCESS | 4107 | |9;NavierStokes;4830.917874396136 19:58:44 INFO - PROCESS | 4107 | __end_tp_report 19:58:44 INFO - PROCESS | 4107 | __startTimestamp1450843124136__endTimestamp 19:58:44 INFO - PROCESS | 4107 | 19:58:44 INFO - PROCESS | 4107 | ------- Summary: start ------- 19:58:44 INFO - PROCESS | 4107 | Number of tests: 10 19:58:44 INFO - PROCESS | 4107 | 19:58:44 INFO - PROCESS | 4107 | [#0] Richards Cycles:1 Average:165.98 Median:165.98 stddev:0.00 (0.0%) 19:58:44 INFO - PROCESS | 4107 | Values: 166.0 19:58:44 INFO - PROCESS | 4107 | 19:58:44 INFO - PROCESS | 4107 | [#1] DeltaBlue Cycles:1 Average:194.89 Median:194.89 stddev:0.00 (0.0%) 19:58:44 INFO - PROCESS | 4107 | Values: 194.9 19:58:44 INFO - PROCESS | 4107 | 19:58:44 INFO - PROCESS | 4107 | [#2] Encrypt Cycles:1 Average:283.93 Median:283.93 stddev:0.00 (0.0%) 19:58:44 INFO - PROCESS | 4107 | Values: 283.9 19:58:44 INFO - PROCESS | 4107 | 19:58:44 INFO - PROCESS | 4107 | [#3] Decrypt Cycles:1 Average:5143.59 Median:5143.59 stddev:0.00 (0.0%) 19:58:44 INFO - PROCESS | 4107 | Values: 5143.6 19:58:44 INFO - PROCESS | 4107 | 19:58:44 INFO - PROCESS | 4107 | [#4] RayTrace Cycles:1 Average:2040.73 Median:2040.73 stddev:0.00 (0.0%) 19:58:44 INFO - PROCESS | 4107 | Values: 2040.7 19:58:44 INFO - PROCESS | 4107 | 19:58:44 INFO - PROCESS | 4107 | [#5] Earley Cycles:1 Average:790.51 Median:790.51 stddev:0.00 (0.0%) 19:58:44 INFO - PROCESS | 4107 | Values: 790.5 19:58:44 INFO - PROCESS | 4107 | 19:58:44 INFO - PROCESS | 4107 | [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 19:58:44 INFO - PROCESS | 4107 | Values: 12219.5 19:58:44 INFO - PROCESS | 4107 | 19:58:44 INFO - PROCESS | 4107 | [#7] RegExp Cycles:1 Average:25948.72 Median:25948.72 stddev:0.00 (0.0%) 19:58:44 INFO - PROCESS | 4107 | Values: 25948.7 19:58:44 INFO - PROCESS | 4107 | 19:58:44 INFO - PROCESS | 4107 | [#8] Splay Cycles:1 Average:584.45 Median:584.45 stddev:0.00 (0.0%) 19:58:44 INFO - PROCESS | 4107 | Values: 584.5 19:58:44 INFO - PROCESS | 4107 | 19:58:44 INFO - PROCESS | 4107 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 19:58:44 INFO - PROCESS | 4107 | Values: 4830.9 19:58:44 INFO - PROCESS | 4107 | -------- Summary: end -------- 19:58:44 INFO - PROCESS | 4107 | 19:58:44 INFO - TEST-INFO | 4107: exit 0 19:58:44 INFO - TEST-OK | v8_7 | took 39804ms 19:58:44 INFO - SUITE-END | took 1214s 19:58:45 INFO - Completed test suite (00:20:15) 19:58:45 INFO - Working with test: dromaeo_css 19:58:45 INFO - Generating results file: dromaeo_css 19:58:45 INFO - Working with test: kraken 19:58:45 INFO - Generating results file: kraken 19:58:45 INFO - javascript benchmark 19:58:45 INFO - Working with test: v8_7 19:58:45 INFO - Generating results file: v8_7 19:58:45 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:58:45 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 19:58:45 INFO - process_Request line: dromaeo_css 7000.75 graph.html#tests=[[72,201,35]] 19:58:45 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:58:45 INFO - process_Request line: kraken 1500.30 graph.html#tests=[[232,201,35]] 19:58:45 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:58:45 INFO - process_Request line: v8_7 19768.94 graph.html#tests=[[230,201,35]] 19:58:45 INFO - RETURN: dromaeo_css: 7000.75 19:58:45 INFO - RETURN: kraken: 1500.30 19:58:45 INFO - RETURN: v8_7: 19768.94 19:58:45 INFO - javascript benchmark 19:58:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3174.1588479053057, 3225.951610725841, 3255.641879393266, 3258.348330333934, 3281.7210537104347, 5161.380634323887, 5275.709835959021, 5423.240746295522, 5492.588055895804, 5497.862553436166, 5343.519083282504, 5375.139977603584, 5378.946210537903, 5458.1266997280345, 5498.202760599711, 4865.635077369194, 4881.707097574139, 4887.584555312794, 4942.604591632678, 5053.115704751672, 4911.336969509124, 5041.0, 5057.988402319533, 5086.898262034757, 5124.4106927703415, 4918.877028074309, 4955.752212389384, 4987.177115775893, 4998.600111991032, 5015.774290156952, 4930.926036109461, 4933.802647894116, 4945.455999840015, 4986.301917731521, 4990.675606085593, 4835.540623640749, 4942.654014219006, 4944.554990050877, 4947.480514545993, 4962.925556116661, 5131.358580177478, 5157.664751791159, 5175.792968281265, 5188.8183913563225, 5216.295800067019, 5848.941510584882, 5854.648721076749, 5862.589618726691, 5862.882742345172, 5864.53083753303, 5749.137629355589, 5806.1000544915605, 5885.293764748215, 5888.970555147197, 5890.322612899528, 5364.168553874156, 5376.327959005124, 5502.972485137549, 5506.724663766836, 5508.476694713996, 5880.088586269135, 5909.674967876808, 5909.793157239476, 5912.822615321547, 5922.8815423691285, 5723.7996670116345, 5736.569757268222, 5737.799177028867, 5744.080947048452, 5775.16260142277, 5728.427157284322, 5734.369219385864, 5854.648721076749, 5861.70691465425, 5926.377730338339, 5851.912221316684, 5908.763649453974, 5911.172435858984, 5946.791862284799, 5952.166696662471, 5876.324222714443, 5903.0555111182, 5912.497437717756, 5913.438223368773, 5919.822405327847, 4402.3836662867225, 4421.602055814992, 4447.266201076851, 4449.1546606145375, 4507.684462087688, 4003.978985358715, 4006.5192176938954, 4012.3179059559943, 4017.357222844331, 4042.231975924624, 5518.613697041169, 5529.972350138223, 5532.695701736363, 5535.197396377503, 5566.0, 5643.40744221859, 5769.0, 5800.216970708984, 5802.593818432669, 5848.766049357978, 5448.046591846411, 5464.535514481234, 5485.890282194334, 5491.258680078218, 5512.4211957744665, 5113.9744301279, 5115.693058416507, 5116.56509196715, 5125.79496820123, 5171.63798534099, 5855.619384740064, 5888.882222355614, 5974.761009559569, 6024.57827952048, 6032.849178770478, 5803.506701930214, 5883.264591926009, 5889.587728858939, 5890.617109887844, 5901.085331773582, 5948.851278718067, 5949.762009519571, 5950.880982380415, 5954.553408494294, 5966.642001479925, 5564.972175139098, 5662.065759149859, 5662.065759149859, 5738.397468265939, 5799.76800927975, 5818.534517238695, 5884.7940322088525, 5890.941090589039, 5892.705364731832, 5894.528437725057, 5595.048841697003, 5696.743646535999, 5727.513161381329, 5732.512736417451, 5737.311522617146, 5532.972335138459, 5585.301837270341, 5649.548036157015, 5689.516391106637, 5703.657780533182, 5569.55443564522, 5621.7189140542, 5621.887562248814, 5635.6618602883955, 5677.063284558001, 5728.856778580569, 5787.958167529717, 5790.131480277992, 5793.507551858139, 5850.327212370632, 5466.371367292653, 5553.278073850373, 5556.888862222652, 5702.37273899879, 5725.312962444534], "unit": "score", "name": "dojo.html", "value": 5371.202849576747}, {"lowerIsBetter": false, "replicates": [558.9217509548664, 604.9425304596065, 607.6384551192041, 609.8963176260036, 610.2768219659704, 29358.0, 30136.39727205457, 38412.807935960314, 38927.026824329405, 38959.22081558367, 42249.0, 42735.3589696154, 42836.78581607095, 42842.7857860711, 42860.0, 7486.962565187167, 7605.695772169107, 8710.12898710127, 8882.15619516145, 8886.644534218656, 10407.115395191418, 10678.145748340154, 10680.946595267013, 10684.51919663617, 10692.411917344543, 10376.273660843744, 10443.0, 10459.895401045967, 10464.4767761612, 10469.581216751321, 7660.885086723676, 7820.296173344369, 7830.882536761953, 10255.743606409862, 10470.42412667303, 10230.925752795998, 10243.539040743184, 10304.690859274233, 10340.069393754524, 10377.896221037769, 39622.0, 40037.19925601501, 40123.595674151264, 40141.0, 40186.18231268025, 3039.0, 3051.938961220785, 3319.9834000830083, 3472.8437220324895, 3541.486484459739, 29986.700132998827, 30251.394972100654, 30310.393792124254, 30733.231669208224, 31358.686413135805, 3943.2310699413624, 3947.1118998225456, 3980.900477488086, 3990.68074554035, 4035.0, 267139.0, 268976.0, 269186.65406673035, 269673.0, 269792.0, 55392.446075538726, 56234.43765562374, 58350.70824645935, 58767.11849322264, 58815.0, 67373.0, 68189.0, 68514.0, 68519.0, 68554.65722671355, 12843.614691559269, 12977.35113244334, 12980.805287920688, 13047.282399467931, 13089.541866034642, 9950.950245248727, 10087.344322619007, 10094.343867648578, 10095.0, 10103.0, 19688.90155549242, 19890.90600017013, 20061.0, 20068.297609583595, 20145.59708805845, 7183.209846916835, 7331.670074846645, 7336.082989626297, 7456.552606843607, 7494.550326980289, 833.3374966901328, 969.060011788564, 1008.8436292374694, 1027.4688623171926, 1083.00363665428, 28380.432391352057, 28424.857875710488, 29881.517772334322, 30493.390132197233, 31109.8444507776, 992.5384696116196, 998.4658207858761, 1016.6594190945968, 1058.9093233969024, 1098.2367254758026, 13513.121647092907, 13527.0, 13796.517121900686, 13826.30868456573, 13855.653608659864, 303256.0, 308975.0, 308981.0, 310507.0543651082, 310679.3786652414, 50861.23708144381, 51097.48902510927, 51109.0, 51149.23276150861, 51227.48772512227, 1237.10928131745, 1237.7029512917015, 1243.6269119264184, 1266.9049821263443, 1309.6267563744286, 24530.63204051905, 25596.8720156398, 28204.0, 30066.24834379158, 31179.37641247117, 47580.0, 47863.28205076857, 47949.760251199914, 47991.52008479871, 48023.279650804565, 242635.0, 244743.0, 244965.0, 245342.0, 273853.1376234785, 25621.3594660135, 31753.0, 32084.67915320817, 32116.518252225767, 32508.837455813515, 37134.62865371312, 37938.8103059483, 38021.619783801805, 38188.618113818506, 38554.0, 32250.677493225707, 32481.0, 32676.83661581677, 33862.66137338595, 35610.0, 34086.31827363389, 34733.30533389369, 35489.467657984635, 35519.82240088783, 35567.0, 33728.3254334907, 34432.48351274783, 34756.47865282073, 34770.130746731535, 34781.826090869385, 29562.260943476584, 30967.380652387277, 32379.0, 32454.513182301813, 32544.83727581347, 24484.328957943297, 24692.38269043288, 24739.25782226464, 24806.37984050341, 24992.250232493054], "unit": "score", "name": "ext.html", "value": 18236.894146474104}, {"lowerIsBetter": false, "replicates": [356.03336940207333, 356.0901895656596, 359.46619270383474, 360.05844716067486, 362.923786004939, 13623.93188034061, 13812.240326782023, 16074.51776446707, 16851.41020064298, 17925.10374481274, 13278.800817987738, 13745.106568073068, 15520.53438396847, 15751.684966300667, 16093.0, 5206.531412172894, 5451.454854514536, 5456.672599644015, 5458.9454105459035, 5459.754311056012, 3976.602339766029, 4057.6550993165615, 5290.285811415448, 5409.783608655669, 5413.242146099549, 5760.279965004374, 5845.5908086433965, 5876.471117599415, 5896.7051647417675, 5903.852403689899, 5716.714164291769, 5820.447057529528, 5835.5915085944, 5854.4438278363705, 5861.3552509223955, 5173.430922598511, 5174.534291913746, 5178.40448348441, 5180.974095129538, 5184.403793563713, 19860.60278794416, 19951.90024049885, 20005.49986250341, 20030.499237519034, 20607.896960515252, 2212.070930209316, 2236.3626366485473, 2463.9137630183036, 2470.654108424822, 2575.490215516392, 12999.675008124777, 13021.60935171937, 13295.86704132956, 13352.132111412728, 13395.10324042942, 1722.345508706696, 1734.6443978984405, 1737.9565510862203, 1761.4979730776668, 1779.5106345754891, 59966.70016649932, 60682.696586517224, 61420.078698819554, 61985.0, 62856.37143628551, 9531.142197202285, 9682.806343873082, 9736.513174341255, 9772.21822254218, 9826.115649591427, 12867.099303048884, 12874.420651070724, 12880.291583962784, 12880.742385152245, 12897.097203195874, 6942.340477654615, 6947.930520694829, 6961.338672826073, 6994.0, 7001.63468123711, 6551.508636852255, 6598.274189839114, 6645.269020407752, 6645.700943457556, 6645.700943457556, 5840.912386314209, 5908.847774683982, 5919.230500035054, 5958.463738263577, 5963.2844058713235, 1654.9751753723704, 1718.1564510734754, 1767.3814165042133, 1770.9645807084044, 1776.0764402510881, 903.4940433357209, 904.3262769236829, 980.7548112971757, 997.9850302245472, 1035.876074459205, 17276.395326163776, 17961.7305740414, 18100.818991810178, 18316.816831831777, 18514.259429622663, 807.7294106474396, 829.5147338806745, 875.4222213339166, 984.6947446291673, 1002.3835341265216, 8633.0, 8828.161324674145, 8829.218796079214, 9185.724428267162, 9252.722418327461, 530201.0, 536574.0, 546343.0, 548555.0, 554645.0, 79540.99999999884, 80144.59927700325, 80660.19339806645, 80861.19138808655, 81156.0, 1148.5750272399098, 1149.5401839264362, 1194.3908606610516, 1195.0, 1203.807390817465, 14464.927675361556, 14496.130232186102, 14577.708445831237, 14662.853371466148, 14840.480583179537, 33622.327553449286, 33699.83150084234, 33809.15477113092, 33949.66050339564, 34011.0, 45309.0, 46248.768756156, 47808.282875756195, 50511.24233136432, 51823.0, 9391.342606017513, 9412.858807118037, 9559.187469065208, 9583.616655333708, 9657.372270802376, 17189.742153867453, 17336.479905602853, 17487.387941422498, 17537.824621753618, 17699.557511062325, 13791.448342066205, 14527.0, 14618.707625847635, 14624.415023398944, 14795.926020369829, 13633.659158521117, 14476.276186190858, 14476.420943162155, 14679.71530249088, 15122.319495622503, 14961.0, 15087.849121508645, 15138.545843624708, 15561.0, 15575.922120389325, 8215.79460513468, 8414.368922330972, 9071.228945539702, 9200.95399522998, 9365.953170234105, 14091.0, 14092.506762263272, 14136.78794818058, 14295.0, 14368.0], "unit": "score", "name": "jquery.html", "value": 8944.129624044983}, {"lowerIsBetter": false, "replicates": [1302.6027061746177, 1414.3069895751082, 1474.2702362330645, 1586.5161125856616, 1741.3208848549075, 6724.462043036558, 7688.3849292056575, 7819.178986206452, 7835.608219589027, 7839.333656639178, 7631.1605723370385, 7790.3767698584115, 7811.92188078119, 7813.140554539011, 7813.6093195340145, 2170.6418440957223, 2203.6914831923546, 2207.536417352358, 2208.1167532986774, 2208.9447763805874, 2218.1681869299014, 2249.6850440938283, 2254.0, 2255.210676263311, 2255.616545187322, 2162.772908844572, 2207.812335951446, 2210.6462965925457, 2230.8661480311152, 2234.497238121418, 2176.804087632113, 2180.5420861618923, 2204.4488877780555, 2206.2829580386438, 2207.558488302338, 2222.0445208560313, 2245.0, 2246.809021233197, 2247.0, 2249.3701763506247, 7619.885701714478, 7723.7682869514, 7727.806804829925, 7728.304452599237, 7731.0336207974005, 4374.475062992461, 4460.687751857371, 4463.933041004388, 4487.39420178275, 4496.078303947683, 3064.4790385634496, 3132.8276944768027, 3150.842457877097, 3188.0913939527354, 3219.8551065201887, 989.7331415787803, 1023.0332335942537, 1046.210111365914, 1070.1599244592958, 1099.230538622959, 10587.364758114538, 10597.258191926569, 10603.204759643058, 10605.045545900828, 10617.84073238902, 4157.937630935538, 4209.20025195218, 4210.242156411814, 4226.112516371535, 4257.765822879772, 9049.276057915351, 9088.909330880337, 9106.817863642822, 9108.316876234308, 9115.772105697279, 4621.514740952219, 4623.768811559408, 4629.282461218517, 4647.16351056813, 4654.394928659321, 3781.0925377909102, 3804.2201348723447, 4173.457450531472, 4202.579742025834, 4239.703220774516, 3526.8236588171003, 3604.3512167810045, 3609.3864043112735, 3634.164142247298, 3644.799536025491, 1126.7577470843808, 1127.667338135252, 1128.7968165730247, 1130.2088538023415, 1133.6202372205403, 865.9740207793776, 874.6020560644891, 1076.321917192164, 1080.8324709670014, 1312.5078095714107, 7130.03744494497, 7177.318154775392, 7185.317394847481, 7198.856022879513, 7212.170600381023, 1074.7957888001254, 1084.3764835219781, 1095.2497539185524, 1101.3502033800096, 1127.2954403497813, 5601.6358936668985, 5624.0, 5629.887402251932, 5631.549476041907, 5634.549236061105, 8929.955350223338, 9419.434833909987, 9526.714198574055, 9532.23742100644, 9564.4739539326, 9271.768205794775, 9362.672306469241, 9396.812063758824, 9398.765030874147, 9435.292353073546, 7028.929710702828, 7207.279272072856, 7208.747693830691, 7227.566346019255, 7290.744823931243, 7426.4058875288765, 7480.850382992418, 7509.66206520697, 7521.05986751656, 7532.736354227576, 8026.117127116129, 8126.390520710852, 8181.918180818116, 8236.958815205886, 8270.421070525006, 8398.580070996304, 8607.18231767981, 8615.267702245379, 8626.698065567674, 8636.438631489185, 6698.799036028927, 6763.188417389944, 6766.7969960901255, 6768.052472653734, 6778.457723382019, 7367.115946086504, 7413.147488038944, 7441.255874412732, 7441.776746697607, 7451.850962980819, 6529.836754081186, 6839.829004274933, 6974.511784175059, 7034.402075823407, 7116.466265030247, 6580.868382632225, 6761.256261811099, 6783.966080169567, 6893.965530172317, 6931.514793964374, 6610.206775187008, 6714.429273511806, 6717.966410167918, 6739.831504212434, 6740.494462915203, 6174.722137503913, 6187.566870319034, 6188.597741146811, 6206.10011548332, 6208.658523781235, 6189.938100618936, 6263.96868015657, 6284.088807123033, 6486.1243732097455, 6532.542722009413], "unit": "score", "name": "mootools.html", "value": 4410.453666141345}, {"lowerIsBetter": false, "replicates": [339.20625735778276, 342.125868406222, 346.0604458894102, 349.0819145646949, 350.3098895176503, 5905.586608937376, 5955.583109182359, 5958.970205148979, 5965.0, 5976.8206953791405, 5649.519790817775, 5696.914546281799, 5798.246227990356, 5854.736536855841, 5876.236089308384, 4554.111948170108, 4574.245249533839, 4583.03756211196, 4601.677882548223, 4601.930971035429, 4394.340848872679, 4568.406107206075, 4583.770811459431, 4585.70192937458, 4593.035462552868, 4411.558844115579, 4475.149721552911, 4560.9087818243615, 4571.131485017836, 4572.702774319675, 4528.3660287559605, 4548.636109111263, 4557.680962332638, 4557.977210113928, 4563.726176429424, 4033.0320723026557, 4041.312976793952, 4044.130511939947, 4049.5545489996075, 4053.898652533681, 5537.501624853742, 5643.097104463266, 5654.406287339812, 5657.2928383952, 5659.7453114609525, 5347.973260133714, 5350.678959262456, 5352.545033672142, 5354.544863686591, 5355.973220133875, 6223.43989040984, 6266.154069200645, 6270.404311590391, 6281.214848143982, 6285.151504546873, 4476.6418686505, 4485.977570112129, 4488.169688607585, 4488.281874900033, 4493.662975276835, 6293.559450838443, 6478.676066196718, 6500.414962653336, 6501.642409667466, 6539.771108011244, 4491.663125265618, 4513.277875539898, 4515.661325400542, 4515.68390212682, 4518.186726389215, 4536.274196128669, 4557.316402539579, 4560.498345182027, 4562.61217796491, 4562.9771851141195, 5215.452377500308, 5242.816501422432, 5244.711540865289, 5246.947530524722, 5266.3943646480375, 6089.786857459968, 6271.310155882849, 6317.4630156437215, 6320.146780184617, 6341.873162536724, 1581.8497242761919, 1583.4299652125226, 1592.3471376735483, 1596.0822527046994, 1597.5127586086355, 1061.2253055269696, 1080.475969154959, 1081.3619964221148, 1102.2669924500278, 1103.4151899493281, 6046.213992181077, 6048.0, 6053.939460605426, 6055.878882422415, 6059.21230240066, 6488.059231411419, 6498.252700939358, 6501.0573466847045, 6502.60984340941, 6504.414602685686, 5866.677332746654, 5939.376365481562, 6001.459868611759, 6086.360932102154, 6107.816765497042, 3505.9657401066747, 3518.964810351915, 3521.8415171316838, 3525.206828463575, 3529.6823285904393, 6602.8349291268105, 6603.174603174603, 6608.768693095719, 6612.702428390734, 6612.974988876732, 6533.705983230766, 6648.1025061616065, 6705.932940670628, 6709.932900671029, 6761.966190169018, 6624.8012559623285, 6658.4673226141795, 6660.56706314088, 6665.233498147678, 6667.799966001027, 6562.343765623399, 6574.737010519526, 6583.0, 6586.341365863375, 6599.406053455212, 6378.48972082223, 6503.837404064936, 6506.0, 6506.089147519257, 6507.642079685663, 6653.2348779889, 6653.800385988428, 6655.600663960178, 6659.866802664016, 6661.933380666325, 4514.164879497303, 4554.339620755039, 4560.977195114003, 4563.452385713736, 4568.223402021597, 6483.675816209076, 6580.868382632416, 6582.11141495911, 6593.835154121185, 6595.472362210916, 6352.0, 6375.171227740364, 6387.872242555216, 6395.936040639534, 6396.264429590657, 6360.809175724736, 6373.267074286517, 6390.105385245976, 6397.488200944006, 6400.839979000562, 6118.326984031664, 6271.937280627318, 6279.183706118358, 6284.780032698834, 6290.591111577733, 6436.710348034256, 6436.806895793134, 6437.967810160919, 6437.967810160919, 6438.420542151041, 6269.090981807703, 6286.811395658137, 6289.622622642473, 6293.905591416041, 6294.874102518015], "unit": "score", "name": "prototype.html", "value": 4776.635283443054}, {"lowerIsBetter": false, "replicates": [749.482856828788, 760.44107580928, 811.1807074854395, 840.1817414405244, 845.0957475501209, 13118.93440532796, 13171.934140329296, 13220.074594778369, 13253.668658283548, 13276.867231327697, 12187.939060304687, 14464.532691217, 14507.419703211885, 14514.854851451482, 14527.20100394478, 807.5679511461369, 813.9470934389245, 821.0147822612859, 821.4373154389233, 822.2147848804408, 678.4470656415006, 684.8185230913812, 801.1027649033063, 808.5876203136384, 811.2212276214841, 838.4005436113177, 842.9873551896726, 846.2595229174473, 849.6856163219586, 850.0054935725217, 694.1254019934919, 701.6632016632045, 845.5814371885925, 846.0101681033175, 846.5640195299426, 614.9108379284978, 623.6476390839161, 623.847157446424, 624.2883113250898, 624.3194917539903, 13061.151025183333, 13136.86863131366, 13146.408411621404, 13161.60515184546, 13173.341332933314, 11667.766644667145, 11738.329330344, 12342.321172335518, 12521.373931303398, 12626.368681565886, 10431.113355364803, 10536.104431123364, 10601.310914790514, 10641.627543035956, 10835.241533092687, 3574.7318951078514, 3627.6916462100753, 3662.08447888028, 3679.7240206984584, 3750.9249815003545, 47578.52421475775, 47595.286070708964, 47606.0, 47637.76181119107, 48031.75984120092, 9457.858132128023, 9874.654387096418, 9951.353162044445, 10091.444970526545, 10506.369617822802, 17743.201555930013, 17753.378631747826, 17772.377966771102, 17775.0, 17785.644287114184, 7551.395888328921, 7595.430342724318, 7601.695932162652, 7726.459147859596, 7774.06711194649, 4150.91698166035, 4221.345691417835, 4237.978810105929, 4238.682098842599, 4290.785460726951, 3051.054173206313, 3053.084074777558, 3057.8165310081467, 3082.5376193570696, 3088.907332779975, 524.5174439515655, 546.4944925943487, 556.2323992889867, 561.764059095181, 562.2409746841731, 563.6082922368996, 598.5042373303336, 600.7236671131328, 669.3707914560298, 685.4345165238599, 8404.453710508797, 8753.606087726068, 8830.823383532294, 8844.115588441233, 9003.594838232164, 659.8746238214724, 660.9306022867626, 673.3132205150816, 677.3869647968596, 686.3822559696313, 4033.334499807499, 4204.3693445983345, 4280.357946308079, 4381.16757816014, 4427.867163985021, 52119.0, 59400.0, 59430.70284648549, 59445.108323375185, 60178.097328540105, 50648.24027639588, 53308.73345633247, 53333.200002, 53524.0, 53947.73026134844, 49176.0, 49725.50274497281, 53941.1908821368, 54371.0, 58750.412495874494, 8936.329775267011, 9015.14356136166, 9046.683366082156, 9083.68207112748, 9098.226650734761, 37545.62454375421, 38035.809820950715, 38142.42786358151, 39060.80469597634, 39722.80138599288, 46694.0, 46703.53296466992, 46978.76510617425, 47089.2936605958, 48165.27752083792, 9958.253131015057, 11054.941336862908, 11461.598844040418, 11491.655250342503, 11595.555136457855, 11745.0, 12007.75984480288, 12366.938165309475, 12488.500459981862, 12965.805512917124, 10866.05595444417, 10989.450527473435, 11223.775524489627, 11241.156913231704, 11543.728432070657, 11468.079285731983, 11734.530618775154, 11794.528218871492, 11807.645770626896, 11854.762904742029, 10847.945760271148, 11163.441827908735, 11270.985611295022, 11428.0, 11634.476448560004, 9980.700578982642, 10017.39895606266, 10212.131968782736, 10214.744631384276, 10555.15558755313, 9060.592273347584, 9239.127720878638, 9730.902690973, 10282.126019288444, 10393.220508461744], "unit": "score", "name": "yui.html", "value": 6377.678350789816}], "name": "dromaeo_css", "value": 7000.748791271132}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 111.0, 105.0, 109.0, 109.0, 110.0, 98.0, 109.0, 109.0, 101.0], "unit": "score", "name": "ai-astar", "value": 106.8}, {"lowerIsBetter": true, "replicates": [147.0, 124.0, 158.0, 166.0, 132.0, 147.0, 158.0, 126.0, 175.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 145.7}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 159.0, 159.0, 163.0, 162.0, 161.0, 160.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 85.0, 105.0, 71.0, 71.0, 74.0, 123.0, 93.0, 71.0], "unit": "score", "name": "audio-fft", "value": 83.5}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 136.0, 92.0, 93.0, 93.0, 135.0, 93.0, 92.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 106.4}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 144.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 61.0, 59.0, 56.0, 58.0, 58.0, 67.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 58.4}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 68.0, 67.0, 68.0, 68.0, 69.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 87.0, 85.0, 84.0, 84.0, 85.0, 92.0, 86.0, 94.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [118.0, 121.0, 114.0, 114.0, 120.0, 117.0, 118.0, 125.0, 114.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.1}, {"lowerIsBetter": true, "replicates": [141.0, 144.0, 155.0, 146.0, 161.0, 142.0, 164.0, 151.0, 143.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.9}, {"lowerIsBetter": true, "replicates": [75.0, 68.0, 67.0, 68.0, 66.0, 66.0, 68.0, 67.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1500.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.97510373443984], "unit": "score", "name": "Richards", "value": 212.69455}, {"lowerIsBetter": false, "replicates": [194.89378288832586], "unit": "score", "name": "DeltaBlue", "value": 339.25145799999996}, {"lowerIsBetter": false, "replicates": [283.9295854628052], "unit": "score", "name": "Encrypt", "value": 937.4894820000002}, {"lowerIsBetter": false, "replicates": [5143.589743589743], "unit": "score", "name": "Decrypt", "value": 51.75004486540379}, {"lowerIsBetter": false, "replicates": [2040.7331975560082], "unit": "score", "name": "RayTrace", "value": 362.609380239521}, {"lowerIsBetter": false, "replicates": [790.5138339920949], "unit": "score", "name": "Earley", "value": 843.0756950000003}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [25948.71794871795], "unit": "score", "name": "RegExp", "value": 35.107129446640336}, {"lowerIsBetter": false, "replicates": [584.4535359438925], "unit": "score", "name": "Splay", "value": 139.43110099999998}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19768.93978243932}]} 19:58:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19768.94"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1500.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "7000.75"}}} 19:58:45 INFO - Return code: 0 19:58:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:58:45 ERROR - # TBPL SUCCESS # 19:58:45 INFO - Running post-action listener: _resource_record_post_action 19:58:45 INFO - Running post-run listener: _resource_record_post_run 19:58:46 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 10272768; Write bytes: 447762432; Read time: 2856; Write time: 518316 19:58:46 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 84701184; Read time: 40; Write time: 91688 19:58:46 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 8507392; Write bytes: 363061248; Read time: 2728; Write time: 426628 19:58:46 INFO - Running post-run listener: _upload_blobber_files 19:58:46 INFO - Blob upload gear active. 19:58:46 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:58:46 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 19:58:46 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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 19:58:46 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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 19:58:46 INFO - (blobuploader) - INFO - Open directory for files ... 19:58:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 19:58:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:58:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:58:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:58:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:58:47 INFO - (blobuploader) - INFO - Done attempting. 19:58:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:58:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:58:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:58:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:58:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:58:48 INFO - (blobuploader) - INFO - Done attempting. 19:58:48 INFO - (blobuploader) - INFO - Iteration through files over. 19:58:48 INFO - Return code: 0 19:58:48 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:58:48 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:58:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/7274fb8b71d82ede2435356834af4f19104ddeb00eaab7df2c85f603cdd9c1adffc3e3c53b35c39d9e0214fa41a73aaa79db3c3ea77aeff3f1f4f3212a797f22", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/bb7ffc696abdd8366f47a87b3b5a5269d67025cbab8b50532bbf48ff88bf57c142d76a4c4e16d6e21b53e4b40afa241df30eebd65e6214162c3a494d44c47be5"} 19:58:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:58:48 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:58:48 INFO - Contents: 19:58:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/7274fb8b71d82ede2435356834af4f19104ddeb00eaab7df2c85f603cdd9c1adffc3e3c53b35c39d9e0214fa41a73aaa79db3c3ea77aeff3f1f4f3212a797f22", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/bb7ffc696abdd8366f47a87b3b5a5269d67025cbab8b50532bbf48ff88bf57c142d76a4c4e16d6e21b53e4b40afa241df30eebd65e6214162c3a494d44c47be5"} 19:58:48 INFO - Copying logs to upload dir... 19:58:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1278.226596 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-12-22 19:58:48.578251) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 19:58:48.581788) ========= 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=0cff312cb257a7829adc5a5d000001df-1450840521.788027-651438517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/7274fb8b71d82ede2435356834af4f19104ddeb00eaab7df2c85f603cdd9c1adffc3e3c53b35c39d9e0214fa41a73aaa79db3c3ea77aeff3f1f4f3212a797f22", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/bb7ffc696abdd8366f47a87b3b5a5269d67025cbab8b50532bbf48ff88bf57c142d76a4c4e16d6e21b53e4b40afa241df30eebd65e6214162c3a494d44c47be5"} build_url:https://queue.taskcluster.net/v1/task/N4UspfSeTtKWuzobmzInBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011284 build_url: 'https://queue.taskcluster.net/v1/task/N4UspfSeTtKWuzobmzInBA/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/B2G-Inbound/sha512/7274fb8b71d82ede2435356834af4f19104ddeb00eaab7df2c85f603cdd9c1adffc3e3c53b35c39d9e0214fa41a73aaa79db3c3ea77aeff3f1f4f3212a797f22", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/bb7ffc696abdd8366f47a87b3b5a5269d67025cbab8b50532bbf48ff88bf57c142d76a4c4e16d6e21b53e4b40afa241df30eebd65e6214162c3a494d44c47be5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 19:58:48.606766) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 19:58:48.607102) ========= 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=0cff312cb257a7829adc5a5d000001df-1450840521.788027-651438517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 19:58:48.690520) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 19:58:48.690868) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 19:58:48.691227) ========= ========= Total master_lag: 0.24 =========