builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1450842569.4 results: success (0) buildid: 20151222173024 builduid: 3503a0e3834148738d8b7c13e01855d7 revision: 42981261603ec5de439bc7b92dcec94b5c0af1ba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 19:49:29.403892) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 19:49:29.404401) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 19:49:29.404755) ========= 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=61fa6ed41387771909ec0f71000001b3-1450841433.195363-717746533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006283 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 19:49:29.431841) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 19:49:29.432170) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 19:49:29.450619) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 19:49:29.450963) ========= 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=61fa6ed41387771909ec0f71000001b3-1450841433.195363-717746533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004671 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 19:49:29.503019) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 19:49:29.503398) ========= 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:49:29.503935) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 19:49:29.504352) ========= 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=61fa6ed41387771909ec0f71000001b3-1450841433.195363-717746533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-22 19:49: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% 221M=0s 2015-12-22 19:49:29 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160765 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 19:49:29.677664) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 19:49:29.678009) ========= 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=61fa6ed41387771909ec0f71000001b3-1450841433.195363-717746533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018676 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 19:49:29.727677) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 19:49:29.728032) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 42981261603ec5de439bc7b92dcec94b5c0af1ba --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 42981261603ec5de439bc7b92dcec94b5c0af1ba --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=61fa6ed41387771909ec0f71000001b3-1450841433.195363-717746533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-22 19:49:30,077 truncating revision to first 12 chars 2015-12-22 19:49:30,077 Setting DEBUG logging. 2015-12-22 19:49:30,077 attempt 1/10 2015-12-22 19:49:30,077 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/42981261603e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-22 19:49:30,302 unpacking tar archive at: fx-team-42981261603e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.465688 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 19:49:30.207336) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 19:49:30.207673) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 19:49:30.216681) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 19:49:30.217014) ========= 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:49:30.217491) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-22 19:49:30.217810) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=61fa6ed41387771909ec0f71000001b3-1450841433.195363-717746533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:49:30 INFO - MultiFileLogger online at 20151222 19:49:30 in /builds/slave/test-pgo 19:49:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:49:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:49:30 INFO - {'append_to_log': False, 19:49:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:49:30 INFO - 'blob_upload_branch': 'Fx-Team', 19:49:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:49:30 INFO - 'branch': 'Fx-Team', 19:49:30 INFO - 'buildbot_json_path': 'buildprops.json', 19:49:30 INFO - 'config_files': ('talos/linux_config.py',), 19:49:30 INFO - 'default_actions': ('clobber', 19:49:30 INFO - 'read-buildbot-config', 19:49:30 INFO - 'download-and-extract', 19:49:30 INFO - 'populate-webroot', 19:49:30 INFO - 'create-virtualenv', 19:49:30 INFO - 'install', 19:49:30 INFO - 'run-tests'), 19:49:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:49:30 INFO - 'download_minidump_stackwalk': True, 19:49:30 INFO - 'download_symbols': 'ondemand', 19:49:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:49:30 INFO - 'tooltool.py': '/tools/tooltool.py', 19:49:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:49:30 INFO - '/tools/misc-python/virtualenv.py')}, 19:49:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:49:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:49:30 INFO - 'installer_path': 'installer.exe', 19:49:30 INFO - 'log_level': 'info', 19:49:30 INFO - 'log_name': 'talos', 19:49:30 INFO - 'log_to_console': True, 19:49:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:49:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:49:30 INFO - 'opt_config_files': (), 19:49:30 INFO - 'pip_index': False, 19:49:30 INFO - 'sps_profile': False, 19:49:30 INFO - 'sps_profile_interval': 0, 19:49:30 INFO - 'suite': 'dromaeojs', 19:49:30 INFO - 'system_bits': '64', 19:49:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:49:30 INFO - 'title': 'talos-linux64-ix-045', 19:49:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:49:30 INFO - 'use_talos_json': True, 19:49:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:49:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:49:30 INFO - 'work_dir': 'build'} 19:49:30 INFO - ##### 19:49:30 INFO - ##### Running clobber step. 19:49:30 INFO - ##### 19:49:30 INFO - Running pre-action listener: _resource_record_pre_action 19:49:30 INFO - Running main action method: clobber 19:49:30 INFO - rmtree: /builds/slave/test-pgo/build 19:49:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:49:31 INFO - Running post-action listener: _resource_record_post_action 19:49:31 INFO - ##### 19:49:31 INFO - ##### Running read-buildbot-config step. 19:49:31 INFO - ##### 19:49:31 INFO - Running pre-action listener: _resource_record_pre_action 19:49:31 INFO - Running main action method: read_buildbot_config 19:49:31 INFO - Using buildbot properties: 19:49:31 INFO - { 19:49:31 INFO - "project": "", 19:49:31 INFO - "product": "firefox", 19:49:31 INFO - "script_repo_revision": "production", 19:49:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:49:31 INFO - "repository": "", 19:49:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:49:31 INFO - "buildid": "20151222173024", 19:49:31 INFO - "pgo_build": "True", 19:49:31 INFO - "basedir": "/builds/slave/test-pgo", 19:49:31 INFO - "buildnumber": 847, 19:49:31 INFO - "slavename": "talos-linux64-ix-045", 19:49:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:49:31 INFO - "platform": "ubuntu64_hw", 19:49:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:49:31 INFO - "branch": "fx-team", 19:49:31 INFO - "repo_path": "integration/fx-team", 19:49:31 INFO - "revision": "42981261603ec5de439bc7b92dcec94b5c0af1ba", 19:49:31 INFO - "stage_platform": "linux64-pgo", 19:49:31 INFO - "builduid": "3503a0e3834148738d8b7c13e01855d7", 19:49:31 INFO - "slavebuilddir": "test" 19:49:31 INFO - } 19:49:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ez2rtVYESnekAjO3b5jwCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:49:31 INFO - Running post-action listener: _resource_record_post_action 19:49:31 INFO - ##### 19:49:31 INFO - ##### Running download-and-extract step. 19:49:31 INFO - ##### 19:49:31 INFO - Running pre-action listener: _resource_record_pre_action 19:49:31 INFO - Running main action method: download_and_extract 19:49:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:31 INFO - https://queue.taskcluster.net/v1/task/Ez2rtVYESnekAjO3b5jwCA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:49:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ez2rtVYESnekAjO3b5jwCA/artifacts/public/build/test_packages.json 19:49:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ez2rtVYESnekAjO3b5jwCA/artifacts/public/build/test_packages.json 19:49:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ez2rtVYESnekAjO3b5jwCA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:49:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ez2rtVYESnekAjO3b5jwCA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:49:31 INFO - Downloaded 1302 bytes. 19:49:31 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:49:31 INFO - Using the following test package requirements: 19:49:31 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:49:31 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:49:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:49:31 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:49:31 INFO - u'jsshell-linux-x86_64.zip'], 19:49:31 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:49:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:49:31 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:49:31 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:49:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:49:31 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:49:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:49:31 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:49:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:49:31 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:49:31 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:49:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:49:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:31 INFO - https://queue.taskcluster.net/v1/task/Ez2rtVYESnekAjO3b5jwCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:49:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ez2rtVYESnekAjO3b5jwCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:49:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ez2rtVYESnekAjO3b5jwCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:49:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ez2rtVYESnekAjO3b5jwCA/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:49:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ez2rtVYESnekAjO3b5jwCA/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:49:45 INFO - Downloaded 23175754 bytes. 19:49:45 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:49:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:49:45 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:49:46 INFO - Return code: 0 19:49:46 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:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:46 INFO - https://queue.taskcluster.net/v1/task/Ez2rtVYESnekAjO3b5jwCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:49:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ez2rtVYESnekAjO3b5jwCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:49:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ez2rtVYESnekAjO3b5jwCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:49:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ez2rtVYESnekAjO3b5jwCA/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:49:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ez2rtVYESnekAjO3b5jwCA/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:49:48 INFO - Downloaded 23175754 bytes. 19:49:48 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:49:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:49:48 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:49:49 INFO - Return code: 0 19:49: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:49:49 INFO - https://queue.taskcluster.net/v1/task/Ez2rtVYESnekAjO3b5jwCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:49:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ez2rtVYESnekAjO3b5jwCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:49:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ez2rtVYESnekAjO3b5jwCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:49:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ez2rtVYESnekAjO3b5jwCA/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:49:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ez2rtVYESnekAjO3b5jwCA/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:49:50 INFO - Downloaded 11132277 bytes. 19:49:50 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:49:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:49:50 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:49:50 INFO - Return code: 0 19:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:50 INFO - https://queue.taskcluster.net/v1/task/Ez2rtVYESnekAjO3b5jwCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:49:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ez2rtVYESnekAjO3b5jwCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:49:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ez2rtVYESnekAjO3b5jwCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:49:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ez2rtVYESnekAjO3b5jwCA/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:49:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ez2rtVYESnekAjO3b5jwCA/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:49:52 INFO - Downloaded 54919157 bytes. 19:49:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ez2rtVYESnekAjO3b5jwCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:49:52 INFO - mkdir: /builds/slave/test-pgo/properties 19:49:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:49:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:49:52 INFO - Contents: 19:49:52 INFO - build_url:https://queue.taskcluster.net/v1/task/Ez2rtVYESnekAjO3b5jwCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:49:52 INFO - Running post-action listener: _resource_record_post_action 19:49:52 INFO - Running post-action listener: set_extra_try_arguments 19:49:52 INFO - ##### 19:49:52 INFO - ##### Running populate-webroot step. 19:49:52 INFO - ##### 19:49:52 INFO - Running pre-action listener: _resource_record_pre_action 19:49:52 INFO - Running main action method: populate_webroot 19:49:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:49:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:49:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:49:52 INFO - '--tppagecycles', 19:49:52 INFO - '7'], 19:49:52 INFO - 'tests': ['tsvgm']}}, 19:49:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:49:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:49:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:49:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:49:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:49:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:49:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:49:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:52 INFO - 'talos_options': ['--e10s'], 19:49:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:49:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:52 INFO - 'tests': ['damp', 'tps']}, 19:49:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:52 INFO - 'talos_options': ['--e10s'], 19:49:52 INFO - 'tests': ['damp', 'tps']}, 19:49:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:49:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:49:52 INFO - 'other': {'tests': ['a11yr', 19:49:52 INFO - 'ts_paint', 19:49:52 INFO - 'tpaint', 19:49:52 INFO - 'sessionrestore', 19:49:52 INFO - 'sessionrestore_no_auto_restore']}, 19:49:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:49:52 INFO - 'tests': ['a11yr', 19:49:52 INFO - 'ts_paint', 19:49:52 INFO - 'tpaint', 19:49:52 INFO - 'sessionrestore', 19:49:52 INFO - 'sessionrestore_no_auto_restore']}, 19:49:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:49:52 INFO - 'tests': ['a11yr', 19:49:52 INFO - 'ts_paint', 19:49:52 INFO - 'tpaint', 19:49:52 INFO - 'sessionrestore', 19:49:52 INFO - 'sessionrestore_no_auto_restore']}, 19:49:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:49:52 INFO - 'tests': ['a11yr', 19:49:52 INFO - 'ts_paint', 19:49:52 INFO - 'tpaint', 19:49:52 INFO - 'sessionrestore', 19:49:52 INFO - 'sessionrestore_no_auto_restore']}, 19:49:52 INFO - 'other_l64': {'tests': ['a11yr', 19:49:52 INFO - 'ts_paint', 19:49:52 INFO - 'tpaint', 19:49:52 INFO - 'sessionrestore', 19:49:52 INFO - 'sessionrestore_no_auto_restore']}, 19:49:52 INFO - 'other_nol64': {'tests': ['a11yr', 19:49:52 INFO - 'ts_paint', 19:49:52 INFO - 'tpaint', 19:49:52 INFO - 'sessionrestore', 19:49:52 INFO - 'sessionrestore_no_auto_restore']}, 19:49:52 INFO - 'svgr': {'tests': ['tsvgx', 19:49:52 INFO - 'tsvgr_opacity', 19:49:52 INFO - 'tart', 19:49:52 INFO - 'tscrollx', 19:49:52 INFO - 'cart']}, 19:49:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:49:52 INFO - 'tests': ['tsvgx', 19:49:52 INFO - 'tsvgr_opacity', 19:49:52 INFO - 'tart', 19:49:52 INFO - 'tscrollx', 19:49:52 INFO - 'cart']}, 19:49:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:52 INFO - 'tests': ['tp5o']}, 19:49:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:52 INFO - 'talos_options': ['--e10s'], 19:49:52 INFO - 'tests': ['tp5o']}, 19:49:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:52 INFO - 'talos_options': ['--xperf_path', 19:49:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:49:52 INFO - 'tests': ['tp5n']}, 19:49:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:52 INFO - 'talos_options': ['--e10s', 19:49:52 INFO - '--xperf_path', 19:49:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:49:52 INFO - 'tests': ['tp5n']}}, 19:49:52 INFO - 'talos.zip': {'path': '', 19:49:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:49:52 INFO - Running post-action listener: _resource_record_post_action 19:49:52 INFO - ##### 19:49:52 INFO - ##### Running create-virtualenv step. 19:49:52 INFO - ##### 19:49:52 INFO - Running pre-action listener: _resource_record_pre_action 19:49:52 INFO - Running main action method: create_virtualenv 19:49:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:49:52 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:49:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:49:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:49:52 INFO - Using real prefix '/usr' 19:49:52 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:49:52 INFO - Installing distribute.............................................................................................................................................................................................done. 19:49:54 INFO - Installing pip.................done. 19:49:54 INFO - Return code: 0 19:49:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:49: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:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49: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:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4685ff4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c77840>, '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 0x2be46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4b60>, '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': '61fa6ed41387771909ec0f71000001b3-1450841433.195363-717746533', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:49: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 19:49: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 pip>=1.5 19:49:54 INFO - Using env: {'DISPLAY': ':0', 19:49:54 INFO - 'HOME': '/home/cltbld', 19:49:54 INFO - 'LANG': 'en_US.UTF-8', 19:49:54 INFO - 'LANGUAGE': 'en_US:en', 19:49:54 INFO - 'LOGNAME': 'cltbld', 19:49:54 INFO - 'MAIL': '/var/mail/cltbld', 19:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:54 INFO - 'MOZ_NO_REMOTE': '1', 19:49:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:54 INFO - 'NO_EM_RESTART': '1', 19:49:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:54 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:54 INFO - 'SHELL': '/bin/bash', 19:49:54 INFO - 'SHLVL': '1', 19:49:54 INFO - 'TERM': 'linux', 19:49:54 INFO - 'TMOUT': '86400', 19:49:54 INFO - 'USER': 'cltbld', 19:49:54 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450841433.195363-717746533', 19:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:54 INFO - '_': '/tools/buildbot/bin/python'} 19:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:55 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:49:55 INFO - Cleaning up... 19:49:55 INFO - Return code: 0 19:49:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:55 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 0x7f4685ff4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c77840>, '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 0x2be46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4b60>, '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': '61fa6ed41387771909ec0f71000001b3-1450841433.195363-717746533', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:49:55 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:49:55 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:49:55 INFO - Using env: {'DISPLAY': ':0', 19:49:55 INFO - 'HOME': '/home/cltbld', 19:49:55 INFO - 'LANG': 'en_US.UTF-8', 19:49:55 INFO - 'LANGUAGE': 'en_US:en', 19:49:55 INFO - 'LOGNAME': 'cltbld', 19:49:55 INFO - 'MAIL': '/var/mail/cltbld', 19:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:55 INFO - 'MOZ_NO_REMOTE': '1', 19:49:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:55 INFO - 'NO_EM_RESTART': '1', 19:49:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:55 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:55 INFO - 'SHELL': '/bin/bash', 19:49:55 INFO - 'SHLVL': '1', 19:49:55 INFO - 'TERM': 'linux', 19:49:55 INFO - 'TMOUT': '86400', 19:49:55 INFO - 'USER': 'cltbld', 19:49:55 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450841433.195363-717746533', 19:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:55 INFO - '_': '/tools/buildbot/bin/python'} 19:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:55 INFO - Downloading/unpacking psutil>=0.7.1 19:49: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:49: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:49: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:49: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:49: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:49: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:49:56 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:49:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:49:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:49:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:49:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:49:57 INFO - Installing collected packages: psutil 19:49:57 INFO - Running setup.py install for psutil 19:49:57 INFO - building 'psutil._psutil_linux' extension 19:49:57 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:49:57 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:49:57 INFO - building 'psutil._psutil_posix' extension 19:49:57 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:49:57 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:49:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:49:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:49:57 INFO - Successfully installed psutil 19:49:57 INFO - Cleaning up... 19:49:57 INFO - Return code: 0 19:49:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:49: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:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49: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:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49: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', '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 0x7f4685ff4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c77840>, '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 0x2be46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4b60>, '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': '61fa6ed41387771909ec0f71000001b3-1450841433.195363-717746533', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:49: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 19:49: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 mozsystemmonitor==0.0.0 19:49:57 INFO - Using env: {'DISPLAY': ':0', 19:49:57 INFO - 'HOME': '/home/cltbld', 19:49:57 INFO - 'LANG': 'en_US.UTF-8', 19:49:57 INFO - 'LANGUAGE': 'en_US:en', 19:49:57 INFO - 'LOGNAME': 'cltbld', 19:49:57 INFO - 'MAIL': '/var/mail/cltbld', 19:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:57 INFO - 'MOZ_NO_REMOTE': '1', 19:49:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:57 INFO - 'NO_EM_RESTART': '1', 19:49:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:57 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:57 INFO - 'SHELL': '/bin/bash', 19:49:57 INFO - 'SHLVL': '1', 19:49:57 INFO - 'TERM': 'linux', 19:49:57 INFO - 'TMOUT': '86400', 19:49:57 INFO - 'USER': 'cltbld', 19:49:57 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450841433.195363-717746533', 19:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:57 INFO - '_': '/tools/buildbot/bin/python'} 19:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:49: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:49: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:49: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:49: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:49: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:49: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:49:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:49:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:49:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:49:59 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:49:59 INFO - Installing collected packages: mozsystemmonitor 19:49:59 INFO - Running setup.py install for mozsystemmonitor 19:49:59 INFO - Successfully installed mozsystemmonitor 19:49:59 INFO - Cleaning up... 19:49:59 INFO - Return code: 0 19:49:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:59 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 0x7f4685ff4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c77840>, '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 0x2be46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4b60>, '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': '61fa6ed41387771909ec0f71000001b3-1450841433.195363-717746533', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:49:59 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:49:59 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:49:59 INFO - Using env: {'DISPLAY': ':0', 19:49:59 INFO - 'HOME': '/home/cltbld', 19:49:59 INFO - 'LANG': 'en_US.UTF-8', 19:49:59 INFO - 'LANGUAGE': 'en_US:en', 19:49:59 INFO - 'LOGNAME': 'cltbld', 19:49:59 INFO - 'MAIL': '/var/mail/cltbld', 19:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:59 INFO - 'MOZ_NO_REMOTE': '1', 19:49:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:59 INFO - 'NO_EM_RESTART': '1', 19:49:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:49:59 INFO - 'PWD': '/builds/slave/test-pgo', 19:49:59 INFO - 'SHELL': '/bin/bash', 19:49:59 INFO - 'SHLVL': '1', 19:49:59 INFO - 'TERM': 'linux', 19:49:59 INFO - 'TMOUT': '86400', 19:49:59 INFO - 'USER': 'cltbld', 19:49:59 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450841433.195363-717746533', 19:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:59 INFO - '_': '/tools/buildbot/bin/python'} 19:49:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:59 INFO - Downloading/unpacking blobuploader==1.2.4 19:49: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:49: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:49: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:49: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:49: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:49: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:50:01 INFO - Downloading blobuploader-1.2.4.tar.gz 19:50:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:50:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:50:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:50:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:50:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:02 INFO - Downloading docopt-0.6.1.tar.gz 19:50:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:50:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:50:02 INFO - Installing collected packages: blobuploader, requests, docopt 19:50:02 INFO - Running setup.py install for blobuploader 19:50:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:50:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:50:02 INFO - Running setup.py install for requests 19:50:02 INFO - Running setup.py install for docopt 19:50:02 INFO - Successfully installed blobuploader requests docopt 19:50:02 INFO - Cleaning up... 19:50:02 INFO - Return code: 0 19:50:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4685ff4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c77840>, '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 0x2be46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4b60>, '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': '61fa6ed41387771909ec0f71000001b3-1450841433.195363-717746533', '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:50:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 19:50:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:50:02 INFO - Using env: {'DISPLAY': ':0', 19:50:02 INFO - 'HOME': '/home/cltbld', 19:50:02 INFO - 'LANG': 'en_US.UTF-8', 19:50:02 INFO - 'LANGUAGE': 'en_US:en', 19:50:02 INFO - 'LOGNAME': 'cltbld', 19:50:02 INFO - 'MAIL': '/var/mail/cltbld', 19:50:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:02 INFO - 'MOZ_NO_REMOTE': '1', 19:50:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:50:02 INFO - 'NO_EM_RESTART': '1', 19:50:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:50:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:50:02 INFO - 'PWD': '/builds/slave/test-pgo', 19:50:02 INFO - 'SHELL': '/bin/bash', 19:50:02 INFO - 'SHLVL': '1', 19:50:02 INFO - 'TERM': 'linux', 19:50:02 INFO - 'TMOUT': '86400', 19:50:02 INFO - 'USER': 'cltbld', 19:50:02 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450841433.195363-717746533', 19:50:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:02 INFO - '_': '/tools/buildbot/bin/python'} 19:50:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:50:03 INFO - Running setup.py (path:/tmp/pip-73Pf7o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:50:03 INFO - Running setup.py (path:/tmp/pip-kKFCwQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:50:03 INFO - Running setup.py (path:/tmp/pip-tSnyvu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:50:03 INFO - Running setup.py (path:/tmp/pip-htl7Qx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:50:03 INFO - Running setup.py (path:/tmp/pip-IhsvJ6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:50:03 INFO - Running setup.py (path:/tmp/pip-IWygRA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:50:03 INFO - Running setup.py (path:/tmp/pip-8InhdM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:50:03 INFO - Running setup.py (path:/tmp/pip-Pz0jfK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:50:03 INFO - Running setup.py (path:/tmp/pip-QcX8jh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:50:03 INFO - Running setup.py (path:/tmp/pip-7sPSy5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:50:03 INFO - Running setup.py (path:/tmp/pip-s_tkoS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:50:03 INFO - Running setup.py (path:/tmp/pip-22aZ5j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:50:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:50:03 INFO - Running setup.py (path:/tmp/pip-l9hWfp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:50:04 INFO - Running setup.py (path:/tmp/pip-AfDAf0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:50:04 INFO - Running setup.py (path:/tmp/pip-0ATWW1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:50:04 INFO - Running setup.py (path:/tmp/pip-VVJlY6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:50:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:50:04 INFO - Running setup.py (path:/tmp/pip-ew6Iks-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:50:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:50:04 INFO - Running setup.py install for manifestparser 19:50:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:50:04 INFO - Running setup.py install for mozcrash 19:50:04 INFO - Running setup.py install for mozdebug 19:50:04 INFO - Running setup.py install for mozdevice 19:50:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:50:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:50:04 INFO - Running setup.py install for mozfile 19:50:04 INFO - Running setup.py install for mozhttpd 19:50:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:50:04 INFO - Running setup.py install for mozinfo 19:50:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:50:05 INFO - Running setup.py install for mozInstall 19:50:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:50:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:50:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:50:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:50:05 INFO - Running setup.py install for mozleak 19:50:05 INFO - Running setup.py install for mozlog 19:50:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:50:05 INFO - Running setup.py install for moznetwork 19:50:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:50:05 INFO - Running setup.py install for mozprocess 19:50:05 INFO - Running setup.py install for mozprofile 19:50:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:50:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:50:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:50:05 INFO - Running setup.py install for mozrunner 19:50:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:50:05 INFO - Running setup.py install for mozscreenshot 19:50:05 INFO - Running setup.py install for moztest 19:50:05 INFO - Running setup.py install for mozversion 19:50:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:50:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:50:06 INFO - Cleaning up... 19:50:06 INFO - Return code: 0 19:50:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f4685ff4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c77840>, '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 0x2be46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4b60>, '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': '61fa6ed41387771909ec0f71000001b3-1450841433.195363-717746533', '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:50:06 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:50:06 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:50:06 INFO - Using env: {'DISPLAY': ':0', 19:50:06 INFO - 'HOME': '/home/cltbld', 19:50:06 INFO - 'LANG': 'en_US.UTF-8', 19:50:06 INFO - 'LANGUAGE': 'en_US:en', 19:50:06 INFO - 'LOGNAME': 'cltbld', 19:50:06 INFO - 'MAIL': '/var/mail/cltbld', 19:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:06 INFO - 'MOZ_NO_REMOTE': '1', 19:50:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:50:06 INFO - 'NO_EM_RESTART': '1', 19:50:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:50:06 INFO - 'PWD': '/builds/slave/test-pgo', 19:50:06 INFO - 'SHELL': '/bin/bash', 19:50:06 INFO - 'SHLVL': '1', 19:50:06 INFO - 'TERM': 'linux', 19:50:06 INFO - 'TMOUT': '86400', 19:50:06 INFO - 'USER': 'cltbld', 19:50:06 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450841433.195363-717746533', 19:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:06 INFO - '_': '/tools/buildbot/bin/python'} 19:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:50:06 INFO - Running setup.py (path:/tmp/pip-elbg7B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:50:06 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:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:50:06 INFO - Running setup.py (path:/tmp/pip-EUOe_7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:50:06 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:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:50:06 INFO - Running setup.py (path:/tmp/pip-aPRfb4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:50:06 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:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:50:06 INFO - Running setup.py (path:/tmp/pip-Q0CvfC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:50:06 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:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:50:06 INFO - Running setup.py (path:/tmp/pip-TC4krU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:50:06 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:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:50:06 INFO - Running setup.py (path:/tmp/pip-j1eZgv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:50:06 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:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:50:06 INFO - Running setup.py (path:/tmp/pip-0k3vYA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:50:06 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:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:50:06 INFO - Running setup.py (path:/tmp/pip-FiBpbb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 19:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:50:06 INFO - Running setup.py (path:/tmp/pip-dog1Zf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 19:50:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:50:06 INFO - Running setup.py (path:/tmp/pip-zc2KC4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:50:07 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:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:50:07 INFO - Running setup.py (path:/tmp/pip-8Et7SP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:50:07 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:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:50:07 INFO - Running setup.py (path:/tmp/pip-MWct0u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:50:07 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:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:50:07 INFO - Running setup.py (path:/tmp/pip-7_rykz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:50:07 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:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:50:07 INFO - Running setup.py (path:/tmp/pip-ukV4Gn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:50:07 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:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:50:07 INFO - Running setup.py (path:/tmp/pip-J49jYR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:50:07 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:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:50:07 INFO - Running setup.py (path:/tmp/pip-rZOVoW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:50:07 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:50:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:50:07 INFO - Running setup.py (path:/tmp/pip-_RQKiB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:50:07 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:50:07 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:50:07 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:50:07 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:50: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 mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:50:07 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:50:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:50: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:50: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:50: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:50: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:50: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:50: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:50:09 INFO - Downloading blessings-1.5.1.tar.gz 19:50:09 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:50:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:50:09 INFO - Installing collected packages: blessings 19:50:09 INFO - Running setup.py install for blessings 19:50:09 INFO - Successfully installed blessings 19:50:09 INFO - Cleaning up... 19:50:09 INFO - Return code: 0 19:50:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:50:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:50:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:50:09 INFO - Reading from file tmpfile_stdout 19:50:09 INFO - Current package versions: 19:50:09 INFO - argparse == 1.2.1 19:50:09 INFO - blessings == 1.5.1 19:50:09 INFO - blobuploader == 1.2.4 19:50:09 INFO - docopt == 0.6.1 19:50:09 INFO - manifestparser == 1.1 19:50:09 INFO - mozInstall == 1.12 19:50:09 INFO - mozcrash == 0.16 19:50:09 INFO - mozdebug == 0.1 19:50:09 INFO - mozdevice == 0.47 19:50:09 INFO - mozfile == 1.2 19:50:09 INFO - mozhttpd == 0.7 19:50:09 INFO - mozinfo == 0.9 19:50:09 INFO - mozleak == 0.1 19:50:09 INFO - mozlog == 3.1 19:50:09 INFO - moznetwork == 0.27 19:50:09 INFO - mozprocess == 0.22 19:50:09 INFO - mozprofile == 0.28 19:50:09 INFO - mozrunner == 6.11 19:50:09 INFO - mozscreenshot == 0.1 19:50:09 INFO - mozsystemmonitor == 0.0 19:50:09 INFO - moztest == 0.7 19:50:09 INFO - mozversion == 1.4 19:50:09 INFO - psutil == 3.1.1 19:50:09 INFO - requests == 1.2.3 19:50:09 INFO - wsgiref == 0.1.2 19:50:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:50: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:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50: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:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50: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', '-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 0x7f4685ff4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c77840>, '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 0x2be46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4b60>, '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': '61fa6ed41387771909ec0f71000001b3-1450841433.195363-717746533', '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:50:09 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:50:09 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:50:09 INFO - Using env: {'DISPLAY': ':0', 19:50:09 INFO - 'HOME': '/home/cltbld', 19:50:09 INFO - 'LANG': 'en_US.UTF-8', 19:50:09 INFO - 'LANGUAGE': 'en_US:en', 19:50:09 INFO - 'LOGNAME': 'cltbld', 19:50:09 INFO - 'MAIL': '/var/mail/cltbld', 19:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:09 INFO - 'MOZ_NO_REMOTE': '1', 19:50:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:50:09 INFO - 'NO_EM_RESTART': '1', 19:50:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:50:09 INFO - 'PWD': '/builds/slave/test-pgo', 19:50:09 INFO - 'SHELL': '/bin/bash', 19:50:09 INFO - 'SHLVL': '1', 19:50:09 INFO - 'TERM': 'linux', 19:50:09 INFO - 'TMOUT': '86400', 19:50:09 INFO - 'USER': 'cltbld', 19:50:09 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450841433.195363-717746533', 19:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:09 INFO - '_': '/tools/buildbot/bin/python'} 19:50:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 19:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 19:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 19:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 19:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 19:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 19:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 19:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 19:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:50:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 19:50:09 INFO - Cleaning up... 19:50:09 INFO - Return code: 0 19:50:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:50: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:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50: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:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4685ff4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c77840>, '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 0x2be46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4b60>, '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': '61fa6ed41387771909ec0f71000001b3-1450841433.195363-717746533', '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:50:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 19:50:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:50:09 INFO - Using env: {'DISPLAY': ':0', 19:50:09 INFO - 'HOME': '/home/cltbld', 19:50:09 INFO - 'LANG': 'en_US.UTF-8', 19:50:09 INFO - 'LANGUAGE': 'en_US:en', 19:50:09 INFO - 'LOGNAME': 'cltbld', 19:50:09 INFO - 'MAIL': '/var/mail/cltbld', 19:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:09 INFO - 'MOZ_NO_REMOTE': '1', 19:50:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:50:09 INFO - 'NO_EM_RESTART': '1', 19:50:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:50:09 INFO - 'PWD': '/builds/slave/test-pgo', 19:50:09 INFO - 'SHELL': '/bin/bash', 19:50:09 INFO - 'SHLVL': '1', 19:50:09 INFO - 'TERM': 'linux', 19:50:09 INFO - 'TMOUT': '86400', 19:50:09 INFO - 'USER': 'cltbld', 19:50:09 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450841433.195363-717746533', 19:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:09 INFO - '_': '/tools/buildbot/bin/python'} 19:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:10 INFO - Downloading/unpacking jsonschema 19:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:50:11 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:50:11 INFO - Downloading/unpacking functools32 (from jsonschema) 19:50: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:50: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:50: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:50: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:50: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:50: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:50:12 INFO - Downloading functools32-3.2.3-2.tar.gz 19:50:12 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:50:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:50:12 INFO - warning: no files found matching '*.txt' 19:50:12 INFO - no previously-included directories found matching 'build' 19:50:12 INFO - no previously-included directories found matching 'dist' 19:50:12 INFO - no previously-included directories found matching '.git*' 19:50:12 INFO - Installing collected packages: jsonschema, functools32 19:50:12 INFO - Running setup.py install for functools32 19:50:12 INFO - warning: no files found matching '*.txt' 19:50:12 INFO - no previously-included directories found matching 'build' 19:50:12 INFO - no previously-included directories found matching 'dist' 19:50:12 INFO - no previously-included directories found matching '.git*' 19:50:12 INFO - Successfully installed jsonschema functools32 19:50:12 INFO - Cleaning up... 19:50:12 INFO - Return code: 0 19:50:12 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:50:12 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:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:12 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:50:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:12 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 0x7f4685ff4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c77840>, '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 0x2be46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4b60>, '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': '61fa6ed41387771909ec0f71000001b3-1450841433.195363-717746533', '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:50:12 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:50:12 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:50:12 INFO - Using env: {'DISPLAY': ':0', 19:50:12 INFO - 'HOME': '/home/cltbld', 19:50:12 INFO - 'LANG': 'en_US.UTF-8', 19:50:12 INFO - 'LANGUAGE': 'en_US:en', 19:50:12 INFO - 'LOGNAME': 'cltbld', 19:50:12 INFO - 'MAIL': '/var/mail/cltbld', 19:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:12 INFO - 'MOZ_NO_REMOTE': '1', 19:50:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:50:12 INFO - 'NO_EM_RESTART': '1', 19:50:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:50:12 INFO - 'PWD': '/builds/slave/test-pgo', 19:50:12 INFO - 'SHELL': '/bin/bash', 19:50:12 INFO - 'SHLVL': '1', 19:50:12 INFO - 'TERM': 'linux', 19:50:12 INFO - 'TMOUT': '86400', 19:50:12 INFO - 'USER': 'cltbld', 19:50:12 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450841433.195363-717746533', 19:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:12 INFO - '_': '/tools/buildbot/bin/python'} 19:50:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:12 INFO - Downloading/unpacking flake8 19:50: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:50: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:50: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:50: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:50: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:50: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:50:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:50:14 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:50:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:50:14 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:50:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:14 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:50:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:50:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:50:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:50:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:50:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:50:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:50:14 INFO - no previously-included directories found matching 'docs/_build' 19:50:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:50:14 INFO - Running setup.py install for pep8 19:50:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:50:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:50:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:50:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:50:14 INFO - no previously-included directories found matching 'docs/_build' 19:50:15 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:50:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:50:15 INFO - Cleaning up... 19:50:15 INFO - Return code: 0 19:50:15 INFO - Running post-action listener: _resource_record_post_action 19:50:15 INFO - Running post-action listener: _start_resource_monitoring 19:50:15 INFO - Starting resource monitoring. 19:50:15 INFO - ##### 19:50:15 INFO - ##### Running install step. 19:50:15 INFO - ##### 19:50:15 INFO - Running pre-action listener: _resource_record_pre_action 19:50:15 INFO - Running main action method: install 19:50:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:50:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:50:15 INFO - Reading from file tmpfile_stdout 19:50:15 INFO - Detecting whether we're running mozinstall >=1.0... 19:50:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:50:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:50:15 INFO - Reading from file tmpfile_stdout 19:50:15 INFO - Output received: 19:50:15 INFO - Usage: mozinstall [options] installer 19:50:15 INFO - Options: 19:50:15 INFO - -h, --help show this help message and exit 19:50:15 INFO - -d DEST, --destination=DEST 19:50:15 INFO - Directory to install application into. [default: 19:50:15 INFO - "/builds/slave/test-pgo"] 19:50:15 INFO - --app=APP Application being installed. [default: firefox] 19:50:15 INFO - mkdir: /builds/slave/test-pgo/build/application 19:50:15 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:50:15 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:50:31 INFO - Reading from file tmpfile_stdout 19:50:31 INFO - Output received: 19:50:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:50:31 INFO - Running post-action listener: _resource_record_post_action 19:50:31 INFO - ##### 19:50:31 INFO - ##### Running run-tests step. 19:50:31 INFO - ##### 19:50:31 INFO - Running pre-action listener: _resource_record_pre_action 19:50:31 INFO - Running main action method: run_tests 19:50:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:50:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:50:31 INFO - Python 2.7.3 19:50:31 INFO - Return code: 0 19:50:31 INFO - grabbing minidump binary from tooltool 19:50:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:31 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 0x2c77840>, '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 0x2be46b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be4b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:50:31 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:50:31 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:50:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:50:31 INFO - Return code: 0 19:50:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:50:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:50:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:50:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:50:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:50:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:50:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:50:32 INFO - Return code: 0 19:50:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ez2rtVYESnekAjO3b5jwCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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:50:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ez2rtVYESnekAjO3b5jwCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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:50:32 INFO - Using env: {'DISPLAY': ':0', 19:50:32 INFO - 'HOME': '/home/cltbld', 19:50:32 INFO - 'LANG': 'en_US.UTF-8', 19:50:32 INFO - 'LANGUAGE': 'en_US:en', 19:50:32 INFO - 'LOGNAME': 'cltbld', 19:50:32 INFO - 'MAIL': '/var/mail/cltbld', 19:50:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:50:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:50:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:32 INFO - 'MOZ_NO_REMOTE': '1', 19:50:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:50:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:50:32 INFO - 'NO_EM_RESTART': '1', 19:50:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:50:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:50:32 INFO - 'PWD': '/builds/slave/test-pgo', 19:50:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:50:32 INFO - 'SHELL': '/bin/bash', 19:50:32 INFO - 'SHLVL': '1', 19:50:32 INFO - 'TERM': 'linux', 19:50:32 INFO - 'TMOUT': '86400', 19:50:32 INFO - 'USER': 'cltbld', 19:50:32 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450841433.195363-717746533', 19:50:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:32 INFO - '_': '/tools/buildbot/bin/python'} 19:50:32 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ez2rtVYESnekAjO3b5jwCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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:50:32 INFO - mozversion application_buildid: 20151222173024 19:50:32 INFO - mozversion application_changeset: 42981261603ec5de439bc7b92dcec94b5c0af1ba 19:50:32 INFO - mozversion application_display_name: Nightly 19:50:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:50:32 INFO - mozversion application_name: Firefox 19:50:32 INFO - mozversion application_remotingname: firefox 19:50:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:50:32 INFO - mozversion application_vendor: Mozilla 19:50:32 INFO - mozversion application_version: 46.0a1 19:50:32 INFO - mozversion platform_buildid: 20151222173024 19:50:32 INFO - mozversion platform_changeset: 42981261603ec5de439bc7b92dcec94b5c0af1ba 19:50:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:50:32 INFO - mozversion platform_version: 46.0a1 19:50:32 INFO - using testdate: 1450842632 19:50:32 INFO - actual date: 1450842632 19:50:32 INFO - starting webserver on 'localhost:53746' 19:50:32 INFO - SUITE-START | Running 3 tests 19:50:32 INFO - TEST-START | dromaeo_css 19:50:32 INFO - operating with platform_type : linux_ 19:50:32 INFO - Initialising browser for dromaeo_css test... 19:50:32 INFO - TEST-INFO | started process 14609 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8S0Ecy/profile http://localhost:53746/getInfo.html) 19:50:36 INFO - PROCESS | 14609 | __metrics Screen width/height:1600/1200 19:50:36 INFO - PROCESS | 14609 | colorDepth:24 19:50:36 INFO - PROCESS | 14609 | Browser inner width/height: 1024/697 19:50:36 INFO - PROCESS | 14609 | __metrics 19:50:37 INFO - PROCESS | 14609 | 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:50:37 INFO - PROCESS | 14609 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:50:37 INFO - TEST-INFO | 14609: exit 0 19:50:37 INFO - Browser initialized. 19:50:37 INFO - Running cycle 1/1 for dromaeo_css test... 19:50:37 INFO - TEST-INFO | started process 14704 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8S0Ecy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:50:49 INFO - PROCESS | 14704 | RSS: Main: 150286336 19:50:49 INFO - PROCESS | 14704 | 19:51:41 INFO - PROCESS | 14704 | 1450842701265 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:53:50 INFO - PROCESS | 14704 | Cycle 1(1): loaded http://localhost:53746/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53746/tests/dromaeo/cssquery-ext.html) 19:53:51 INFO - PROCESS | 14704 | RSS: Main: 274513920 19:53:51 INFO - PROCESS | 14704 | 19:56:53 INFO - PROCESS | 14704 | Cycle 1(1): loaded http://localhost:53746/tests/dromaeo/cssquery-ext.html (next: http://localhost:53746/tests/dromaeo/cssquery-jquery.html) 19:56:54 INFO - PROCESS | 14704 | RSS: Main: 233508864 19:56:54 INFO - PROCESS | 14704 | 19:59:56 INFO - PROCESS | 14704 | Cycle 1(1): loaded http://localhost:53746/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53746/tests/dromaeo/cssquery-mootools.html) 19:59:56 INFO - PROCESS | 14704 | RSS: Main: 225583104 19:59:56 INFO - PROCESS | 14704 | 20:02:58 INFO - PROCESS | 14704 | Cycle 1(1): loaded http://localhost:53746/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53746/tests/dromaeo/cssquery-prototype.html) 20:02:59 INFO - PROCESS | 14704 | RSS: Main: 209637376 20:02:59 INFO - PROCESS | 14704 | 20:06:01 INFO - PROCESS | 14704 | Cycle 1(1): loaded http://localhost:53746/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53746/tests/dromaeo/cssquery-yui.html) 20:06:02 INFO - PROCESS | 14704 | RSS: Main: 212021248 20:06:02 INFO - PROCESS | 14704 | 20:09:05 INFO - PROCESS | 14704 | Cycle 1(1): loaded http://localhost:53746/tests/dromaeo/cssquery-yui.html (next: http://localhost:53746/tests/dromaeo/cssquery-dojo.html) 20:09:05 INFO - PROCESS | 14704 | RSS: Main: 284565504 20:09:05 INFO - PROCESS | 14704 | 20:09:05 INFO - PROCESS | 14704 | __start_tp_report 20:09:05 INFO - PROCESS | 14704 | _x_x_mozilla_page_load 20:09:05 INFO - PROCESS | 14704 | _x_x_mozilla_page_load_details 20:09:05 INFO - PROCESS | 14704 | |i|pagename|runs| 20:09:05 INFO - PROCESS | 14704 | |0;dojo.html;3090.3046814466747;3134.0597820653797;3173.6984986426296;3181.7613678974067;3227.451333273344;5194.584433245341;5312.256284120216;5395.2446657467935;5399.163129714895;5456.61803673743;5281.9207711884355;5308.309919710442;5362.570994320455;5376.247325374451;5378.381486129097;4838.298446725223;4844.563989240967;4858.076965376576;4869.975650121763;4885.462599114095;4941.036497882914;4970.925436118461;4974.850754477371;4993.800247990094;5011.749412529377;4785.880352991186;4811.903761924742;4874.31759553661;4978.576820970222;4990.101781679296;4907.288443175756;4911.238757992481;4920.384951881015;4937.234728617034;4972.03045406146;4884.9267260990755;4893.755312234374;4903.65674402792;4907.582855457291;4971.254311853215;5078.822241221576;5146.794128234867;5156.535911767922;5268.341457317835;5305.628605997582;5825.708714564297;5862.882742345172;5863.442972917566;5868.295804503487;5868.794592189253;5665.3768085510565;5879.353271140214;5896.616719913235;5898.793542226044;5899.351071382144;5361.329833770778;5370.7046112463795;5415.296011518517;5502.202180683778;5548.9722551387795;5960.165576819249;5967.164596956342;5970.910436343458;6003.099535069775;6018;5531.446855314436;5733.598648094593;5736.799212027559;5743.2246646703;5743.6266642668925;5693.430656934273;5766.855828604318;5769.826905192851;5871.9706401468575;5920.348761636216;5791.362950075489;5816.331121920949;5819.127130930395;5819.476247137778;5826.592138550345;5620.803271885465;5825.475707186373;5829.09649004405;5829.5044921181325;5831.183634291203;4405.140997505456;4421.226285400042;4434.312681534368;4491.258942274488;4505.05393867285;3994.8601798936897;3997.060690737674;3999.6200360965663;4002.6197511236387;4043.251998380309;5483.75323110461;5485.451454854562;5486.890262194814;5491.176323551499;5527.55779537636;5639.407862174495;5718;5752.338481074647;5822.854428639318;5836.503897168704;5388.299521062237;5418.133098704188;5422.7017514036315;5427.511523962862;5460.5085542301385;5031.295618613397;5034.949650503521;5037.471065538139;5042.647014708935;5085.237214417867;5731.140328950607;5752.309722833287;5839.153322768175;5855.238818953509;5862.970685146547;5810.448007439287;5814.360420353673;5814.941850581609;5815.302163740378;5820.708964551671;5896.55775816824;5901.085331773582;5901.439363260483;5907.4683278505145;5910.822675319747;5517.613767036269;5562.137868630369;5621.80323688669;5745.8563535911935;5863.970680146572;5808.709564521672;5842.240508734008;5844.064949608212;5849.707514624167;5850.53195744348;5698.686572238401;5704.914426283692;5706.743196556082;5707.315122185364;5707.4577915098;5485.286912701324;5567.276254086943;5580.023495888285;5583.609147359646;5696.430356964271;5476.151196564539;5590.2453168821685;5609.4390560943575;5613.186088017296;5615.691136987341;5704.201411802268;5715.485606295453;5715.8856822864145;5718.571107166896;5725.942740572541;5410.8647283816645;5462.317210348707;5492.423295553909;5492.47821456961;5565.6104072714525 20:09:05 INFO - PROCESS | 14704 | |1;ext.html;571.4476514837127;607.1924340626965;607.9969600151999;611.1871211288986;612.1093808508621;30188.09435716929;31152.68847311526;31158.376832463364;39230;39586.20827583447;43664.781676091654;44047.55952440474;44136.55863441373;44206;44272.55727442724;8694.999999999984;8908.465492070463;8916.73249802507;8917.509536975464;8920.553972301392;7847.725329613465;7866.881996770053;10525;10705.036546710795;10733.624323148691;10374.32566883154;10468.581256749721;10478.68563943079;10483.423411712352;10493;7792.805179870492;7816.179301173409;10330.070293673567;10415.166786657124;10417.635382761604;10552.841707374395;10820.296680715728;10822.080123189538;10823.296485728402;10827.350358978487;39950;40306;40506;40594.18811623751;40644.18711625751;3267.1668724475107;3303.6035675719068;3315.0717799016074;3316.7628155586576;3337.499375093731;30161.396772064654;30429.543556846664;30486.237844053856;30529.542056869166;31311.37377252465;3985.123272879962;4066.207089617526;4096.959030409717;4105.3020986432375;4132.8140233689555;264318;265844;265904;266529;268051.999999998;52348.73825630924;53591.464085359425;60491.69754151201;60889.08666370008;60911.39088609057;55888.441115589136;56135.43864561384;56397.43602564004;56475.152872706945;56544.71727641336;15247.390104395921;15443.227838608249;15445.691086178214;15457.845421545866;15461;11594.420278986017;11669.299842009506;11673.76652466946;11675.88324116765;11687.88312116885;19213.960742885432;20354.79645203529;20414.795852041585;20418.08118634665;20419.28532501385;7872.370210383156;8059.838803223903;8083.797905052421;8097.676092956216;8182.672693092329;958.8178246133212;1032.4373216596973;1032.736652153696;1064.084886997182;1082.7293176705823;27353.179404617895;27913.581296280572;27979;28141.859290703414;28316.716832831407;1038.2213339995003;1063.7181146996052;1066.5573786878513;1085.8425528298353;1155.8728539860608;14757.483488077865;14830.258487075818;14838.109713417229;15001.699966000619;15089;387732;393560;393565;393640;394703;55062.724686377114;55353.723231383585;55376.723116384965;55542.44457555454;55549.444505555235;1328.382302229468;1335.899807514421;1337.037333120152;1344.4958140697238;1371.403439503819;27259.909603615633;27276.31809204786;31964.84017579897;32972.67027329696;33437.49843752297;48928.755356224414;49470.50529494659;49483.75258123686;49524.25713614227;49565;297854;298274;299378;299435;299801;32846;43013.78493107514;43199.56800432081;43517.56482435135;44198;42781.78609106935;43368.78315608528;43389.783051085804;43738.34392484179;43903.560964391225;36237.45643815292;36405;36918.815405922796;40556.18887622172;42343.5765642352;36188.63811361853;37130.8143459281;37635.2472950534;37738;37991;36530.81734591416;36772.44841327329;38360.616393835706;39299.41050884182;39361.80319098386;31097.8445107773;33353.33293334071;33745.493817592265;33797.83101084479;33876.66123338834;25114.497710045332;25569.23292301234;25623.743762562135;25723.311938895647;25936.74063259343 20:09:05 INFO - PROCESS | 14704 | |2;jquery.html;357.70310642167004;359.30295227259114;359.42850867121274;361.0666427285467;361.4921035944497;13947.985901803513;14184.858151418483;16489.422870199545;16849.15754212289;17473.475795726117;14140.646483837909;14241.216733079676;16549.420770273042;16570.66858662826;17445.47663570095;5381.461853814617;5508.7521061552325;5509.035918714229;5513.9448605514035;5518.806841760539;4295.806688699016;5448.45515448454;5465.535429488478;5476.17857321401;5488.121900495921;5326.840194794143;5436.809711660093;5437.374701909272;5440.891182176354;5446.2647542581835;5312.096943519592;5395.541378982772;5400.216968539579;5406.810761623344;5413.756380962866;4766.976165119152;4795.136875362434;4799.664023518355;4803.543663352011;4807.375041244616;19956.3015294464;20168.663737296552;20446.69329960037;21165.153393864228;21278.574428511343;2121.9151233950624;2180.5202855371795;2217.401301648562;2264.241479104502;2726.8909243630233;13035.804462933063;13042.347882605833;13162.868371316355;13337.933310333483;13550.93571685095;1811.275489804089;1814.5463634091477;1830.2130084063847;1853.805350438198;1869.5513076861591;52236.47763522354;58956.705216473645;62348.68825655888;62390.37609623891;62513.37486625121;9631.373960692532;9824.803503930025;9825.066618671215;9866.30935834499;9909.950450247847;12622.81065784014;12698.365081745877;12719.427625756864;12722.363881806057;12748.80876786849;7117.572945623279;7185.389241914391;7231.674574644154;7234.529755565872;7236.819079523054;6818.386345228953;6877;6921.723131074801;6933.653317334113;6939.132608423947;5814;5852.736626851802;5852.882942341129;5853.765849365977;5906.527477801766;1702.0808763267696;1717.6307093974856;1725.9309627614755;1728.9827101729072;1759.3553020027139;923.9790032014528;925.5187302602609;938.9201917837061;1006.773475967916;1007.7077647482295;15945.681086378207;17026.404075857285;17100.144992750313;17186.31254749796;18019.909900450675;917.1607978699549;935.7286386947845;936.438137117724;980.460746589373;1011.6054738651932;9683.515824208762;9888.901110988942;10019.148372388428;10035.79928401428;10039.548220330104;519058;522506;555931;556280;565405;40074.398884016766;64913;83892.58053709692;84239;84267.5786621063;1097.6871591596516;1121.899029087386;1126.2003977176132;1130.6212418839616;1143.12550898561;12067.456964436446;13834.239116848268;14937.178455184634;15300.693986120437;15591.220438977778;32660;33248.5958619591;35742.31932605117;36197.81901090478;36897.63102369049;43185.35221971736;43540;43603.56396435995;45495.31757023714;45802.77098614485;9325.580348884181;9378.202852757318;9623.422594644344;9628.037196280316;9632;12291.938540307241;17415.47753567395;17561.209745561224;17852.285908563514;18182.5454363642;14456.638584035063;14572;14841.628959276104;14841.777373339193;14873.702525949637;14215.573532794033;14347.56957291283;14460.493882714054;14497.92751036238;14778.48275310359;14379.42482300738;14592.854071459149;14725.705485890008;15019.32413041394;15136.54590362291;9370.718878433658;9536.33245672824;9542.379745316532;9592.472414017016;9649.421034737938;14369.209693466542;14527.782083268548;14591.270436477922;14874.256287185814;15039.624009399853 20:09:05 INFO - PROCESS | 14704 | |3;mootools.html;1320.3794216718138;1686.6120792217791;1764.2413762082308;1788.2757483219293;1819.8089200633933;6713.731450741971;7529.698812047518;7715.7299494517565;7737.72917947872;7799.92200077999;7479.139898911627;7560.584167870765;7640.388768898489;7643.350315223199;7647.23527647235;1965.3514340267677;2009.5076706207;2276.1805749930013;2316.2587971849016;2316.2703748319227;2301.4821665125382;2323.9651405228933;2332.230363979891;2349.0251545608553;2350.3536527454917;2234.4078819112947;2246.359787460574;2292.426893276681;2293.3349328694744;2293.4037150340864;2255.8308126890465;2265.4449659833363;2293.4266433391654;2320.756320586348;2322.2800931711054;2293.495431005176;2302.873341966191;2316.061994892071;2321.1759825262125;2324.1865347128537;7794.142644309121;7852.685892564291;7855.332296754783;7903.170167132425;7906.644201010969;4703.0593881223895;4723.338732577442;4758.547937945889;4792.448868380111;4795.017021510582;3111.377724455118;3125.8437078146003;3136.466800643896;3168.207948012997;3172.1118086935694;941.7975135345933;951.3958636265952;956.9282303827241;986.9161121304697;992.28059656749;10579.206559508068;10724.249302548824;10746.892531074667;10751.569937202503;10754.838677419844;4314.741115533078;4433.623142032899;4434.201843668171;4436.268015777425;4493.88765280864;9259.166674999282;9302.25581953442;9312.674056407994;9323;9329.30030247734;4839.395075615548;4848.17581011229;4849.393825771778;4856.8300109495995;4857.344258525124;4402.977985110054;4414.183376075436;4415.094905544356;4423.8230470781455;4427.026054268056;3180.777345585787;3213.084270982759;3657.8719744808805;3673.9081522962138;3809.8285577149095;1237.6596435979998;1257.1577043380958;1260.9117361784588;1261.148724610884;1261.426051146726;1057.9206559508068;1058.090042563395;1114.2812885688686;1215.2283300104498;1334.9599512014654;7337.70649174027;7367.5211111277595;7428.405727541784;7470.551766894004;7488.063992001;623.9251289845248;641.3618449642636;643.4144928115486;644.0853987337991;787.9008782748034;5871.031279838779;5908.852278692981;5909.438603332676;5911.408859114054;5922.496587790086;9097;9206.17144457002;9296.907030929739;9415.435073895589;9419.058094190526;9203.079692030744;9303.069693030642;9317.487538185329;9338.645896344991;9344.112309330603;6605.669716514251;6795.286494917962;6859.2454829968665;7341.449391295674;7347.963260183772;7233.819154521179;7305.415566754753;7314.902764585355;7332.120145582351;7361.852762944604;8112.351011918914;8297.211764882326;8327.95836020816;8507.191816777397;8511.702090426805;8504.957475212585;8646.092160323076;8648.091950345375;8654.30765538768;8659.13408659129;6437.613743175424;6641.236257830411;6646.634435106115;6647.60114393138;6649.46804255668;6703.865922681616;6937.549059311129;7100.396466300423;7317.487775855639;7338.6697598607125;6919.827004324932;6979.371856532936;7065.929340706527;7071.186813516511;7131.964340178473;6680.164979377578;6737.797866064026;6799.796006119825;6867.21027081872;6892.207396149507;6977.79066628002;7056.964715176391;7058.082449281561;7060.6116663584;7063.682134304071;6499.967500162658;6656.334366563498;6656.567323123982;6658.766943156967;6665;6499.740010399721;6522.543421960418;6524.543281970216;6562.442192413508;6565.507586930904 20:09:05 INFO - PROCESS | 14704 | |4;prototype.html;326.38802245789145;332.8651895982127;339.2891891487334;341.053576325696;345.87548482546293;5763.5389168866495;5805.593608447411;5885.705714714263;5908.645481271126;5910.261217347832;5655.915161272585;5774;5775.451332123442;5780.1907732917425;5781.768729250825;4514.571115744007;4514.909701805962;4515.841945531907;4516.277395616702;4521.932171017437;4300.80646370914;4389.736615803046;4426;4511.52628973958;4520.073384956093;4482.955170448303;4494.393256910324;4495.752733599651;4499.325101234825;4505.144022635689;4480.439945006858;4482.081173359454;4482.641388688913;4498.932516012263;4501.347304640842;3954.683625309968;3955.307821131319;3962.445257663929;3966.5438474575503;3981.9601803981877;5421.864453388657;5548.472895074961;5565.332160140769;5587.329520457531;5595.7481913313595;5169;5174.637775355726;5176.974115129438;5177.948220517785;5184.559312458446;5896.64620122794;6202.62784232943;6208.596441231351;6217.098520714516;6220.813375598739;4216.57834216579;4218.725782824106;4307.5261721210645;4319;4325.048489332342;6351.777687780906;6445.097686323918;6450.129232553592;6452.064450654629;6455.386738259811;4392.275274579659;4402;4404.55954404557;4404.889877753082;4407.713498622579;4326.935095973563;4446.377507149002;4459.821607135743;4464.816823541764;4466.7766611669285;5116.104681680766;5154.871128221825;5164.25118357836;5180.559652429511;5192.792288308501;6272.278687950853;6274;6275.874482510416;6281.403266689657;6281.59169653971;1560.7112684153467;1574.7244232259309;1575.8109026916613;1578.5501132177274;1580.0519688187226;1038.1798379280283;1048.0619845238468;1062.86182796236;1062.9309094908806;1067.3062509368817;5959.135925290809;5965.701714914324;5969.492593129546;5972.552058595623;5977.462028417463;6411.455026322721;6412.422881940648;6423.454006409507;6427.646479443675;6428.292887782341;5935.495482884004;5954.07711804671;5960.85097872548;5962.821115366546;5965.79119730816;3375.0549846043145;3466.133466633342;3477.0264325988765;3477.6174620791694;3480.373532764076;6536.411722944958;6572.4084832365315;6601.603903765694;6605.042268870987;6611.73553057882;6664.200295964419;6669.266380698119;6672.633005184664;6684.465242780566;6685.465162786965;6434.485241180694;6572.244191917991;6584.209894812558;6593.307702691244;6595.175603049619;6198.535109866868;6372.299047104908;6463.61218326883;6466.741330346734;6479.967600161969;6256.749730010749;6349.396807303298;6369.522285828674;6374.93625063762;6390;6494.383033611799;6548.214214294315;6556.3443655634055;6558.737650494118;6575;4479.440069991251;4513.097380523974;4556.225441674989;4559.908801824011;4565.680402371802;6375.808725738235;6390.13733146038;6395.072714456471;6395.968020159869;6398.0402939559435;6184.721687524162;6214.937850621436;6226.875462490634;6230.657313847782;6237.002079667232;6073.5748497604745;6170.876582468415;6190.442860142609;6193.256809182927;6199.907001394892;6102.877942441215;6107.786227482017;6117.663528505975;6117.724702388492;6119.908201377072;6162;6192.287886893065;6201.906971395342;6204.7828326008375;6208.937910620836;5973.970130149321;6085.269767627913;6096.847578810565;6102.481289090477;6108.358622344767 20:09:05 INFO - PROCESS | 14704 | |5;yui.html;849.2569002123142;850.5067061104556;859.8968123825142;860.2859626509997;860.5396113079502;13921.651958701037;14208.360623771941;14224.217668028254;14263.072900261475;14282.071665341758;12611.684707882285;14385.424583016667;14584.562463126096;14621.415143394279;14633.853661463381;832.854250506162;843.9662413503484;849.087231226434;849.4393700157897;849.4436144325476;695.1067877777058;704.471646265301;825.3768404854327;826.6404114210337;834.7370578267856;880.4277219807112;881.607684580362;889.7908991387019;890.0743227043866;890.9887277939553;726.4587882027923;737.2295950731499;888.8444522208588;889.1464194373409;889.9421537600068;640.0878747784435;653.0432915778407;653.2291895563234;654.1790053482848;654.5810681164058;13624.795628065587;13706.246156461391;13749.931250343785;13757.862421375758;13765.862341376658;11888.346140962243;12150.4532296046;12279.447424865903;12483.812742808865;12501.812472812824;10377.325473844176;10650.147988160928;10695.465226738632;10710.464476776207;11036.448177591088;3625.764325318872;3655.7989310588173;3694.8522059117604;3771.6039815819217;3781.0169355967373;47543.524564754254;48528;48612.75693621509;48639.75680121612;48729.51270487321;10034.247431442525;10373.222008349405;10422.426766527762;10495.422751748727;10897.182711296684;17622.735658965124;17708.557286067695;17722.379716709853;17736.91131544334;17749.645007100044;7513.39892808585;7754.418418618626;7878.054633444023;7938.047434307805;7946.880796788053;4381.9123617527475;4395.252807022814;4554.316852472156;4640.512746161672;4670.299455081765;3177.3804108199142;3211.132994091582;3211.940059780267;3216.260260140181;3235.530848027023;563.3521450332069;573.3721574875588;578.5863107877888;587.8824235152987;590.1501837354197;618.3816183816184;620.7672122953892;628.2806186915956;633.882731694638;701.7228194863001;8913.465192088495;9323.440593564408;9527.809443811086;9610.183134433652;9648.71053868385;541.2503682399825;557.2866730584858;615.9498055814825;632.2570979099539;715.7101373943561;3971.9672885050095;4052.77709725962;4164.16956330655;4258.276093064186;4411.360352748833;53990.73004634952;53999.46000539944;54452.72773636106;55610.44389556053;55748.16377754337;46884.7655761719;49808.750956244985;49911;50169.498305017216;50488.242676359885;42819;43419.78290108593;45193.09613807705;45398.546014540094;46624;8670.436421632574;8737.475751454933;9159.313051521029;9213.309001824757;9381.906180938104;32877;33450.49824252687;34284.31431371409;34906.825465872505;35014.64985350216;42161.789191053846;42283;42429;42464.78767606142;43688.56311436845;11286.717832054264;11345.149113816662;11349.262297950607;11558.711032223926;11942.820857687315;11909.82135267989;12119.272843629411;12187.939060304641;13050.282234477196;13081.542146024844;11834.940825295818;12059.57791477294;12173.513059477522;12619.432125554189;12661.556845510362;11451.713707157054;11947.223430476992;12258.632241032783;12291.32397718134;12300.938495307466;10791.1367090631;11016.724581885517;11056.557737690724;11063.778724425627;11089.944550277198;9321.860172097287;9642.373245739005;9681.66114186;9782.217422606316;9847.803043939224;9022.548872556477;9603.855942160733;9820.508974551387;9858.556364963737;9948.701538953843 20:09:05 INFO - PROCESS | 14704 | __end_tp_report 20:09:05 INFO - PROCESS | 14704 | __start_cc_report 20:09:05 INFO - PROCESS | 14704 | _x_x_mozilla_cycle_collect,981 20:09:05 INFO - PROCESS | 14704 | __end_cc_report 20:09:05 INFO - PROCESS | 14704 | __startTimestamp1450843745449__endTimestamp 20:09:05 INFO - PROCESS | 14704 | 20:09:05 INFO - PROCESS | 14704 | ------- Summary: start ------- 20:09:05 INFO - PROCESS | 14704 | Number of tests: 6 20:09:05 INFO - PROCESS | 14704 | 20:09:05 INFO - PROCESS | 14704 | [#0] dojo.html Cycles:165 Average:5367.32 Median:5548.97 stddev:601.40 (10.8%) stddev-sans-first:576.11 20:09:05 INFO - PROCESS | 14704 | Values: 3090.3 3134.1 3173.7 3181.8 3227.5 5194.6 5312.3 5395.2 5399.2 5456.6 5281.9 5308.3 5362.6 5376.2 5378.4 4838.3 4844.6 4858.1 4870.0 4885.5 4941.0 4970.9 4974.9 4993.8 5011.7 4785.9 4811.9 4874.3 4978.6 4990.1 4907.3 4911.2 4920.4 4937.2 4972.0 4884.9 4893.8 4903.7 4907.6 4971.3 5078.8 5146.8 5156.5 5268.3 5305.6 5825.7 5862.9 5863.4 5868.3 5868.8 5665.4 5879.4 5896.6 5898.8 5899.4 5361.3 5370.7 5415.3 5502.2 5549.0 5960.2 5967.2 5970.9 6003.1 6018.0 5531.4 5733.6 5736.8 5743.2 5743.6 5693.4 5766.9 5769.8 5872.0 5920.3 5791.4 5816.3 5819.1 5819.5 5826.6 5620.8 5825.5 5829.1 5829.5 5831.2 4405.1 4421.2 4434.3 4491.3 4505.1 3994.9 3997.1 3999.6 4002.6 4043.3 5483.8 5485.5 5486.9 5491.2 5527.6 5639.4 5718.0 5752.3 5822.9 5836.5 5388.3 5418.1 5422.7 5427.5 5460.5 5031.3 5034.9 5037.5 5042.6 5085.2 5731.1 5752.3 5839.2 5855.2 5863.0 5810.4 5814.4 5814.9 5815.3 5820.7 5896.6 5901.1 5901.4 5907.5 5910.8 5517.6 5562.1 5621.8 5745.9 5864.0 5808.7 5842.2 5844.1 5849.7 5850.5 5698.7 5704.9 5706.7 5707.3 5707.5 5485.3 5567.3 5580.0 5583.6 5696.4 5476.2 5590.2 5609.4 5613.2 5615.7 5704.2 5715.5 5715.9 5718.6 5725.9 5410.9 5462.3 5492.4 5492.5 5565.6 20:09:05 INFO - PROCESS | 14704 | 20:09:05 INFO - PROCESS | 14704 | [#1] ext.html Cycles:180 Average:49231.89 Median:33591.50 stddev:84866.19 (252.6%) stddev-sans-first:85025.62 20:09:05 INFO - PROCESS | 14704 | Values: 571.4 607.2 608.0 611.2 612.1 30188.1 31152.7 31158.4 39230.0 39586.2 43664.8 44047.6 44136.6 44206.0 44272.6 8695.0 8908.5 8916.7 8917.5 8920.6 7847.7 7866.9 10525.0 10705.0 10733.6 10374.3 10468.6 10478.7 10483.4 10493.0 7792.8 7816.2 10330.1 10415.2 10417.6 10552.8 10820.3 10822.1 10823.3 10827.4 39950.0 40306.0 40506.0 40594.2 40644.2 3267.2 3303.6 3315.1 3316.8 3337.5 30161.4 30429.5 30486.2 30529.5 31311.4 3985.1 4066.2 4097.0 4105.3 4132.8 264318.0 265844.0 265904.0 266529.0 268052.0 52348.7 53591.5 60491.7 60889.1 60911.4 55888.4 56135.4 56397.4 56475.2 56544.7 15247.4 15443.2 15445.7 15457.8 15461.0 11594.4 11669.3 11673.8 11675.9 11687.9 19214.0 20354.8 20414.8 20418.1 20419.3 7872.4 8059.8 8083.8 8097.7 8182.7 958.8 1032.4 1032.7 1064.1 1082.7 27353.2 27913.6 27979.0 28141.9 28316.7 1038.2 1063.7 1066.6 1085.8 1155.9 14757.5 14830.3 14838.1 15001.7 15089.0 387732.0 393560.0 393565.0 393640.0 394703.0 55062.7 55353.7 55376.7 55542.4 55549.4 1328.4 1335.9 1337.0 1344.5 1371.4 27259.9 27276.3 31964.8 32972.7 33437.5 48928.8 49470.5 49483.8 49524.3 49565.0 297854.0 298274.0 299378.0 299435.0 299801.0 32846.0 43013.8 43199.6 43517.6 44198.0 42781.8 43368.8 43389.8 43738.3 43903.6 36237.5 36405.0 36918.8 40556.2 42343.6 36188.6 37130.8 37635.2 37738.0 37991.0 36530.8 36772.4 38360.6 39299.4 39361.8 31097.8 33353.3 33745.5 33797.8 33876.7 25114.5 25569.2 25623.7 25723.3 25936.7 20:09:05 INFO - PROCESS | 14704 | 20:09:05 INFO - PROCESS | 14704 | [#2] jquery.html Cycles:180 Average:28706.06 Median:359.37 stddev:88785.67 (24706.2%) stddev-sans-first:89009.21 20:09:05 INFO - PROCESS | 14704 | Values: 357.7 359.3 359.4 361.1 361.5 13948.0 14184.9 16489.4 16849.2 17473.5 14140.6 14241.2 16549.4 16570.7 17445.5 5381.5 5508.8 5509.0 5513.9 5518.8 4295.8 5448.5 5465.5 5476.2 5488.1 5326.8 5436.8 5437.4 5440.9 5446.3 5312.1 5395.5 5400.2 5406.8 5413.8 4767.0 4795.1 4799.7 4803.5 4807.4 19956.3 20168.7 20446.7 21165.2 21278.6 2121.9 2180.5 2217.4 2264.2 2726.9 13035.8 13042.3 13162.9 13337.9 13550.9 1811.3 1814.5 1830.2 1853.8 1869.6 52236.5 58956.7 62348.7 62390.4 62513.4 9631.4 9824.8 9825.1 9866.3 9910.0 12622.8 12698.4 12719.4 12722.4 12748.8 7117.6 7185.4 7231.7 7234.5 7236.8 6818.4 6877.0 6921.7 6933.7 6939.1 5814.0 5852.7 5852.9 5853.8 5906.5 1702.1 1717.6 1725.9 1729.0 1759.4 924.0 925.5 938.9 1006.8 1007.7 15945.7 17026.4 17100.1 17186.3 18019.9 917.2 935.7 936.4 980.5 1011.6 9683.5 9888.9 10019.1 10035.8 10039.5 519058.0 522506.0 555931.0 556280.0 565405.0 40074.4 64913.0 83892.6 84239.0 84267.6 1097.7 1121.9 1126.2 1130.6 1143.1 12067.5 13834.2 14937.2 15300.7 15591.2 32660.0 33248.6 35742.3 36197.8 36897.6 43185.4 43540.0 43603.6 45495.3 45802.8 9325.6 9378.2 9623.4 9628.0 9632.0 12291.9 17415.5 17561.2 17852.3 18182.5 14456.6 14572.0 14841.6 14841.8 14873.7 14215.6 14347.6 14460.5 14497.9 14778.5 14379.4 14592.9 14725.7 15019.3 15136.5 9370.7 9536.3 9542.4 9592.5 9649.4 14369.2 14527.8 14591.3 14874.3 15039.6 20:09:05 INFO - PROCESS | 14704 | 20:09:05 INFO - PROCESS | 14704 | [#3] mootools.html Cycles:180 Average:5446.52 Median:6585.59 stddev:2820.21 (42.8%) stddev-sans-first:2811.07 20:09:05 INFO - PROCESS | 14704 | Values: 1320.4 1686.6 1764.2 1788.3 1819.8 6713.7 7529.7 7715.7 7737.7 7799.9 7479.1 7560.6 7640.4 7643.4 7647.2 1965.4 2009.5 2276.2 2316.3 2316.3 2301.5 2324.0 2332.2 2349.0 2350.4 2234.4 2246.4 2292.4 2293.3 2293.4 2255.8 2265.4 2293.4 2320.8 2322.3 2293.5 2302.9 2316.1 2321.2 2324.2 7794.1 7852.7 7855.3 7903.2 7906.6 4703.1 4723.3 4758.5 4792.4 4795.0 3111.4 3125.8 3136.5 3168.2 3172.1 941.8 951.4 956.9 986.9 992.3 10579.2 10724.2 10746.9 10751.6 10754.8 4314.7 4433.6 4434.2 4436.3 4493.9 9259.2 9302.3 9312.7 9323.0 9329.3 4839.4 4848.2 4849.4 4856.8 4857.3 4403.0 4414.2 4415.1 4423.8 4427.0 3180.8 3213.1 3657.9 3673.9 3809.8 1237.7 1257.2 1260.9 1261.1 1261.4 1057.9 1058.1 1114.3 1215.2 1335.0 7337.7 7367.5 7428.4 7470.6 7488.1 623.9 641.4 643.4 644.1 787.9 5871.0 5908.9 5909.4 5911.4 5922.5 9097.0 9206.2 9296.9 9415.4 9419.1 9203.1 9303.1 9317.5 9338.6 9344.1 6605.7 6795.3 6859.2 7341.4 7348.0 7233.8 7305.4 7314.9 7332.1 7361.9 8112.4 8297.2 8328.0 8507.2 8511.7 8505.0 8646.1 8648.1 8654.3 8659.1 6437.6 6641.2 6646.6 6647.6 6649.5 6703.9 6937.5 7100.4 7317.5 7338.7 6919.8 6979.4 7065.9 7071.2 7132.0 6680.2 6737.8 6799.8 6867.2 6892.2 6977.8 7057.0 7058.1 7060.6 7063.7 6500.0 6656.3 6656.6 6658.8 6665.0 6499.7 6522.5 6524.5 6562.4 6565.5 20:09:05 INFO - PROCESS | 14704 | 20:09:05 INFO - PROCESS | 14704 | [#4] prototype.html Cycles:180 Average:5192.25 Median:5922.88 stddev:1556.58 (26.3%) stddev-sans-first:1517.49 20:09:05 INFO - PROCESS | 14704 | Values: 326.4 332.9 339.3 341.1 345.9 5763.5 5805.6 5885.7 5908.6 5910.3 5655.9 5774.0 5775.5 5780.2 5781.8 4514.6 4514.9 4515.8 4516.3 4521.9 4300.8 4389.7 4426.0 4511.5 4520.1 4483.0 4494.4 4495.8 4499.3 4505.1 4480.4 4482.1 4482.6 4498.9 4501.3 3954.7 3955.3 3962.4 3966.5 3982.0 5421.9 5548.5 5565.3 5587.3 5595.7 5169.0 5174.6 5177.0 5177.9 5184.6 5896.6 6202.6 6208.6 6217.1 6220.8 4216.6 4218.7 4307.5 4319.0 4325.0 6351.8 6445.1 6450.1 6452.1 6455.4 4392.3 4402.0 4404.6 4404.9 4407.7 4326.9 4446.4 4459.8 4464.8 4466.8 5116.1 5154.9 5164.3 5180.6 5192.8 6272.3 6274.0 6275.9 6281.4 6281.6 1560.7 1574.7 1575.8 1578.6 1580.1 1038.2 1048.1 1062.9 1062.9 1067.3 5959.1 5965.7 5969.5 5972.6 5977.5 6411.5 6412.4 6423.5 6427.6 6428.3 5935.5 5954.1 5960.9 5962.8 5965.8 3375.1 3466.1 3477.0 3477.6 3480.4 6536.4 6572.4 6601.6 6605.0 6611.7 6664.2 6669.3 6672.6 6684.5 6685.5 6434.5 6572.2 6584.2 6593.3 6595.2 6198.5 6372.3 6463.6 6466.7 6480.0 6256.7 6349.4 6369.5 6374.9 6390.0 6494.4 6548.2 6556.3 6558.7 6575.0 4479.4 4513.1 4556.2 4559.9 4565.7 6375.8 6390.1 6395.1 6396.0 6398.0 6184.7 6214.9 6226.9 6230.7 6237.0 6073.6 6170.9 6190.4 6193.3 6199.9 6102.9 6107.8 6117.7 6117.7 6119.9 6162.0 6192.3 6201.9 6204.8 6208.9 5974.0 6085.3 6096.8 6102.5 6108.4 20:09:05 INFO - PROCESS | 14704 | 20:09:05 INFO - PROCESS | 14704 | [#5] yui.html Cycles:180 Average:13731.43 Median:24976.43 stddev:15362.54 (61.5%) stddev-sans-first:15375.17 20:09:05 INFO - PROCESS | 14704 | Values: 849.3 850.5 859.9 860.3 860.5 13921.7 14208.4 14224.2 14263.1 14282.1 12611.7 14385.4 14584.6 14621.4 14633.9 832.9 844.0 849.1 849.4 849.4 695.1 704.5 825.4 826.6 834.7 880.4 881.6 889.8 890.1 891.0 726.5 737.2 888.8 889.1 889.9 640.1 653.0 653.2 654.2 654.6 13624.8 13706.2 13749.9 13757.9 13765.9 11888.3 12150.5 12279.4 12483.8 12501.8 10377.3 10650.1 10695.5 10710.5 11036.4 3625.8 3655.8 3694.9 3771.6 3781.0 47543.5 48528.0 48612.8 48639.8 48729.5 10034.2 10373.2 10422.4 10495.4 10897.2 17622.7 17708.6 17722.4 17736.9 17749.6 7513.4 7754.4 7878.1 7938.0 7946.9 4381.9 4395.3 4554.3 4640.5 4670.3 3177.4 3211.1 3211.9 3216.3 3235.5 563.4 573.4 578.6 587.9 590.2 618.4 620.8 628.3 633.9 701.7 8913.5 9323.4 9527.8 9610.2 9648.7 541.3 557.3 615.9 632.3 715.7 3972.0 4052.8 4164.2 4258.3 4411.4 53990.7 53999.5 54452.7 55610.4 55748.2 46884.8 49808.8 49911.0 50169.5 50488.2 42819.0 43419.8 45193.1 45398.5 46624.0 8670.4 8737.5 9159.3 9213.3 9381.9 32877.0 33450.5 34284.3 34906.8 35014.6 42161.8 42283.0 42429.0 42464.8 43688.6 11286.7 11345.1 11349.3 11558.7 11942.8 11909.8 12119.3 12187.9 13050.3 13081.5 11834.9 12059.6 12173.5 12619.4 12661.6 11451.7 11947.2 12258.6 12291.3 12300.9 10791.1 11016.7 11056.6 11063.8 11089.9 9321.9 9642.4 9681.7 9782.2 9847.8 9022.5 9603.9 9820.5 9858.6 9948.7 20:09:05 INFO - PROCESS | 14704 | -------- Summary: end -------- 20:09:05 INFO - PROCESS | 14704 | 20:09:06 INFO - TEST-INFO | 14704: exit 0 20:09:06 INFO - TEST-OK | dromaeo_css | took 1113689ms 20:09:06 INFO - TEST-START | kraken 20:09:06 INFO - operating with platform_type : linux_ 20:09:06 INFO - Initialising browser for kraken test... 20:09:06 INFO - TEST-INFO | started process 14896 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpE0iqaX/profile http://localhost:53746/getInfo.html) 20:09:10 INFO - PROCESS | 14896 | __metrics Screen width/height:1600/1200 20:09:10 INFO - PROCESS | 14896 | colorDepth:24 20:09:10 INFO - PROCESS | 14896 | Browser inner width/height: 1024/697 20:09:10 INFO - PROCESS | 14896 | __metrics 20:09:10 INFO - PROCESS | 14896 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:09:10 INFO - PROCESS | 14896 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:09:10 ERROR - PROCESS | 14896 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 20:09:11 INFO - TEST-INFO | 14896: exit 0 20:09:11 INFO - Browser initialized. 20:09:11 INFO - Running cycle 1/1 for kraken test... 20:09:11 INFO - TEST-INFO | started process 14981 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpE0iqaX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:09:23 INFO - PROCESS | 14981 | RSS: Main: 149671936 20:09:23 INFO - PROCESS | 14981 | 20:09:25 INFO - PROCESS | 14981 | Cycle 1(1): loaded http://localhost:53746/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53746/tests/kraken/driver.html?testName=audio-beat-detection) 20:09:26 INFO - PROCESS | 14981 | RSS: Main: 185319424 20:09:26 INFO - PROCESS | 14981 | 20:09:28 INFO - PROCESS | 14981 | Cycle 1(1): loaded http://localhost:53746/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53746/tests/kraken/driver.html?testName=audio-dft) 20:09:29 INFO - PROCESS | 14981 | RSS: Main: 177909760 20:09:29 INFO - PROCESS | 14981 | 20:09:32 INFO - PROCESS | 14981 | Cycle 1(1): loaded http://localhost:53746/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53746/tests/kraken/driver.html?testName=audio-fft) 20:09:32 INFO - PROCESS | 14981 | RSS: Main: 159866880 20:09:32 INFO - PROCESS | 14981 | 20:09:34 INFO - PROCESS | 14981 | Cycle 1(1): loaded http://localhost:53746/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53746/tests/kraken/driver.html?testName=audio-oscillator) 20:09:35 INFO - PROCESS | 14981 | RSS: Main: 162803712 20:09:35 INFO - PROCESS | 14981 | 20:09:37 INFO - PROCESS | 14981 | Cycle 1(1): loaded http://localhost:53746/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53746/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:09:38 INFO - PROCESS | 14981 | RSS: Main: 163663872 20:09:38 INFO - PROCESS | 14981 | 20:09:41 INFO - PROCESS | 14981 | Cycle 1(1): loaded http://localhost:53746/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53746/tests/kraken/driver.html?testName=imaging-darkroom) 20:09:41 INFO - PROCESS | 14981 | RSS: Main: 165249024 20:09:41 INFO - PROCESS | 14981 | 20:09:45 INFO - PROCESS | 14981 | Cycle 1(1): loaded http://localhost:53746/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53746/tests/kraken/driver.html?testName=imaging-desaturate) 20:09:45 INFO - PROCESS | 14981 | RSS: Main: 164954112 20:09:45 INFO - PROCESS | 14981 | 20:09:48 INFO - PROCESS | 14981 | Cycle 1(1): loaded http://localhost:53746/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53746/tests/kraken/driver.html?testName=json-parse-financial) 20:09:48 INFO - PROCESS | 14981 | RSS: Main: 164782080 20:09:48 INFO - PROCESS | 14981 | 20:09:50 INFO - PROCESS | 14981 | Cycle 1(1): loaded http://localhost:53746/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53746/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:09:51 INFO - PROCESS | 14981 | RSS: Main: 175763456 20:09:51 INFO - PROCESS | 14981 | 20:09:52 INFO - PROCESS | 14981 | Cycle 1(1): loaded http://localhost:53746/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53746/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:09:53 INFO - PROCESS | 14981 | RSS: Main: 173260800 20:09:53 INFO - PROCESS | 14981 | 20:09:55 INFO - PROCESS | 14981 | Cycle 1(1): loaded http://localhost:53746/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53746/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:09:56 INFO - PROCESS | 14981 | RSS: Main: 186277888 20:09:56 INFO - PROCESS | 14981 | 20:09:58 INFO - PROCESS | 14981 | Cycle 1(1): loaded http://localhost:53746/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53746/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:09:58 INFO - PROCESS | 14981 | RSS: Main: 192290816 20:09:58 INFO - PROCESS | 14981 | 20:10:01 INFO - PROCESS | 14981 | Cycle 1(1): loaded http://localhost:53746/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53746/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:10:02 INFO - PROCESS | 14981 | RSS: Main: 190722048 20:10:02 INFO - PROCESS | 14981 | 20:10:03 INFO - PROCESS | 14981 | Cycle 1(1): loaded http://localhost:53746/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53746/tests/kraken/driver.html?testName=ai-astar) 20:10:04 INFO - PROCESS | 14981 | RSS: Main: 247644160 20:10:04 INFO - PROCESS | 14981 | 20:10:04 INFO - PROCESS | 14981 | __start_tp_report 20:10:04 INFO - PROCESS | 14981 | _x_x_mozilla_page_load 20:10:04 INFO - PROCESS | 14981 | _x_x_mozilla_page_load_details 20:10:04 INFO - PROCESS | 14981 | |i|pagename|runs| 20:10:04 INFO - PROCESS | 14981 | |0;ai-astar;109;110;104;108;112;110;101;111;109;116 20:10:04 INFO - PROCESS | 14981 | |1;audio-beat-detection;150;122;160;161;129;153;163;125;164;126 20:10:04 INFO - PROCESS | 14981 | |2;audio-dft;162;160;162;162;162;162;161;162;163;161 20:10:04 INFO - PROCESS | 14981 | |3;audio-fft;71;72;86;92;71;72;71;104;103;70 20:10:04 INFO - PROCESS | 14981 | |4;audio-oscillator;94;94;137;93;94;94;138;93;93;141 20:10:04 INFO - PROCESS | 14981 | |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;109;109 20:10:04 INFO - PROCESS | 14981 | |6;imaging-darkroom;147;145;146;146;145;146;147;145;146;147 20:10:04 INFO - PROCESS | 14981 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;96;95 20:10:04 INFO - PROCESS | 14981 | |8;json-parse-financial;57;59;57;57;56;57;57;65;55;54 20:10:04 INFO - PROCESS | 14981 | |9;json-stringify-tinderbox;66;66;65;67;65;67;66;66;66;66 20:10:04 INFO - PROCESS | 14981 | |10;stanford-crypto-aes;85;86;84;85;83;85;85;85;86;85 20:10:04 INFO - PROCESS | 14981 | |11;stanford-crypto-ccm;124;127;114;123;111;120;114;127;116;130 20:10:04 INFO - PROCESS | 14981 | |12;stanford-crypto-pbkdf2;138;154;149;151;148;141;150;148;149;141 20:10:04 INFO - PROCESS | 14981 | |13;stanford-crypto-sha256-iterative;69;69;68;67;70;69;68;66;68;67 20:10:04 INFO - PROCESS | 14981 | __end_tp_report 20:10:04 INFO - PROCESS | 14981 | __start_cc_report 20:10:04 INFO - PROCESS | 14981 | _x_x_mozilla_cycle_collect,931 20:10:04 INFO - PROCESS | 14981 | __end_cc_report 20:10:04 INFO - PROCESS | 14981 | __startTimestamp1450843804048__endTimestamp 20:10:04 INFO - PROCESS | 14981 | 20:10:04 INFO - PROCESS | 14981 | ------- Summary: start ------- 20:10:04 INFO - PROCESS | 14981 | Number of tests: 14 20:10:04 INFO - PROCESS | 14981 | 20:10:04 INFO - PROCESS | 14981 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:4.14 (3.8%) stddev-sans-first:4.39 20:10:04 INFO - PROCESS | 14981 | Values: 109.0 110.0 104.0 108.0 112.0 110.0 101.0 111.0 109.0 116.0 20:10:04 INFO - PROCESS | 14981 | 20:10:04 INFO - PROCESS | 14981 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:156.50 stddev:17.64 (11.3%) stddev-sans-first:18.63 20:10:04 INFO - PROCESS | 14981 | Values: 150.0 122.0 160.0 161.0 129.0 153.0 163.0 125.0 164.0 126.0 20:10:04 INFO - PROCESS | 14981 | 20:10:04 INFO - PROCESS | 14981 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 20:10:04 INFO - PROCESS | 14981 | Values: 162.0 160.0 162.0 162.0 162.0 162.0 161.0 162.0 163.0 161.0 20:10:04 INFO - PROCESS | 14981 | 20:10:04 INFO - PROCESS | 14981 | [#3] audio-fft Cycles:10 Average:81.20 Median:71.50 stddev:13.91 (19.5%) stddev-sans-first:14.26 20:10:04 INFO - PROCESS | 14981 | Values: 71.0 72.0 86.0 92.0 71.0 72.0 71.0 104.0 103.0 70.0 20:10:04 INFO - PROCESS | 14981 | 20:10:04 INFO - PROCESS | 14981 | [#4] audio-oscillator Cycles:10 Average:107.10 Median:93.50 stddev:21.81 (23.3%) stddev-sans-first:22.61 20:10:04 INFO - PROCESS | 14981 | Values: 94.0 94.0 137.0 93.0 94.0 94.0 138.0 93.0 93.0 141.0 20:10:04 INFO - PROCESS | 14981 | 20:10:04 INFO - PROCESS | 14981 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 20:10:04 INFO - PROCESS | 14981 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 20:10:04 INFO - PROCESS | 14981 | 20:10:04 INFO - PROCESS | 14981 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 20:10:04 INFO - PROCESS | 14981 | Values: 147.0 145.0 146.0 146.0 145.0 146.0 147.0 145.0 146.0 147.0 20:10:04 INFO - PROCESS | 14981 | 20:10:04 INFO - PROCESS | 14981 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:10:04 INFO - PROCESS | 14981 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 20:10:04 INFO - PROCESS | 14981 | 20:10:04 INFO - PROCESS | 14981 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.00 stddev:2.99 (5.2%) stddev-sans-first:3.17 20:10:04 INFO - PROCESS | 14981 | Values: 57.0 59.0 57.0 57.0 56.0 57.0 57.0 65.0 55.0 54.0 20:10:04 INFO - PROCESS | 14981 | 20:10:04 INFO - PROCESS | 14981 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 20:10:04 INFO - PROCESS | 14981 | Values: 66.0 66.0 65.0 67.0 65.0 67.0 66.0 66.0 66.0 66.0 20:10:04 INFO - PROCESS | 14981 | 20:10:04 INFO - PROCESS | 14981 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:85.00 stddev:0.88 (1.0%) stddev-sans-first:0.93 20:10:04 INFO - PROCESS | 14981 | Values: 85.0 86.0 84.0 85.0 83.0 85.0 85.0 85.0 86.0 85.0 20:10:04 INFO - PROCESS | 14981 | 20:10:04 INFO - PROCESS | 14981 | [#11] stanford-crypto-ccm Cycles:10 Average:120.60 Median:123.50 stddev:6.57 (5.3%) stddev-sans-first:6.85 20:10:04 INFO - PROCESS | 14981 | Values: 124.0 127.0 114.0 123.0 111.0 120.0 114.0 127.0 116.0 130.0 20:10:04 INFO - PROCESS | 14981 | 20:10:04 INFO - PROCESS | 14981 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.90 Median:149.00 stddev:5.13 (3.4%) stddev-sans-first:4.31 20:10:04 INFO - PROCESS | 14981 | Values: 138.0 154.0 149.0 151.0 148.0 141.0 150.0 148.0 149.0 141.0 20:10:04 INFO - PROCESS | 14981 | 20:10:04 INFO - PROCESS | 14981 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.50 stddev:1.20 (1.7%) stddev-sans-first:1.22 20:10:04 INFO - PROCESS | 14981 | Values: 69.0 69.0 68.0 67.0 70.0 69.0 68.0 66.0 68.0 67.0 20:10:04 INFO - PROCESS | 14981 | -------- Summary: end -------- 20:10:04 INFO - PROCESS | 14981 | 20:10:04 INFO - TEST-INFO | 14981: exit 0 20:10:04 INFO - TEST-OK | kraken | took 58736ms 20:10:04 INFO - TEST-START | v8_7 20:10:04 INFO - operating with platform_type : linux_ 20:10:04 INFO - Initialising browser for v8_7 test... 20:10:04 INFO - TEST-INFO | started process 15229 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHTq__2/profile http://localhost:53746/getInfo.html) 20:10:09 INFO - PROCESS | 15229 | __metrics Screen width/height:1600/1200 20:10:09 INFO - PROCESS | 15229 | colorDepth:24 20:10:09 INFO - PROCESS | 15229 | Browser inner width/height: 1024/697 20:10:09 INFO - PROCESS | 15229 | __metrics 20:10:09 INFO - PROCESS | 15229 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:10:09 INFO - PROCESS | 15229 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:10:10 INFO - TEST-INFO | 15229: exit 0 20:10:10 INFO - Browser initialized. 20:10:10 INFO - Running cycle 1/1 for v8_7 test... 20:10:10 INFO - TEST-INFO | started process 15314 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHTq__2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:10:21 INFO - PROCESS | 15314 | RSS: Main: 150188032 20:10:21 INFO - PROCESS | 15314 | 20:10:43 INFO - PROCESS | 15314 | Cycle 1(1): loaded http://localhost:53746/tests/v8_7/run.html (next: http://localhost:53746/tests/v8_7/run.html) 20:10:43 INFO - PROCESS | 15314 | RSS: Main: 624996352 20:10:43 INFO - PROCESS | 15314 | 20:10:43 INFO - PROCESS | 15314 | __start_tp_report 20:10:43 INFO - PROCESS | 15314 | _x_x_mozilla_page_load 20:10:43 INFO - PROCESS | 15314 | _x_x_mozilla_page_load_details 20:10:43 INFO - PROCESS | 15314 | |i|pagename|runs| 20:10:43 INFO - PROCESS | 15314 | |0;Richards;164.66326362588507 20:10:43 INFO - PROCESS | 15314 | |1;DeltaBlue;188.43037497644622 20:10:43 INFO - PROCESS | 15314 | |2;Encrypt;279.2516056967328 20:10:43 INFO - PROCESS | 15314 | |3;Decrypt;5128.205128205128 20:10:43 INFO - PROCESS | 15314 | |4;RayTrace;1970.4724409448818 20:10:43 INFO - PROCESS | 15314 | |5;Earley;791.1392405063291 20:10:43 INFO - PROCESS | 15314 | |6;Boyer;12083.333333333334 20:10:43 INFO - PROCESS | 15314 | |7;RegExp;26102.5641025641 20:10:43 INFO - PROCESS | 15314 | |8;Splay;667.332002661344 20:10:43 INFO - PROCESS | 15314 | |9;NavierStokes;4845.410628019324 20:10:43 INFO - PROCESS | 15314 | __end_tp_report 20:10:43 INFO - PROCESS | 15314 | __startTimestamp1450843843603__endTimestamp 20:10:43 INFO - PROCESS | 15314 | 20:10:43 INFO - PROCESS | 15314 | ------- Summary: start ------- 20:10:43 INFO - PROCESS | 15314 | Number of tests: 10 20:10:43 INFO - PROCESS | 15314 | 20:10:43 INFO - PROCESS | 15314 | [#0] Richards Cycles:1 Average:164.66 Median:164.66 stddev:0.00 (0.0%) 20:10:43 INFO - PROCESS | 15314 | Values: 164.7 20:10:43 INFO - PROCESS | 15314 | 20:10:43 INFO - PROCESS | 15314 | [#1] DeltaBlue Cycles:1 Average:188.43 Median:188.43 stddev:0.00 (0.0%) 20:10:43 INFO - PROCESS | 15314 | Values: 188.4 20:10:43 INFO - PROCESS | 15314 | 20:10:43 INFO - PROCESS | 15314 | [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 20:10:43 INFO - PROCESS | 15314 | Values: 279.3 20:10:43 INFO - PROCESS | 15314 | 20:10:43 INFO - PROCESS | 15314 | [#3] Decrypt Cycles:1 Average:5128.21 Median:5128.21 stddev:0.00 (0.0%) 20:10:43 INFO - PROCESS | 15314 | Values: 5128.2 20:10:43 INFO - PROCESS | 15314 | 20:10:43 INFO - PROCESS | 15314 | [#4] RayTrace Cycles:1 Average:1970.47 Median:1970.47 stddev:0.00 (0.0%) 20:10:43 INFO - PROCESS | 15314 | Values: 1970.5 20:10:43 INFO - PROCESS | 15314 | 20:10:43 INFO - PROCESS | 15314 | [#5] Earley Cycles:1 Average:791.14 Median:791.14 stddev:0.00 (0.0%) 20:10:43 INFO - PROCESS | 15314 | Values: 791.1 20:10:43 INFO - PROCESS | 15314 | 20:10:43 INFO - PROCESS | 15314 | [#6] Boyer Cycles:1 Average:12083.33 Median:12083.33 stddev:0.00 (0.0%) 20:10:43 INFO - PROCESS | 15314 | Values: 12083.3 20:10:43 INFO - PROCESS | 15314 | 20:10:43 INFO - PROCESS | 15314 | [#7] RegExp Cycles:1 Average:26102.56 Median:26102.56 stddev:0.00 (0.0%) 20:10:43 INFO - PROCESS | 15314 | Values: 26102.6 20:10:43 INFO - PROCESS | 15314 | 20:10:43 INFO - PROCESS | 15314 | [#8] Splay Cycles:1 Average:667.33 Median:667.33 stddev:0.00 (0.0%) 20:10:43 INFO - PROCESS | 15314 | Values: 667.3 20:10:43 INFO - PROCESS | 15314 | 20:10:43 INFO - PROCESS | 15314 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 20:10:43 INFO - PROCESS | 15314 | Values: 4845.4 20:10:43 INFO - PROCESS | 15314 | -------- Summary: end -------- 20:10:43 INFO - PROCESS | 15314 | 20:10:44 INFO - TEST-INFO | 15314: exit 0 20:10:44 INFO - TEST-OK | v8_7 | took 39526ms 20:10:44 INFO - SUITE-END | took 1211s 20:10:44 INFO - Completed test suite (00:20:12) 20:10:44 INFO - Working with test: dromaeo_css 20:10:44 INFO - Generating results file: dromaeo_css 20:10:44 INFO - Working with test: kraken 20:10:44 INFO - Generating results file: kraken 20:10:44 INFO - javascript benchmark 20:10:44 INFO - Working with test: v8_7 20:10:44 INFO - Generating results file: v8_7 20:10:44 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:10:44 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 20:10:44 INFO - process_Request line: dromaeo_css 7044.38 graph.html#tests=[[72,64,35]] 20:10:44 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:10:44 INFO - process_Request line: kraken 1499.10 graph.html#tests=[[232,64,35]] 20:10:44 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:10:44 INFO - process_Request line: v8_7 19701.27 graph.html#tests=[[230,64,35]] 20:10:44 INFO - RETURN: dromaeo_css: 7044.38 20:10:44 INFO - RETURN: kraken: 1499.10 20:10:44 INFO - RETURN: v8_7: 19701.27 20:10:44 INFO - javascript benchmark 20:10:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3090.3046814466747, 3134.0597820653797, 3173.6984986426296, 3181.7613678974067, 3227.451333273344, 5194.584433245341, 5312.256284120216, 5395.2446657467935, 5399.163129714895, 5456.61803673743, 5281.9207711884355, 5308.309919710442, 5362.570994320455, 5376.247325374451, 5378.381486129097, 4838.298446725223, 4844.563989240967, 4858.076965376576, 4869.975650121763, 4885.462599114095, 4941.036497882914, 4970.925436118461, 4974.850754477371, 4993.800247990094, 5011.749412529377, 4785.880352991186, 4811.903761924742, 4874.31759553661, 4978.576820970222, 4990.101781679296, 4907.288443175756, 4911.238757992481, 4920.384951881015, 4937.234728617034, 4972.03045406146, 4884.9267260990755, 4893.755312234374, 4903.65674402792, 4907.582855457291, 4971.254311853215, 5078.822241221576, 5146.794128234867, 5156.535911767922, 5268.341457317835, 5305.628605997582, 5825.708714564297, 5862.882742345172, 5863.442972917566, 5868.295804503487, 5868.794592189253, 5665.3768085510565, 5879.353271140214, 5896.616719913235, 5898.793542226044, 5899.351071382144, 5361.329833770778, 5370.7046112463795, 5415.296011518517, 5502.202180683778, 5548.9722551387795, 5960.165576819249, 5967.164596956342, 5970.910436343458, 6003.099535069775, 6018.0, 5531.446855314436, 5733.598648094593, 5736.799212027559, 5743.2246646703, 5743.6266642668925, 5693.430656934273, 5766.855828604318, 5769.826905192851, 5871.9706401468575, 5920.348761636216, 5791.362950075489, 5816.331121920949, 5819.127130930395, 5819.476247137778, 5826.592138550345, 5620.803271885465, 5825.475707186373, 5829.09649004405, 5829.5044921181325, 5831.183634291203, 4405.140997505456, 4421.226285400042, 4434.312681534368, 4491.258942274488, 4505.05393867285, 3994.8601798936897, 3997.060690737674, 3999.6200360965663, 4002.6197511236387, 4043.251998380309, 5483.75323110461, 5485.451454854562, 5486.890262194814, 5491.176323551499, 5527.55779537636, 5639.407862174495, 5718.0, 5752.338481074647, 5822.854428639318, 5836.503897168704, 5388.299521062237, 5418.133098704188, 5422.7017514036315, 5427.511523962862, 5460.5085542301385, 5031.295618613397, 5034.949650503521, 5037.471065538139, 5042.647014708935, 5085.237214417867, 5731.140328950607, 5752.309722833287, 5839.153322768175, 5855.238818953509, 5862.970685146547, 5810.448007439287, 5814.360420353673, 5814.941850581609, 5815.302163740378, 5820.708964551671, 5896.55775816824, 5901.085331773582, 5901.439363260483, 5907.4683278505145, 5910.822675319747, 5517.613767036269, 5562.137868630369, 5621.80323688669, 5745.8563535911935, 5863.970680146572, 5808.709564521672, 5842.240508734008, 5844.064949608212, 5849.707514624167, 5850.53195744348, 5698.686572238401, 5704.914426283692, 5706.743196556082, 5707.315122185364, 5707.4577915098, 5485.286912701324, 5567.276254086943, 5580.023495888285, 5583.609147359646, 5696.430356964271, 5476.151196564539, 5590.2453168821685, 5609.4390560943575, 5613.186088017296, 5615.691136987341, 5704.201411802268, 5715.485606295453, 5715.8856822864145, 5718.571107166896, 5725.942740572541, 5410.8647283816645, 5462.317210348707, 5492.423295553909, 5492.47821456961, 5565.6104072714525], "unit": "score", "name": "dojo.html", "value": 5327.622357431846}, {"lowerIsBetter": false, "replicates": [571.4476514837127, 607.1924340626965, 607.9969600151999, 611.1871211288986, 612.1093808508621, 30188.09435716929, 31152.68847311526, 31158.376832463364, 39230.0, 39586.20827583447, 43664.781676091654, 44047.55952440474, 44136.55863441373, 44206.0, 44272.55727442724, 8694.999999999984, 8908.465492070463, 8916.73249802507, 8917.509536975464, 8920.553972301392, 7847.725329613465, 7866.881996770053, 10525.0, 10705.036546710795, 10733.624323148691, 10374.32566883154, 10468.581256749721, 10478.68563943079, 10483.423411712352, 10493.0, 7792.805179870492, 7816.179301173409, 10330.070293673567, 10415.166786657124, 10417.635382761604, 10552.841707374395, 10820.296680715728, 10822.080123189538, 10823.296485728402, 10827.350358978487, 39950.0, 40306.0, 40506.0, 40594.18811623751, 40644.18711625751, 3267.1668724475107, 3303.6035675719068, 3315.0717799016074, 3316.7628155586576, 3337.499375093731, 30161.396772064654, 30429.543556846664, 30486.237844053856, 30529.542056869166, 31311.37377252465, 3985.123272879962, 4066.207089617526, 4096.959030409717, 4105.3020986432375, 4132.8140233689555, 264318.0, 265844.0, 265904.0, 266529.0, 268051.999999998, 52348.73825630924, 53591.464085359425, 60491.69754151201, 60889.08666370008, 60911.39088609057, 55888.441115589136, 56135.43864561384, 56397.43602564004, 56475.152872706945, 56544.71727641336, 15247.390104395921, 15443.227838608249, 15445.691086178214, 15457.845421545866, 15461.0, 11594.420278986017, 11669.299842009506, 11673.76652466946, 11675.88324116765, 11687.88312116885, 19213.960742885432, 20354.79645203529, 20414.795852041585, 20418.08118634665, 20419.28532501385, 7872.370210383156, 8059.838803223903, 8083.797905052421, 8097.676092956216, 8182.672693092329, 958.8178246133212, 1032.4373216596973, 1032.736652153696, 1064.084886997182, 1082.7293176705823, 27353.179404617895, 27913.581296280572, 27979.0, 28141.859290703414, 28316.716832831407, 1038.2213339995003, 1063.7181146996052, 1066.5573786878513, 1085.8425528298353, 1155.8728539860608, 14757.483488077865, 14830.258487075818, 14838.109713417229, 15001.699966000619, 15089.0, 387732.0, 393560.0, 393565.0, 393640.0, 394703.0, 55062.724686377114, 55353.723231383585, 55376.723116384965, 55542.44457555454, 55549.444505555235, 1328.382302229468, 1335.899807514421, 1337.037333120152, 1344.4958140697238, 1371.403439503819, 27259.909603615633, 27276.31809204786, 31964.84017579897, 32972.67027329696, 33437.49843752297, 48928.755356224414, 49470.50529494659, 49483.75258123686, 49524.25713614227, 49565.0, 297854.0, 298274.0, 299378.0, 299435.0, 299801.0, 32846.0, 43013.78493107514, 43199.56800432081, 43517.56482435135, 44198.0, 42781.78609106935, 43368.78315608528, 43389.783051085804, 43738.34392484179, 43903.560964391225, 36237.45643815292, 36405.0, 36918.815405922796, 40556.18887622172, 42343.5765642352, 36188.63811361853, 37130.8143459281, 37635.2472950534, 37738.0, 37991.0, 36530.81734591416, 36772.44841327329, 38360.616393835706, 39299.41050884182, 39361.80319098386, 31097.8445107773, 33353.33293334071, 33745.493817592265, 33797.83101084479, 33876.66123338834, 25114.497710045332, 25569.23292301234, 25623.743762562135, 25723.311938895647, 25936.74063259343], "unit": "score", "name": "ext.html", "value": 19255.48484963688}, {"lowerIsBetter": false, "replicates": [357.70310642167004, 359.30295227259114, 359.42850867121274, 361.0666427285467, 361.4921035944497, 13947.985901803513, 14184.858151418483, 16489.422870199545, 16849.15754212289, 17473.475795726117, 14140.646483837909, 14241.216733079676, 16549.420770273042, 16570.66858662826, 17445.47663570095, 5381.461853814617, 5508.7521061552325, 5509.035918714229, 5513.9448605514035, 5518.806841760539, 4295.806688699016, 5448.45515448454, 5465.535429488478, 5476.17857321401, 5488.121900495921, 5326.840194794143, 5436.809711660093, 5437.374701909272, 5440.891182176354, 5446.2647542581835, 5312.096943519592, 5395.541378982772, 5400.216968539579, 5406.810761623344, 5413.756380962866, 4766.976165119152, 4795.136875362434, 4799.664023518355, 4803.543663352011, 4807.375041244616, 19956.3015294464, 20168.663737296552, 20446.69329960037, 21165.153393864228, 21278.574428511343, 2121.9151233950624, 2180.5202855371795, 2217.401301648562, 2264.241479104502, 2726.8909243630233, 13035.804462933063, 13042.347882605833, 13162.868371316355, 13337.933310333483, 13550.93571685095, 1811.275489804089, 1814.5463634091477, 1830.2130084063847, 1853.805350438198, 1869.5513076861591, 52236.47763522354, 58956.705216473645, 62348.68825655888, 62390.37609623891, 62513.37486625121, 9631.373960692532, 9824.803503930025, 9825.066618671215, 9866.30935834499, 9909.950450247847, 12622.81065784014, 12698.365081745877, 12719.427625756864, 12722.363881806057, 12748.80876786849, 7117.572945623279, 7185.389241914391, 7231.674574644154, 7234.529755565872, 7236.819079523054, 6818.386345228953, 6877.0, 6921.723131074801, 6933.653317334113, 6939.132608423947, 5814.0, 5852.736626851802, 5852.882942341129, 5853.765849365977, 5906.527477801766, 1702.0808763267696, 1717.6307093974856, 1725.9309627614755, 1728.9827101729072, 1759.3553020027139, 923.9790032014528, 925.5187302602609, 938.9201917837061, 1006.773475967916, 1007.7077647482295, 15945.681086378207, 17026.404075857285, 17100.144992750313, 17186.31254749796, 18019.909900450675, 917.1607978699549, 935.7286386947845, 936.438137117724, 980.460746589373, 1011.6054738651932, 9683.515824208762, 9888.901110988942, 10019.148372388428, 10035.79928401428, 10039.548220330104, 519058.0, 522506.0, 555931.0, 556280.0, 565405.0, 40074.398884016766, 64913.0, 83892.58053709692, 84239.0, 84267.5786621063, 1097.6871591596516, 1121.899029087386, 1126.2003977176132, 1130.6212418839616, 1143.12550898561, 12067.456964436446, 13834.239116848268, 14937.178455184634, 15300.693986120437, 15591.220438977778, 32660.0, 33248.5958619591, 35742.31932605117, 36197.81901090478, 36897.63102369049, 43185.35221971736, 43540.0, 43603.56396435995, 45495.31757023714, 45802.77098614485, 9325.580348884181, 9378.202852757318, 9623.422594644344, 9628.037196280316, 9632.0, 12291.938540307241, 17415.47753567395, 17561.209745561224, 17852.285908563514, 18182.5454363642, 14456.638584035063, 14572.0, 14841.628959276104, 14841.777373339193, 14873.702525949637, 14215.573532794033, 14347.56957291283, 14460.493882714054, 14497.92751036238, 14778.48275310359, 14379.42482300738, 14592.854071459149, 14725.705485890008, 15019.32413041394, 15136.54590362291, 9370.718878433658, 9536.33245672824, 9542.379745316532, 9592.472414017016, 9649.421034737938, 14369.209693466542, 14527.782083268548, 14591.270436477922, 14874.256287185814, 15039.624009399853], "unit": "score", "name": "jquery.html", "value": 8921.795918829263}, {"lowerIsBetter": false, "replicates": [1320.3794216718138, 1686.6120792217791, 1764.2413762082308, 1788.2757483219293, 1819.8089200633933, 6713.731450741971, 7529.698812047518, 7715.7299494517565, 7737.72917947872, 7799.92200077999, 7479.139898911627, 7560.584167870765, 7640.388768898489, 7643.350315223199, 7647.23527647235, 1965.3514340267677, 2009.5076706207, 2276.1805749930013, 2316.2587971849016, 2316.2703748319227, 2301.4821665125382, 2323.9651405228933, 2332.230363979891, 2349.0251545608553, 2350.3536527454917, 2234.4078819112947, 2246.359787460574, 2292.426893276681, 2293.3349328694744, 2293.4037150340864, 2255.8308126890465, 2265.4449659833363, 2293.4266433391654, 2320.756320586348, 2322.2800931711054, 2293.495431005176, 2302.873341966191, 2316.061994892071, 2321.1759825262125, 2324.1865347128537, 7794.142644309121, 7852.685892564291, 7855.332296754783, 7903.170167132425, 7906.644201010969, 4703.0593881223895, 4723.338732577442, 4758.547937945889, 4792.448868380111, 4795.017021510582, 3111.377724455118, 3125.8437078146003, 3136.466800643896, 3168.207948012997, 3172.1118086935694, 941.7975135345933, 951.3958636265952, 956.9282303827241, 986.9161121304697, 992.28059656749, 10579.206559508068, 10724.249302548824, 10746.892531074667, 10751.569937202503, 10754.838677419844, 4314.741115533078, 4433.623142032899, 4434.201843668171, 4436.268015777425, 4493.88765280864, 9259.166674999282, 9302.25581953442, 9312.674056407994, 9323.0, 9329.30030247734, 4839.395075615548, 4848.17581011229, 4849.393825771778, 4856.8300109495995, 4857.344258525124, 4402.977985110054, 4414.183376075436, 4415.094905544356, 4423.8230470781455, 4427.026054268056, 3180.777345585787, 3213.084270982759, 3657.8719744808805, 3673.9081522962138, 3809.8285577149095, 1237.6596435979998, 1257.1577043380958, 1260.9117361784588, 1261.148724610884, 1261.426051146726, 1057.9206559508068, 1058.090042563395, 1114.2812885688686, 1215.2283300104498, 1334.9599512014654, 7337.70649174027, 7367.5211111277595, 7428.405727541784, 7470.551766894004, 7488.063992001, 623.9251289845248, 641.3618449642636, 643.4144928115486, 644.0853987337991, 787.9008782748034, 5871.031279838779, 5908.852278692981, 5909.438603332676, 5911.408859114054, 5922.496587790086, 9097.0, 9206.17144457002, 9296.907030929739, 9415.435073895589, 9419.058094190526, 9203.079692030744, 9303.069693030642, 9317.487538185329, 9338.645896344991, 9344.112309330603, 6605.669716514251, 6795.286494917962, 6859.2454829968665, 7341.449391295674, 7347.963260183772, 7233.819154521179, 7305.415566754753, 7314.902764585355, 7332.120145582351, 7361.852762944604, 8112.351011918914, 8297.211764882326, 8327.95836020816, 8507.191816777397, 8511.702090426805, 8504.957475212585, 8646.092160323076, 8648.091950345375, 8654.30765538768, 8659.13408659129, 6437.613743175424, 6641.236257830411, 6646.634435106115, 6647.60114393138, 6649.46804255668, 6703.865922681616, 6937.549059311129, 7100.396466300423, 7317.487775855639, 7338.6697598607125, 6919.827004324932, 6979.371856532936, 7065.929340706527, 7071.186813516511, 7131.964340178473, 6680.164979377578, 6737.797866064026, 6799.796006119825, 6867.21027081872, 6892.207396149507, 6977.79066628002, 7056.964715176391, 7058.082449281561, 7060.6116663584, 7063.682134304071, 6499.967500162658, 6656.334366563498, 6656.567323123982, 6658.766943156967, 6665.0, 6499.740010399721, 6522.543421960418, 6524.543281970216, 6562.442192413508, 6565.507586930904], "unit": "score", "name": "mootools.html", "value": 4440.021665143454}, {"lowerIsBetter": false, "replicates": [326.38802245789145, 332.8651895982127, 339.2891891487334, 341.053576325696, 345.87548482546293, 5763.5389168866495, 5805.593608447411, 5885.705714714263, 5908.645481271126, 5910.261217347832, 5655.915161272585, 5774.0, 5775.451332123442, 5780.1907732917425, 5781.768729250825, 4514.571115744007, 4514.909701805962, 4515.841945531907, 4516.277395616702, 4521.932171017437, 4300.80646370914, 4389.736615803046, 4426.0, 4511.52628973958, 4520.073384956093, 4482.955170448303, 4494.393256910324, 4495.752733599651, 4499.325101234825, 4505.144022635689, 4480.439945006858, 4482.081173359454, 4482.641388688913, 4498.932516012263, 4501.347304640842, 3954.683625309968, 3955.307821131319, 3962.445257663929, 3966.5438474575503, 3981.9601803981877, 5421.864453388657, 5548.472895074961, 5565.332160140769, 5587.329520457531, 5595.7481913313595, 5169.0, 5174.637775355726, 5176.974115129438, 5177.948220517785, 5184.559312458446, 5896.64620122794, 6202.62784232943, 6208.596441231351, 6217.098520714516, 6220.813375598739, 4216.57834216579, 4218.725782824106, 4307.5261721210645, 4319.0, 4325.048489332342, 6351.777687780906, 6445.097686323918, 6450.129232553592, 6452.064450654629, 6455.386738259811, 4392.275274579659, 4402.0, 4404.55954404557, 4404.889877753082, 4407.713498622579, 4326.935095973563, 4446.377507149002, 4459.821607135743, 4464.816823541764, 4466.7766611669285, 5116.104681680766, 5154.871128221825, 5164.25118357836, 5180.559652429511, 5192.792288308501, 6272.278687950853, 6274.0, 6275.874482510416, 6281.403266689657, 6281.59169653971, 1560.7112684153467, 1574.7244232259309, 1575.8109026916613, 1578.5501132177274, 1580.0519688187226, 1038.1798379280283, 1048.0619845238468, 1062.86182796236, 1062.9309094908806, 1067.3062509368817, 5959.135925290809, 5965.701714914324, 5969.492593129546, 5972.552058595623, 5977.462028417463, 6411.455026322721, 6412.422881940648, 6423.454006409507, 6427.646479443675, 6428.292887782341, 5935.495482884004, 5954.07711804671, 5960.85097872548, 5962.821115366546, 5965.79119730816, 3375.0549846043145, 3466.133466633342, 3477.0264325988765, 3477.6174620791694, 3480.373532764076, 6536.411722944958, 6572.4084832365315, 6601.603903765694, 6605.042268870987, 6611.73553057882, 6664.200295964419, 6669.266380698119, 6672.633005184664, 6684.465242780566, 6685.465162786965, 6434.485241180694, 6572.244191917991, 6584.209894812558, 6593.307702691244, 6595.175603049619, 6198.535109866868, 6372.299047104908, 6463.61218326883, 6466.741330346734, 6479.967600161969, 6256.749730010749, 6349.396807303298, 6369.522285828674, 6374.93625063762, 6390.0, 6494.383033611799, 6548.214214294315, 6556.3443655634055, 6558.737650494118, 6575.0, 4479.440069991251, 4513.097380523974, 4556.225441674989, 4559.908801824011, 4565.680402371802, 6375.808725738235, 6390.13733146038, 6395.072714456471, 6395.968020159869, 6398.0402939559435, 6184.721687524162, 6214.937850621436, 6226.875462490634, 6230.657313847782, 6237.002079667232, 6073.5748497604745, 6170.876582468415, 6190.442860142609, 6193.256809182927, 6199.907001394892, 6102.877942441215, 6107.786227482017, 6117.663528505975, 6117.724702388492, 6119.908201377072, 6162.0, 6192.287886893065, 6201.906971395342, 6204.7828326008375, 6208.937910620836, 5973.970130149321, 6085.269767627913, 6096.847578810565, 6102.481289090477, 6108.358622344767], "unit": "score", "name": "prototype.html", "value": 4688.446594339309}, {"lowerIsBetter": false, "replicates": [849.2569002123142, 850.5067061104556, 859.8968123825142, 860.2859626509997, 860.5396113079502, 13921.651958701037, 14208.360623771941, 14224.217668028254, 14263.072900261475, 14282.071665341758, 12611.684707882285, 14385.424583016667, 14584.562463126096, 14621.415143394279, 14633.853661463381, 832.854250506162, 843.9662413503484, 849.087231226434, 849.4393700157897, 849.4436144325476, 695.1067877777058, 704.471646265301, 825.3768404854327, 826.6404114210337, 834.7370578267856, 880.4277219807112, 881.607684580362, 889.7908991387019, 890.0743227043866, 890.9887277939553, 726.4587882027923, 737.2295950731499, 888.8444522208588, 889.1464194373409, 889.9421537600068, 640.0878747784435, 653.0432915778407, 653.2291895563234, 654.1790053482848, 654.5810681164058, 13624.795628065587, 13706.246156461391, 13749.931250343785, 13757.862421375758, 13765.862341376658, 11888.346140962243, 12150.4532296046, 12279.447424865903, 12483.812742808865, 12501.812472812824, 10377.325473844176, 10650.147988160928, 10695.465226738632, 10710.464476776207, 11036.448177591088, 3625.764325318872, 3655.7989310588173, 3694.8522059117604, 3771.6039815819217, 3781.0169355967373, 47543.524564754254, 48528.0, 48612.75693621509, 48639.75680121612, 48729.51270487321, 10034.247431442525, 10373.222008349405, 10422.426766527762, 10495.422751748727, 10897.182711296684, 17622.735658965124, 17708.557286067695, 17722.379716709853, 17736.91131544334, 17749.645007100044, 7513.39892808585, 7754.418418618626, 7878.054633444023, 7938.047434307805, 7946.880796788053, 4381.9123617527475, 4395.252807022814, 4554.316852472156, 4640.512746161672, 4670.299455081765, 3177.3804108199142, 3211.132994091582, 3211.940059780267, 3216.260260140181, 3235.530848027023, 563.3521450332069, 573.3721574875588, 578.5863107877888, 587.8824235152987, 590.1501837354197, 618.3816183816184, 620.7672122953892, 628.2806186915956, 633.882731694638, 701.7228194863001, 8913.465192088495, 9323.440593564408, 9527.809443811086, 9610.183134433652, 9648.71053868385, 541.2503682399825, 557.2866730584858, 615.9498055814825, 632.2570979099539, 715.7101373943561, 3971.9672885050095, 4052.77709725962, 4164.16956330655, 4258.276093064186, 4411.360352748833, 53990.73004634952, 53999.46000539944, 54452.72773636106, 55610.44389556053, 55748.16377754337, 46884.7655761719, 49808.750956244985, 49911.0, 50169.498305017216, 50488.242676359885, 42819.0, 43419.78290108593, 45193.09613807705, 45398.546014540094, 46624.0, 8670.436421632574, 8737.475751454933, 9159.313051521029, 9213.309001824757, 9381.906180938104, 32877.0, 33450.49824252687, 34284.31431371409, 34906.825465872505, 35014.64985350216, 42161.789191053846, 42283.0, 42429.0, 42464.78767606142, 43688.56311436845, 11286.717832054264, 11345.149113816662, 11349.262297950607, 11558.711032223926, 11942.820857687315, 11909.82135267989, 12119.272843629411, 12187.939060304641, 13050.282234477196, 13081.542146024844, 11834.940825295818, 12059.57791477294, 12173.513059477522, 12619.432125554189, 12661.556845510362, 11451.713707157054, 11947.223430476992, 12258.632241032783, 12291.32397718134, 12300.938495307466, 10791.1367090631, 11016.724581885517, 11056.557737690724, 11063.778724425627, 11089.944550277198, 9321.860172097287, 9642.373245739005, 9681.66114186, 9782.217422606316, 9847.803043939224, 9022.548872556477, 9603.855942160733, 9820.508974551387, 9858.556364963737, 9948.701538953843], "unit": "score", "name": "yui.html", "value": 6413.012466224953}], "name": "dromaeo_css", "value": 7044.381804607542}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 104.0, 108.0, 112.0, 110.0, 101.0, 111.0, 109.0, 116.0], "unit": "score", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [150.0, 122.0, 160.0, 161.0, 129.0, 153.0, 163.0, 125.0, 164.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 145.3}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 162.0, 162.0, 162.0, 162.0, 161.0, 162.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 86.0, 92.0, 71.0, 72.0, 71.0, 104.0, 103.0, 70.0], "unit": "score", "name": "audio-fft", "value": 81.2}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 137.0, 93.0, 94.0, 94.0, 138.0, 93.0, 93.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 107.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.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.0}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 146.0, 146.0, 145.0, 146.0, 147.0, 145.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [57.0, 59.0, 57.0, 57.0, 56.0, 57.0, 57.0, 65.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 65.0, 67.0, 65.0, 67.0, 66.0, 66.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.0}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 84.0, 85.0, 83.0, 85.0, 85.0, 85.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.9}, {"lowerIsBetter": true, "replicates": [124.0, 127.0, 114.0, 123.0, 111.0, 120.0, 114.0, 127.0, 116.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.6}, {"lowerIsBetter": true, "replicates": [138.0, 154.0, 149.0, 151.0, 148.0, 141.0, 150.0, 148.0, 149.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.9}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 67.0, 70.0, 69.0, 68.0, 66.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1499.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.66326362588507], "unit": "score", "name": "Richards", "value": 214.38904599999995}, {"lowerIsBetter": false, "replicates": [188.43037497644622], "unit": "score", "name": "DeltaBlue", "value": 350.8882260000001}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5128.205128205128], "unit": "score", "name": "Decrypt", "value": 51.90529499999997}, {"lowerIsBetter": false, "replicates": [1970.4724409448818], "unit": "score", "name": "RayTrace", "value": 375.5388731268733}, {"lowerIsBetter": false, "replicates": [791.1392405063291], "unit": "score", "name": "Earley", "value": 842.4092320000002}, {"lowerIsBetter": false, "replicates": [12083.333333333334], "unit": "score", "name": "Boyer", "value": 55.155558620689625}, {"lowerIsBetter": false, "replicates": [26102.5641025641], "unit": "score", "name": "RegExp", "value": 34.90021119842827}, {"lowerIsBetter": false, "replicates": [667.332002661344], "unit": "score", "name": "Splay", "value": 122.11462911266206}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19701.271786001755}]} 20:10:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19701.27"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1499.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "7044.38"}}} 20:10:44 INFO - Return code: 0 20:10:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:10:44 ERROR - # TBPL SUCCESS # 20:10:44 INFO - Running post-action listener: _resource_record_post_action 20:10:44 INFO - Running post-run listener: _resource_record_post_run 20:10:46 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 28672; Write bytes: 547270656; Read time: 12; Write time: 409224 20:10:46 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 235278336; Read time: 0; Write time: 212392 20:10:46 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 28672; Write bytes: 311992320; Read time: 12; Write time: 196832 20:10:46 INFO - Running post-run listener: _upload_blobber_files 20:10:46 INFO - Blob upload gear active. 20:10:46 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:10: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 20:10: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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 20:10: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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 20:10:46 INFO - (blobuploader) - INFO - Open directory for files ... 20:10:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:10:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:10:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:10:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:10:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:10:47 INFO - (blobuploader) - INFO - Done attempting. 20:10:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:10:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:10:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:10:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:10:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:10:48 INFO - (blobuploader) - INFO - Done attempting. 20:10:48 INFO - (blobuploader) - INFO - Iteration through files over. 20:10:48 INFO - Return code: 0 20:10:48 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:10:48 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:10:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4cbecf1a2d53e5a6dd985d94f34fad0cbe02196ca5800485e7dad86e5f9cafdf4126de9a83b050fc6a22e520e74cabd64cc28c0b7ba6a0e745b5f87563767cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b1b021ee21f632e8a87aff790931983bc13afcc02250af5dea6b7494fe0e54dabe314d5eed21bbd0f965290670e79f766b22c0314aa8073c22d2a914a7d1fb51"} 20:10:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:10:48 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:10:48 INFO - Contents: 20:10:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4cbecf1a2d53e5a6dd985d94f34fad0cbe02196ca5800485e7dad86e5f9cafdf4126de9a83b050fc6a22e520e74cabd64cc28c0b7ba6a0e745b5f87563767cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b1b021ee21f632e8a87aff790931983bc13afcc02250af5dea6b7494fe0e54dabe314d5eed21bbd0f965290670e79f766b22c0314aa8073c22d2a914a7d1fb51"} 20:10:48 INFO - Copying logs to upload dir... 20:10:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1277.594301 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-22 20:10:47.829486) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 20:10:47.833362) ========= 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=61fa6ed41387771909ec0f71000001b3-1450841433.195363-717746533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4cbecf1a2d53e5a6dd985d94f34fad0cbe02196ca5800485e7dad86e5f9cafdf4126de9a83b050fc6a22e520e74cabd64cc28c0b7ba6a0e745b5f87563767cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b1b021ee21f632e8a87aff790931983bc13afcc02250af5dea6b7494fe0e54dabe314d5eed21bbd0f965290670e79f766b22c0314aa8073c22d2a914a7d1fb51"} build_url:https://queue.taskcluster.net/v1/task/Ez2rtVYESnekAjO3b5jwCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011428 build_url: 'https://queue.taskcluster.net/v1/task/Ez2rtVYESnekAjO3b5jwCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4cbecf1a2d53e5a6dd985d94f34fad0cbe02196ca5800485e7dad86e5f9cafdf4126de9a83b050fc6a22e520e74cabd64cc28c0b7ba6a0e745b5f87563767cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b1b021ee21f632e8a87aff790931983bc13afcc02250af5dea6b7494fe0e54dabe314d5eed21bbd0f965290670e79f766b22c0314aa8073c22d2a914a7d1fb51"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 20:10:47.857325) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 20:10:47.857601) ========= 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=61fa6ed41387771909ec0f71000001b3-1450841433.195363-717746533 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004659 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 20:10:47.940655) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 20:10:47.940953) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 20:10:47.941235) ========= ========= Total master_lag: 0.23 =========