builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1451631145.97 results: success (0) buildid: 20151231203134 builduid: 43a06c854c9a476f9eaffbac138a5a74 revision: 30c5cd7a3ec750909be74cc68473a6e30ee7f6e6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:25.967440) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:25.968213) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:25.968616) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1451628954.252844-609829084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006488 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.54 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:26.513038) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:26.513365) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.147219) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.147527) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1451628954.252844-609829084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004638 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.202084) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.202397) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.202810) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.203145) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1451628954.252844-609829084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-31 22:52:27-- 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% 43.2M=0s 2015-12-31 22:52:27 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.192341 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.411343) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.411729) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1451628954.252844-609829084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014442 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.463016) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:27.463395) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 30c5cd7a3ec750909be74cc68473a6e30ee7f6e6 --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 30c5cd7a3ec750909be74cc68473a6e30ee7f6e6 --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=bab59de71505bdac5bb1aeb2000001b6-1451628954.252844-609829084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-31 22:52:27,732 truncating revision to first 12 chars 2015-12-31 22:52:27,732 Setting DEBUG logging. 2015-12-31 22:52:27,732 attempt 1/10 2015-12-31 22:52:27,732 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/30c5cd7a3ec7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-31 22:52:28,032 unpacking tar archive at: fx-team-30c5cd7a3ec7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571400 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:28.050502) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:28.050869) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:28.305582) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:28.305903) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 22:52:28.306331) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-31 22:52:28.306652) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bab59de71505bdac5bb1aeb2000001b6-1451628954.252844-609829084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:52:28 INFO - MultiFileLogger online at 20151231 22:52:28 in /builds/slave/test-pgo 22:52:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:52:28 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:52:28 INFO - {'append_to_log': False, 22:52:28 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:52:28 INFO - 'blob_upload_branch': 'Fx-Team', 22:52:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:52:28 INFO - 'branch': 'Fx-Team', 22:52:28 INFO - 'buildbot_json_path': 'buildprops.json', 22:52:28 INFO - 'config_files': ('talos/linux_config.py',), 22:52:28 INFO - 'default_actions': ('clobber', 22:52:28 INFO - 'read-buildbot-config', 22:52:28 INFO - 'download-and-extract', 22:52:28 INFO - 'populate-webroot', 22:52:28 INFO - 'create-virtualenv', 22:52:28 INFO - 'install', 22:52:28 INFO - 'run-tests'), 22:52:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:52:28 INFO - 'download_minidump_stackwalk': True, 22:52:28 INFO - 'download_symbols': 'ondemand', 22:52:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:52:28 INFO - 'tooltool.py': '/tools/tooltool.py', 22:52:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:52:28 INFO - '/tools/misc-python/virtualenv.py')}, 22:52:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:52:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:52:28 INFO - 'installer_path': 'installer.exe', 22:52:28 INFO - 'log_level': 'info', 22:52:28 INFO - 'log_name': 'talos', 22:52:28 INFO - 'log_to_console': True, 22:52:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:52:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:52:28 INFO - 'opt_config_files': (), 22:52:28 INFO - 'pip_index': False, 22:52:28 INFO - 'sps_profile': False, 22:52:28 INFO - 'sps_profile_interval': 0, 22:52:28 INFO - 'suite': 'dromaeojs', 22:52:28 INFO - 'system_bits': '32', 22:52:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:52:28 INFO - 'title': 'talos-linux64-ix-062', 22:52:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:52:28 INFO - 'use_talos_json': True, 22:52:28 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:52:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:52:28 INFO - 'work_dir': 'build'} 22:52:28 INFO - ##### 22:52:28 INFO - ##### Running clobber step. 22:52:28 INFO - ##### 22:52:28 INFO - Running pre-action listener: _resource_record_pre_action 22:52:28 INFO - Running main action method: clobber 22:52:28 INFO - rmtree: /builds/slave/test-pgo/build 22:52:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:52:29 INFO - Running post-action listener: _resource_record_post_action 22:52:29 INFO - ##### 22:52:29 INFO - ##### Running read-buildbot-config step. 22:52:29 INFO - ##### 22:52:29 INFO - Running pre-action listener: _resource_record_pre_action 22:52:29 INFO - Running main action method: read_buildbot_config 22:52:29 INFO - Using buildbot properties: 22:52:29 INFO - { 22:52:29 INFO - "project": "", 22:52:29 INFO - "product": "firefox", 22:52:29 INFO - "script_repo_revision": "production", 22:52:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:52:29 INFO - "repository": "", 22:52:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 22:52:29 INFO - "buildid": "20151231203134", 22:52:29 INFO - "pgo_build": "True", 22:52:29 INFO - "basedir": "/builds/slave/test-pgo", 22:52:29 INFO - "buildnumber": 865, 22:52:29 INFO - "slavename": "talos-linux64-ix-062", 22:52:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:52:29 INFO - "platform": "ubuntu64_hw", 22:52:29 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:52:29 INFO - "branch": "fx-team", 22:52:29 INFO - "repo_path": "integration/fx-team", 22:52:29 INFO - "revision": "30c5cd7a3ec750909be74cc68473a6e30ee7f6e6", 22:52:29 INFO - "stage_platform": "linux64-pgo", 22:52:29 INFO - "builduid": "43a06c854c9a476f9eaffbac138a5a74", 22:52:29 INFO - "slavebuilddir": "test" 22:52:29 INFO - } 22:52:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:52:29 INFO - Running post-action listener: _resource_record_post_action 22:52:29 INFO - ##### 22:52:29 INFO - ##### Running download-and-extract step. 22:52:29 INFO - ##### 22:52:29 INFO - Running pre-action listener: _resource_record_pre_action 22:52:29 INFO - Running main action method: download_and_extract 22:52:29 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:29 INFO - https://queue.taskcluster.net/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:52:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/test_packages.json 22:52:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/test_packages.json 22:52:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:52:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:52:31 INFO - Downloaded 1302 bytes. 22:52:31 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:52:31 INFO - Using the following test package requirements: 22:52:31 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:52:31 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:52:31 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:31 INFO - u'jsshell-linux-x86_64.zip'], 22:52:31 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:52:31 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:52:31 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:52:31 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:52:31 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:52:31 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:52:31 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:52:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:52:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:52: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')]} 22:52:31 INFO - https://queue.taskcluster.net/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:52:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:52:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:52:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/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 22:52:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/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 22:52:34 INFO - Downloaded 23195377 bytes. 22:52:34 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 22:52:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:52:34 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 22:52:35 INFO - Return code: 0 22:52:35 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 22:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:35 INFO - https://queue.taskcluster.net/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:52:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:52:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:52:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/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 22:52:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/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 22:52:41 INFO - Downloaded 23195377 bytes. 22:52:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 22:52:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:52:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:52:42 INFO - Return code: 0 22:52:42 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')]} 22:52:42 INFO - https://queue.taskcluster.net/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:52:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:52:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:52:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/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 22:52:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/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 22:52:43 INFO - Downloaded 11132285 bytes. 22:52:43 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 22:52:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:52:43 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 22:52:43 INFO - Return code: 0 22:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:43 INFO - https://queue.taskcluster.net/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:52:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:52:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:52:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/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 22:52:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BFHT1GX_RMOL7JQLEjLNQA/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 22:52:44 INFO - Downloaded 54935246 bytes. 22:52:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:52:44 INFO - mkdir: /builds/slave/test-pgo/properties 22:52:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:52:44 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:52:44 INFO - Contents: 22:52:44 INFO - build_url:https://queue.taskcluster.net/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:52:44 INFO - Running post-action listener: _resource_record_post_action 22:52:44 INFO - Running post-action listener: set_extra_try_arguments 22:52:44 INFO - ##### 22:52:44 INFO - ##### Running populate-webroot step. 22:52:44 INFO - ##### 22:52:44 INFO - Running pre-action listener: _resource_record_pre_action 22:52:44 INFO - Running main action method: populate_webroot 22:52:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:52:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:52:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:52:44 INFO - '--tppagecycles', 22:52:44 INFO - '7'], 22:52:44 INFO - 'tests': ['tsvgm']}}, 22:52:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:52:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:52:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:52:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:52:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:52:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:52:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:52:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:44 INFO - 'talos_options': ['--e10s'], 22:52:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:52:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:44 INFO - 'tests': ['damp', 'tps']}, 22:52:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:44 INFO - 'talos_options': ['--e10s'], 22:52:44 INFO - 'tests': ['damp', 'tps']}, 22:52:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:52:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:52:44 INFO - 'other': {'tests': ['a11yr', 22:52:44 INFO - 'ts_paint', 22:52:44 INFO - 'tpaint', 22:52:44 INFO - 'sessionrestore', 22:52:44 INFO - 'sessionrestore_no_auto_restore']}, 22:52:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:52:44 INFO - 'tests': ['a11yr', 22:52:44 INFO - 'ts_paint', 22:52:44 INFO - 'tpaint', 22:52:44 INFO - 'sessionrestore', 22:52:44 INFO - 'sessionrestore_no_auto_restore']}, 22:52:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:52:44 INFO - 'tests': ['a11yr', 22:52:44 INFO - 'ts_paint', 22:52:44 INFO - 'tpaint', 22:52:44 INFO - 'sessionrestore', 22:52:44 INFO - 'sessionrestore_no_auto_restore']}, 22:52:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:52:44 INFO - 'tests': ['a11yr', 22:52:44 INFO - 'ts_paint', 22:52:44 INFO - 'tpaint', 22:52:44 INFO - 'sessionrestore', 22:52:44 INFO - 'sessionrestore_no_auto_restore']}, 22:52:44 INFO - 'other_l64': {'tests': ['a11yr', 22:52:44 INFO - 'ts_paint', 22:52:44 INFO - 'tpaint', 22:52:44 INFO - 'sessionrestore', 22:52:44 INFO - 'sessionrestore_no_auto_restore']}, 22:52:44 INFO - 'other_nol64': {'tests': ['a11yr', 22:52:44 INFO - 'ts_paint', 22:52:44 INFO - 'tpaint', 22:52:44 INFO - 'sessionrestore', 22:52:44 INFO - 'sessionrestore_no_auto_restore']}, 22:52:44 INFO - 'svgr': {'tests': ['tsvgx', 22:52:44 INFO - 'tsvgr_opacity', 22:52:44 INFO - 'tart', 22:52:44 INFO - 'tscrollx', 22:52:44 INFO - 'cart']}, 22:52:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:52:44 INFO - 'tests': ['tsvgx', 22:52:44 INFO - 'tsvgr_opacity', 22:52:44 INFO - 'tart', 22:52:44 INFO - 'tscrollx', 22:52:44 INFO - 'cart']}, 22:52:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:44 INFO - 'tests': ['tp5o']}, 22:52:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:44 INFO - 'talos_options': ['--e10s'], 22:52:44 INFO - 'tests': ['tp5o']}, 22:52:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:44 INFO - 'talos_options': ['--xperf_path', 22:52:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:52:44 INFO - 'tests': ['tp5n']}, 22:52:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:52:44 INFO - 'talos_options': ['--e10s', 22:52:44 INFO - '--xperf_path', 22:52:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:52:44 INFO - 'tests': ['tp5n']}}, 22:52:44 INFO - 'talos.zip': {'path': '', 22:52:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:52:44 INFO - Running post-action listener: _resource_record_post_action 22:52:44 INFO - ##### 22:52:44 INFO - ##### Running create-virtualenv step. 22:52:44 INFO - ##### 22:52:44 INFO - Running pre-action listener: _resource_record_pre_action 22:52:44 INFO - Running main action method: create_virtualenv 22:52:44 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:52:44 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 22:52:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:52:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:52:45 INFO - Using real prefix '/usr' 22:52:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:52:45 INFO - Installing distribute.............................................................................................................................................................................................done. 22:52:47 INFO - Installing pip.................done. 22:52:47 INFO - Return code: 0 22:52:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:52:47 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')]} 22:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:47 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')]} 22:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:47 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 0x7fe712548f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174f6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ce40>, '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 0x174d740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174dbf0>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451628954.252844-609829084', '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 22:52:47 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 22:52:47 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 22:52:47 INFO - Using env: {'DISPLAY': ':0', 22:52:47 INFO - 'HOME': '/home/cltbld', 22:52:47 INFO - 'LANG': 'en_US.UTF-8', 22:52:47 INFO - 'LANGUAGE': 'en_US:en', 22:52:47 INFO - 'LOGNAME': 'cltbld', 22:52:47 INFO - 'MAIL': '/var/mail/cltbld', 22:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:47 INFO - 'MOZ_NO_REMOTE': '1', 22:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:47 INFO - 'NO_EM_RESTART': '1', 22:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:52:47 INFO - 'PWD': '/builds/slave/test-pgo', 22:52:47 INFO - 'SHELL': '/bin/bash', 22:52:47 INFO - 'SHLVL': '1', 22:52:47 INFO - 'TERM': 'linux', 22:52:47 INFO - 'TMOUT': '86400', 22:52:47 INFO - 'USER': 'cltbld', 22:52:47 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451628954.252844-609829084', 22:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:47 INFO - '_': '/tools/buildbot/bin/python'} 22:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:47 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 22:52:47 INFO - Cleaning up... 22:52:47 INFO - Return code: 0 22:52:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:52:47 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')]} 22:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:47 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')]} 22:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:47 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 0x7fe712548f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174f6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ce40>, '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 0x174d740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174dbf0>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451628954.252844-609829084', '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 22:52:47 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 22:52:47 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 22:52:47 INFO - Using env: {'DISPLAY': ':0', 22:52:47 INFO - 'HOME': '/home/cltbld', 22:52:47 INFO - 'LANG': 'en_US.UTF-8', 22:52:47 INFO - 'LANGUAGE': 'en_US:en', 22:52:47 INFO - 'LOGNAME': 'cltbld', 22:52:47 INFO - 'MAIL': '/var/mail/cltbld', 22:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:47 INFO - 'MOZ_NO_REMOTE': '1', 22:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:47 INFO - 'NO_EM_RESTART': '1', 22:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:52:47 INFO - 'PWD': '/builds/slave/test-pgo', 22:52:47 INFO - 'SHELL': '/bin/bash', 22:52:47 INFO - 'SHLVL': '1', 22:52:47 INFO - 'TERM': 'linux', 22:52:47 INFO - 'TMOUT': '86400', 22:52:47 INFO - 'USER': 'cltbld', 22:52:47 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451628954.252844-609829084', 22:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:47 INFO - '_': '/tools/buildbot/bin/python'} 22:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:48 INFO - Downloading/unpacking psutil>=0.7.1 22:52:48 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 22:52:48 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 22:52:48 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 22:52:48 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 22:52:48 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 22:52:48 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 22:52:49 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:52:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:52:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:52:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:52:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:52:49 INFO - Installing collected packages: psutil 22:52:49 INFO - Running setup.py install for psutil 22:52:49 INFO - building 'psutil._psutil_linux' extension 22:52:49 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 22:52:50 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 22:52:50 INFO - building 'psutil._psutil_posix' extension 22:52:50 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 22:52:50 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 22:52:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:52:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:52:50 INFO - Successfully installed psutil 22:52:50 INFO - Cleaning up... 22:52:50 INFO - Return code: 0 22:52:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:50 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 0x7fe712548f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174f6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ce40>, '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 0x174d740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174dbf0>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451628954.252844-609829084', '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 22:52:50 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 22:52:50 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 22:52:50 INFO - Using env: {'DISPLAY': ':0', 22:52:50 INFO - 'HOME': '/home/cltbld', 22:52:50 INFO - 'LANG': 'en_US.UTF-8', 22:52:50 INFO - 'LANGUAGE': 'en_US:en', 22:52:50 INFO - 'LOGNAME': 'cltbld', 22:52:50 INFO - 'MAIL': '/var/mail/cltbld', 22:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:50 INFO - 'MOZ_NO_REMOTE': '1', 22:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:50 INFO - 'NO_EM_RESTART': '1', 22:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:52:50 INFO - 'PWD': '/builds/slave/test-pgo', 22:52:50 INFO - 'SHELL': '/bin/bash', 22:52:50 INFO - 'SHLVL': '1', 22:52:50 INFO - 'TERM': 'linux', 22:52:50 INFO - 'TMOUT': '86400', 22:52:50 INFO - 'USER': 'cltbld', 22:52:50 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451628954.252844-609829084', 22:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:50 INFO - '_': '/tools/buildbot/bin/python'} 22:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:52:50 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 22:52:50 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 22:52:50 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 22:52:50 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 22:52:50 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 22:52:50 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 22:52:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:52:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:52:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:52:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:52:52 INFO - Installing collected packages: mozsystemmonitor 22:52:52 INFO - Running setup.py install for mozsystemmonitor 22:52:52 INFO - Successfully installed mozsystemmonitor 22:52:52 INFO - Cleaning up... 22:52:52 INFO - Return code: 0 22:52:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:52 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 0x7fe712548f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174f6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ce40>, '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 0x174d740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174dbf0>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451628954.252844-609829084', '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 22:52:52 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 22:52:52 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 22:52:52 INFO - Using env: {'DISPLAY': ':0', 22:52:52 INFO - 'HOME': '/home/cltbld', 22:52:52 INFO - 'LANG': 'en_US.UTF-8', 22:52:52 INFO - 'LANGUAGE': 'en_US:en', 22:52:52 INFO - 'LOGNAME': 'cltbld', 22:52:52 INFO - 'MAIL': '/var/mail/cltbld', 22:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:52 INFO - 'MOZ_NO_REMOTE': '1', 22:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:52 INFO - 'NO_EM_RESTART': '1', 22:52:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:52:52 INFO - 'PWD': '/builds/slave/test-pgo', 22:52:52 INFO - 'SHELL': '/bin/bash', 22:52:52 INFO - 'SHLVL': '1', 22:52:52 INFO - 'TERM': 'linux', 22:52:52 INFO - 'TMOUT': '86400', 22:52:52 INFO - 'USER': 'cltbld', 22:52:52 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451628954.252844-609829084', 22:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:52 INFO - '_': '/tools/buildbot/bin/python'} 22:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:52 INFO - Downloading/unpacking blobuploader==1.2.4 22:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:54 INFO - Downloading blobuploader-1.2.4.tar.gz 22:52:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:52:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:52:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:52:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:52:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:52:55 INFO - Downloading docopt-0.6.1.tar.gz 22:52:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:52:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:52:55 INFO - Installing collected packages: blobuploader, requests, docopt 22:52:55 INFO - Running setup.py install for blobuploader 22:52:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:52:55 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:52:55 INFO - Running setup.py install for requests 22:52:55 INFO - Running setup.py install for docopt 22:52:55 INFO - Successfully installed blobuploader requests docopt 22:52:55 INFO - Cleaning up... 22:52:55 INFO - Return code: 0 22:52:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:52: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')]} 22:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52: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')]} 22:52:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:55 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 0x7fe712548f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174f6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ce40>, '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 0x174d740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174dbf0>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451628954.252844-609829084', '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 22:52:55 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 22:52:55 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 22:52:55 INFO - Using env: {'DISPLAY': ':0', 22:52:55 INFO - 'HOME': '/home/cltbld', 22:52:55 INFO - 'LANG': 'en_US.UTF-8', 22:52:55 INFO - 'LANGUAGE': 'en_US:en', 22:52:55 INFO - 'LOGNAME': 'cltbld', 22:52:55 INFO - 'MAIL': '/var/mail/cltbld', 22:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:55 INFO - 'MOZ_NO_REMOTE': '1', 22:52:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:55 INFO - 'NO_EM_RESTART': '1', 22:52:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:52:55 INFO - 'PWD': '/builds/slave/test-pgo', 22:52:55 INFO - 'SHELL': '/bin/bash', 22:52:55 INFO - 'SHLVL': '1', 22:52:55 INFO - 'TERM': 'linux', 22:52:55 INFO - 'TMOUT': '86400', 22:52:55 INFO - 'USER': 'cltbld', 22:52:55 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451628954.252844-609829084', 22:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:55 INFO - '_': '/tools/buildbot/bin/python'} 22:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:52:55 INFO - Running setup.py (path:/tmp/pip-BBklXe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:52:56 INFO - Running setup.py (path:/tmp/pip-1SR_zV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:52:56 INFO - Running setup.py (path:/tmp/pip-O_HErp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:52:56 INFO - Running setup.py (path:/tmp/pip-YwO84z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:52:56 INFO - Running setup.py (path:/tmp/pip-PSrHYz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:52:56 INFO - Running setup.py (path:/tmp/pip-vLd5fK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:52:56 INFO - Running setup.py (path:/tmp/pip-S4sB6m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:52:56 INFO - Running setup.py (path:/tmp/pip-MIxHTv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:52:56 INFO - Running setup.py (path:/tmp/pip-rvgoCy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:52:56 INFO - Running setup.py (path:/tmp/pip-JRJLlK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:52:56 INFO - Running setup.py (path:/tmp/pip-Qsfokh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:52:56 INFO - Running setup.py (path:/tmp/pip-_UmoUA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:52:56 INFO - Running setup.py (path:/tmp/pip-AYWV4t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:52:56 INFO - Running setup.py (path:/tmp/pip-cpJKx4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:52:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:52:56 INFO - Running setup.py (path:/tmp/pip-OuCQ1f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:52:57 INFO - Running setup.py (path:/tmp/pip-ji3BFR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:52:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:52:57 INFO - Running setup.py (path:/tmp/pip-WRtKc7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:52:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:52:57 INFO - Running setup.py install for manifestparser 22:52:57 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:52:57 INFO - Running setup.py install for mozcrash 22:52:57 INFO - Running setup.py install for mozdebug 22:52:57 INFO - Running setup.py install for mozdevice 22:52:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:52:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:52:57 INFO - Running setup.py install for mozfile 22:52:57 INFO - Running setup.py install for mozhttpd 22:52:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:52:57 INFO - Running setup.py install for mozinfo 22:52:57 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:52:57 INFO - Running setup.py install for mozInstall 22:52:57 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:52:57 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:52:57 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:52:57 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:52:57 INFO - Running setup.py install for mozleak 22:52:58 INFO - Running setup.py install for mozlog 22:52:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:52:58 INFO - Running setup.py install for moznetwork 22:52:58 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:52:58 INFO - Running setup.py install for mozprocess 22:52:58 INFO - Running setup.py install for mozprofile 22:52:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:52:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:52:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:52:58 INFO - Running setup.py install for mozrunner 22:52:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:52:58 INFO - Running setup.py install for mozscreenshot 22:52:58 INFO - Running setup.py install for moztest 22:52:58 INFO - Running setup.py install for mozversion 22:52:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:52:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:52:58 INFO - Cleaning up... 22:52:58 INFO - Return code: 0 22:52:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:52:58 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')]} 22:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:58 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')]} 22:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:58 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 0x7fe712548f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174f6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ce40>, '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 0x174d740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174dbf0>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451628954.252844-609829084', '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 22:52:58 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 22:52:58 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 22:52:58 INFO - Using env: {'DISPLAY': ':0', 22:52:58 INFO - 'HOME': '/home/cltbld', 22:52:58 INFO - 'LANG': 'en_US.UTF-8', 22:52:58 INFO - 'LANGUAGE': 'en_US:en', 22:52:58 INFO - 'LOGNAME': 'cltbld', 22:52:58 INFO - 'MAIL': '/var/mail/cltbld', 22:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:58 INFO - 'MOZ_NO_REMOTE': '1', 22:52:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:58 INFO - 'NO_EM_RESTART': '1', 22:52:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:52:58 INFO - 'PWD': '/builds/slave/test-pgo', 22:52:58 INFO - 'SHELL': '/bin/bash', 22:52:58 INFO - 'SHLVL': '1', 22:52:58 INFO - 'TERM': 'linux', 22:52:58 INFO - 'TMOUT': '86400', 22:52:58 INFO - 'USER': 'cltbld', 22:52:58 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451628954.252844-609829084', 22:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:58 INFO - '_': '/tools/buildbot/bin/python'} 22:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:52:59 INFO - Running setup.py (path:/tmp/pip-iY44TP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:52:59 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)) 22:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:52:59 INFO - Running setup.py (path:/tmp/pip-OCn8J6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:52:59 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)) 22:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:52:59 INFO - Running setup.py (path:/tmp/pip-zUw_Ls-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:52:59 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)) 22:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:52:59 INFO - Running setup.py (path:/tmp/pip-ill9_6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:52:59 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)) 22:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:52:59 INFO - Running setup.py (path:/tmp/pip-Juphhp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:52:59 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)) 22:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:52:59 INFO - Running setup.py (path:/tmp/pip-Lt48sr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:52:59 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)) 22:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:52:59 INFO - Running setup.py (path:/tmp/pip-J8Naje-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:52:59 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)) 22:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:52:59 INFO - Running setup.py (path:/tmp/pip-V7Mnxj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:52:59 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)) 22:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:52:59 INFO - Running setup.py (path:/tmp/pip-Stjx0h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:52:59 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)) 22:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:52:59 INFO - Running setup.py (path:/tmp/pip-29naa5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:52:59 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)) 22:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:52:59 INFO - Running setup.py (path:/tmp/pip-6FgrQb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:52:59 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)) 22:52:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:52:59 INFO - Running setup.py (path:/tmp/pip-s3IZg1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:53:00 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)) 22:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:53:00 INFO - Running setup.py (path:/tmp/pip-vonMCf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:53:00 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)) 22:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:53:00 INFO - Running setup.py (path:/tmp/pip-8vCnLu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:53:00 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)) 22:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:53:00 INFO - Running setup.py (path:/tmp/pip-fx03nk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:53:00 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)) 22:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:53:00 INFO - Running setup.py (path:/tmp/pip-OCL8nN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:53:00 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)) 22:53:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:53:00 INFO - Running setup.py (path:/tmp/pip-kxbuSn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:53:00 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)) 22:53:00 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)) 22:53:00 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)) 22:53:00 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)) 22:53:00 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)) 22:53:00 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)) 22:53:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:53:00 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 22:53:00 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 22:53:00 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 22:53:00 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 22:53:00 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 22:53:00 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 22:53:02 INFO - Downloading blessings-1.5.1.tar.gz 22:53:02 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 22:53:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:53:02 INFO - Installing collected packages: blessings 22:53:02 INFO - Running setup.py install for blessings 22:53:02 INFO - Successfully installed blessings 22:53:02 INFO - Cleaning up... 22:53:02 INFO - Return code: 0 22:53:02 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:53:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:53:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:53:02 INFO - Reading from file tmpfile_stdout 22:53:02 INFO - Current package versions: 22:53:02 INFO - argparse == 1.2.1 22:53:02 INFO - blessings == 1.5.1 22:53:02 INFO - blobuploader == 1.2.4 22:53:02 INFO - docopt == 0.6.1 22:53:02 INFO - manifestparser == 1.1 22:53:02 INFO - mozInstall == 1.12 22:53:02 INFO - mozcrash == 0.16 22:53:02 INFO - mozdebug == 0.1 22:53:02 INFO - mozdevice == 0.47 22:53:02 INFO - mozfile == 1.2 22:53:02 INFO - mozhttpd == 0.7 22:53:02 INFO - mozinfo == 0.9 22:53:02 INFO - mozleak == 0.1 22:53:02 INFO - mozlog == 3.1 22:53:02 INFO - moznetwork == 0.27 22:53:02 INFO - mozprocess == 0.22 22:53:02 INFO - mozprofile == 0.28 22:53:02 INFO - mozrunner == 6.11 22:53:02 INFO - mozscreenshot == 0.1 22:53:02 INFO - mozsystemmonitor == 0.0 22:53:02 INFO - moztest == 0.7 22:53:02 INFO - mozversion == 1.4 22:53:02 INFO - psutil == 3.1.1 22:53:02 INFO - requests == 1.2.3 22:53:02 INFO - wsgiref == 0.1.2 22:53:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:53: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')]} 22:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53: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')]} 22:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:02 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 0x7fe712548f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174f6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ce40>, '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 0x174d740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174dbf0>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451628954.252844-609829084', '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 22:53:02 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 22:53:02 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 22:53:02 INFO - Using env: {'DISPLAY': ':0', 22:53:02 INFO - 'HOME': '/home/cltbld', 22:53:02 INFO - 'LANG': 'en_US.UTF-8', 22:53:02 INFO - 'LANGUAGE': 'en_US:en', 22:53:02 INFO - 'LOGNAME': 'cltbld', 22:53:02 INFO - 'MAIL': '/var/mail/cltbld', 22:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:02 INFO - 'MOZ_NO_REMOTE': '1', 22:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:02 INFO - 'NO_EM_RESTART': '1', 22:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:02 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:02 INFO - 'SHELL': '/bin/bash', 22:53:02 INFO - 'SHLVL': '1', 22:53:02 INFO - 'TERM': 'linux', 22:53:02 INFO - 'TMOUT': '86400', 22:53:02 INFO - 'USER': 'cltbld', 22:53:02 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451628954.252844-609829084', 22:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:02 INFO - '_': '/tools/buildbot/bin/python'} 22:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:02 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)) 22:53:02 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)) 22:53:02 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)) 22:53:02 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)) 22:53:02 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)) 22:53:02 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)) 22:53:02 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)) 22:53:02 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)) 22:53:02 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)) 22:53:02 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)) 22:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:53:02 INFO - Cleaning up... 22:53:02 INFO - Return code: 0 22:53:02 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:53: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')]} 22:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53: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')]} 22:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:02 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 0x7fe712548f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174f6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ce40>, '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 0x174d740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174dbf0>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451628954.252844-609829084', '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 22:53:02 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 22:53:02 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 22:53:02 INFO - Using env: {'DISPLAY': ':0', 22:53:02 INFO - 'HOME': '/home/cltbld', 22:53:02 INFO - 'LANG': 'en_US.UTF-8', 22:53:02 INFO - 'LANGUAGE': 'en_US:en', 22:53:02 INFO - 'LOGNAME': 'cltbld', 22:53:02 INFO - 'MAIL': '/var/mail/cltbld', 22:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:02 INFO - 'MOZ_NO_REMOTE': '1', 22:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:02 INFO - 'NO_EM_RESTART': '1', 22:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:02 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:02 INFO - 'SHELL': '/bin/bash', 22:53:02 INFO - 'SHLVL': '1', 22:53:02 INFO - 'TERM': 'linux', 22:53:02 INFO - 'TMOUT': '86400', 22:53:02 INFO - 'USER': 'cltbld', 22:53:02 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451628954.252844-609829084', 22:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:02 INFO - '_': '/tools/buildbot/bin/python'} 22:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:03 INFO - Downloading/unpacking jsonschema 22:53:03 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 22:53:03 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 22:53:03 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 22:53:03 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 22:53:03 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 22:53:03 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 22:53:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:53:04 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 22:53:04 INFO - Downloading/unpacking functools32 (from jsonschema) 22:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:04 INFO - Downloading functools32-3.2.3-2.tar.gz 22:53:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:53:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:53:04 INFO - warning: no files found matching '*.txt' 22:53:04 INFO - no previously-included directories found matching 'build' 22:53:04 INFO - no previously-included directories found matching 'dist' 22:53:04 INFO - no previously-included directories found matching '.git*' 22:53:04 INFO - Installing collected packages: jsonschema, functools32 22:53:05 INFO - Running setup.py install for functools32 22:53:05 INFO - warning: no files found matching '*.txt' 22:53:05 INFO - no previously-included directories found matching 'build' 22:53:05 INFO - no previously-included directories found matching 'dist' 22:53:05 INFO - no previously-included directories found matching '.git*' 22:53:05 INFO - Successfully installed jsonschema functools32 22:53:05 INFO - Cleaning up... 22:53:05 INFO - Return code: 0 22:53:05 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:53:05 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')]} 22:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:05 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')]} 22:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:05 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 0x7fe712548f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x174f6c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174ce40>, '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 0x174d740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174dbf0>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1451628954.252844-609829084', '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 22:53:05 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 22:53:05 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 22:53:05 INFO - Using env: {'DISPLAY': ':0', 22:53:05 INFO - 'HOME': '/home/cltbld', 22:53:05 INFO - 'LANG': 'en_US.UTF-8', 22:53:05 INFO - 'LANGUAGE': 'en_US:en', 22:53:05 INFO - 'LOGNAME': 'cltbld', 22:53:05 INFO - 'MAIL': '/var/mail/cltbld', 22:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:05 INFO - 'MOZ_NO_REMOTE': '1', 22:53:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:05 INFO - 'NO_EM_RESTART': '1', 22:53:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:05 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:05 INFO - 'SHELL': '/bin/bash', 22:53:05 INFO - 'SHLVL': '1', 22:53:05 INFO - 'TERM': 'linux', 22:53:05 INFO - 'TMOUT': '86400', 22:53:05 INFO - 'USER': 'cltbld', 22:53:05 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451628954.252844-609829084', 22:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:05 INFO - '_': '/tools/buildbot/bin/python'} 22:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:05 INFO - Downloading/unpacking flake8 22:53:05 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 22:53:05 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 22:53:05 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 22:53:05 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 22:53:05 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 22:53:05 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 22:53:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:53:07 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 22:53:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:53:07 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 22:53:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53:07 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 22:53:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:53:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:53:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:53:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:53:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:53:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:53:07 INFO - no previously-included directories found matching 'docs/_build' 22:53:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:53:07 INFO - Running setup.py install for pep8 22:53:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:53:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:53:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:53:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:53:07 INFO - no previously-included directories found matching 'docs/_build' 22:53:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:53:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:53:07 INFO - Cleaning up... 22:53:07 INFO - Return code: 0 22:53:07 INFO - Running post-action listener: _resource_record_post_action 22:53:07 INFO - Running post-action listener: _start_resource_monitoring 22:53:07 INFO - Starting resource monitoring. 22:53:08 INFO - ##### 22:53:08 INFO - ##### Running install step. 22:53:08 INFO - ##### 22:53:08 INFO - Running pre-action listener: _resource_record_pre_action 22:53:08 INFO - Running main action method: install 22:53:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:53:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:53:08 INFO - Reading from file tmpfile_stdout 22:53:08 INFO - Detecting whether we're running mozinstall >=1.0... 22:53:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:53:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:53:08 INFO - Reading from file tmpfile_stdout 22:53:08 INFO - Output received: 22:53:08 INFO - Usage: mozinstall [options] installer 22:53:08 INFO - Options: 22:53:08 INFO - -h, --help show this help message and exit 22:53:08 INFO - -d DEST, --destination=DEST 22:53:08 INFO - Directory to install application into. [default: 22:53:08 INFO - "/builds/slave/test-pgo"] 22:53:08 INFO - --app=APP Application being installed. [default: firefox] 22:53:08 INFO - mkdir: /builds/slave/test-pgo/build/application 22:53:08 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'] 22:53:08 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 22:53:24 INFO - Reading from file tmpfile_stdout 22:53:24 INFO - Output received: 22:53:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:53:24 INFO - Running post-action listener: _resource_record_post_action 22:53:24 INFO - ##### 22:53:24 INFO - ##### Running run-tests step. 22:53:24 INFO - ##### 22:53:24 INFO - Running pre-action listener: _resource_record_pre_action 22:53:24 INFO - Running main action method: run_tests 22:53:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:53:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:53:24 INFO - Python 2.7.3 22:53:24 INFO - Return code: 0 22:53:24 INFO - grabbing minidump binary from tooltool 22:53:24 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')]} 22:53:24 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 0x174ce40>, '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 0x174d740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x174dbf0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:53:24 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 22:53:24 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 22:53:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:53:24 INFO - Return code: 0 22:53:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:53:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:53:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:53:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:53:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:53:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:53:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:53:25 INFO - Return code: 0 22:53:25 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/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 22:53:25 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/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 22:53:25 INFO - Using env: {'DISPLAY': ':0', 22:53:25 INFO - 'HOME': '/home/cltbld', 22:53:25 INFO - 'LANG': 'en_US.UTF-8', 22:53:25 INFO - 'LANGUAGE': 'en_US:en', 22:53:25 INFO - 'LOGNAME': 'cltbld', 22:53:25 INFO - 'MAIL': '/var/mail/cltbld', 22:53:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:53:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:53:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:25 INFO - 'MOZ_NO_REMOTE': '1', 22:53:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:53:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:25 INFO - 'NO_EM_RESTART': '1', 22:53:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:25 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:53:25 INFO - 'SHELL': '/bin/bash', 22:53:25 INFO - 'SHLVL': '1', 22:53:25 INFO - 'TERM': 'linux', 22:53:25 INFO - 'TMOUT': '86400', 22:53:25 INFO - 'USER': 'cltbld', 22:53:25 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1451628954.252844-609829084', 22:53:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:25 INFO - '_': '/tools/buildbot/bin/python'} 22:53:25 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/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 22:53:25 INFO - mozversion application_buildid: 20151231203134 22:53:25 INFO - mozversion application_changeset: 30c5cd7a3ec750909be74cc68473a6e30ee7f6e6 22:53:25 INFO - mozversion application_display_name: Nightly 22:53:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:53:25 INFO - mozversion application_name: Firefox 22:53:25 INFO - mozversion application_remotingname: firefox 22:53:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:53:25 INFO - mozversion application_vendor: Mozilla 22:53:25 INFO - mozversion application_version: 46.0a1 22:53:25 INFO - mozversion platform_buildid: 20151231203134 22:53:25 INFO - mozversion platform_changeset: 30c5cd7a3ec750909be74cc68473a6e30ee7f6e6 22:53:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:53:25 INFO - mozversion platform_version: 46.0a1 22:53:25 INFO - using testdate: 1451631205 22:53:25 INFO - actual date: 1451631205 22:53:25 INFO - starting webserver on 'localhost:60925' 22:53:25 INFO - SUITE-START | Running 3 tests 22:53:25 INFO - TEST-START | dromaeo_css 22:53:25 INFO - operating with platform_type : linux_ 22:53:25 INFO - Initialising browser for dromaeo_css test... 22:53:25 INFO - TEST-INFO | started process 14783 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsfk8c0/profile http://localhost:60925/getInfo.html) 22:53:29 INFO - PROCESS | 14783 | __metrics Screen width/height:1600/1200 22:53:29 INFO - PROCESS | 14783 | colorDepth:24 22:53:29 INFO - PROCESS | 14783 | Browser inner width/height: 1024/697 22:53:29 INFO - PROCESS | 14783 | __metrics 22:53:29 INFO - PROCESS | 14783 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:53:29 INFO - PROCESS | 14783 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:53:30 INFO - TEST-INFO | 14783: exit 0 22:53:30 INFO - Browser initialized. 22:53:30 INFO - Running cycle 1/1 for dromaeo_css test... 22:53:30 INFO - TEST-INFO | started process 14874 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsfk8c0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:53:42 INFO - PROCESS | 14874 | RSS: Main: 149979136 22:53:42 INFO - PROCESS | 14874 | 22:54:33 INFO - PROCESS | 14874 | 1451631273978 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] 22:56:42 INFO - PROCESS | 14874 | Cycle 1(1): loaded http://localhost:60925/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60925/tests/dromaeo/cssquery-ext.html) 22:56:43 INFO - PROCESS | 14874 | RSS: Main: 268124160 22:56:43 INFO - PROCESS | 14874 | 22:59:46 INFO - PROCESS | 14874 | Cycle 1(1): loaded http://localhost:60925/tests/dromaeo/cssquery-ext.html (next: http://localhost:60925/tests/dromaeo/cssquery-jquery.html) 22:59:46 INFO - PROCESS | 14874 | RSS: Main: 241160192 22:59:46 INFO - PROCESS | 14874 | 23:02:48 INFO - PROCESS | 14874 | Cycle 1(1): loaded http://localhost:60925/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60925/tests/dromaeo/cssquery-mootools.html) 23:02:49 INFO - PROCESS | 14874 | RSS: Main: 227299328 23:02:49 INFO - PROCESS | 14874 | 23:05:51 INFO - PROCESS | 14874 | Cycle 1(1): loaded http://localhost:60925/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60925/tests/dromaeo/cssquery-prototype.html) 23:05:51 INFO - PROCESS | 14874 | RSS: Main: 216670208 23:05:51 INFO - PROCESS | 14874 | 23:08:54 INFO - PROCESS | 14874 | Cycle 1(1): loaded http://localhost:60925/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60925/tests/dromaeo/cssquery-yui.html) 23:08:54 INFO - PROCESS | 14874 | RSS: Main: 219402240 23:08:54 INFO - PROCESS | 14874 | 23:11:57 INFO - PROCESS | 14874 | Cycle 1(1): loaded http://localhost:60925/tests/dromaeo/cssquery-yui.html (next: http://localhost:60925/tests/dromaeo/cssquery-dojo.html) 23:11:57 INFO - PROCESS | 14874 | RSS: Main: 280080384 23:11:57 INFO - PROCESS | 14874 | 23:11:57 INFO - PROCESS | 14874 | __start_tp_report 23:11:57 INFO - PROCESS | 14874 | _x_x_mozilla_page_load 23:11:57 INFO - PROCESS | 14874 | _x_x_mozilla_page_load_details 23:11:57 INFO - PROCESS | 14874 | |i|pagename|runs| 23:11:57 INFO - PROCESS | 14874 | |0;dojo.html;3102.4880894652383;3133.843307834608;3187.6174859016905;3196.7122958933705;3220.6779322067787;5033.723145227011;5149.562287205592;5212.582993360532;5220.582353411733;5252.212168174771;5203.505666961642;5227.137522308814;5248.212768084789;5263.394709608397;5277.762500687469;4710.034442939198;4717.127331443677;4721.763911804396;4774.116788394141;4822.5900798432;4712.5523075307965;4836.467988521277;4860.052289803472;4863.1732605457155;4917.459079501252;4693.9765301173275;4723.267893476499;4786;4802.927956080662;4804.951950480486;4691.671582989192;4705.458872229703;4717.858464246078;4719.716816990992;4735.83424580138;4645.558671926162;4672.953270467286;4691.1555919934735;4698.3187437821325;4738.455077666078;5003.899922001576;5065.290859279704;5082.059818933509;5090.956353947469;5113.51421614946;5484.232207490954;5491;5493.587980901409;5510.889782204374;5536.114221724505;5515.503604675559;5520.861978450531;5524.364698059694;5540.113581826889;5546.223528705985;5124.92312615311;5177.689338639693;5214.191800270926;5216.374035115772;5242.344706911636;5716.056850619601;5728.169415434739;5751.338596061423;5768.278965129359;5787.131930210502;5400.432954539795;5407.053765591006;5488.958362372781;5523.889522209533;5526.50261476469;5510.8071217507195;5595.104783234744;5615.326160860723;5620.185073164368;5626.521745651584;5548.722563871871;5620.156976453564;5632.183333416631;5634.4365563443325;5678.119891416837;5596.076647353222;5644.74598643062;5648.943510564924;5649.830505084854;5652.406497317805;4264.957350426456;4314;4349.782510874507;4387;4421.005273813366;3913.9021524462114;3918.3730603103368;3921.4117882317883;3940.2513522430645;3946.565877753445;5268.1834315681135;5272.130098533776;5277.366715994029;5281.577473802164;5322.33470816148;5439.5104440600535;5544.362398324244;5557.638753481011;5602.131669591138;5653.802116925888;5271.446498117719;5275.4460781618145;5278.419373868871;5284.524392804666;5289.735513224324;4745.976270118696;4754.120487709784;4762.833300834454;4766.833160839424;4810.735409552508;5572.916406253909;5708.514776244066;5720.656760594377;5768.3366412862215;5823.18475413451;5575.135853942646;5579.916301255404;5585.301837270341;5595.916061259166;5602;5699.316082070178;5772.9711351442975;5778.306603207642;5778.94221057784;5780.508656764222;5326.307580014728;5427.782888684408;5489.231507589021;5580.832575022756;5635.492805647347;5563.916541251803;5569.220309156641;5579.218909352613;5581.827816158652;5596.776128954796;5303.390110137229;5435.972820136032;5481.725913704219;5490.039243132356;5534.1145416733125;5421.186821976577;5441.809536666197;5476.424975377528;5491;5530.91703624454;5383.596230282823;5418.02475554404;5428.511433970962;5434.5652347812875;5441.29263195782;5306.389765176899;5485.177223416519;5489.451054894478;5511.787406770504;5524.281843360337;5339.733013349394;5351.812686556108;5418;5426.7829286829665;5455.863603409946 23:11:57 INFO - PROCESS | 14874 | |1;ext.html;533.0644718518998;533.6664584634603;543.0605053257864;557.5121768452603;559.7145455817537;28239.29401764957;28885.133445996602;28886.71113288864;28918.24062871824;28919.975601707887;36882.262354752886;37190.256194876085;37224;37248.25503489935;37341.253174936486;8370.246677798998;8477.491350518958;8528.70149544766;8533.786655333604;8559.486430814171;7458.4033277337685;7631.847363052736;8336.416450848412;8425.915740842605;8453.450525715809;7523.623818809037;10044.949775251114;10232.897671023306;10238;10242.180625549976;9790.5594248259;9907.702768916944;9914.702558923243;9919.702408927707;10020.448875311855;7598.0502437195355;7750.069991600988;9792.90207097927;9898.950505247427;9953.75115622108;36143.81928090369;36281.27437451236;36592.63407365946;36616;36814.631853681385;3321.4021476134285;3389.9491507627404;3444.3111377724554;3492.511048453219;3682.2451397463456;30456;31031.689683103104;31436.214094647818;31606;32396.35207295841;3701.444783282529;3727.2918145552258;3732.197577520819;3772.830222639988;3841.2138952776268;271958;273006;273826;274817;275313.6234318836;59485;59698.40301597015;59815.70092149511;59936.40063599308;60017.39982600205;58481.70759146177;58584;58586;58640.413595863494;58730.70634646885;14751.926240368944;15199.848001520064;15228.619284517976;15231.543053708185;15284.617884552752;11825.822612660817;11992.580259690869;12018.15872888907;12020.398980051137;12030.458629361525;19764.802351976297;20187.495312617008;20260.189592416435;20292.18831246763;20315.796842031687;7359.374453171434;7944.364450843918;7959.110258408736;7979.8404031919035;7994.920050799417;925.5511077127587;1017.6743442098606;1031.742064483879;1058.2116323339162;1069.983950240747;28647.71352286492;28844.711552884204;29206.853965730035;29259.707402926124;30763.69236307653;954.8615450759739;1009.3849840255532;1038.2265212416798;1107.5182295701234;1147.0135683312344;13579.728405432033;13883.37524811386;16257.187140643156;16385.262663180187;16388.83611163873;293710;295827;298777;299974;493452;48075.75962120167;55864.72067639717;56966.71516642473;56984.715076424356;57137.71431142901;1246.7381849811459;1343.563341913882;1353.810466534686;1363.638635761524;1366.2606474019726;26514.469710605295;27877.303067423476;28105.71894281031;28217.294567635974;28460.43079138447;44574.54839983832;45256;45330.32004520001;45560;45737.77131114456;282078;283758;284042;284250;284306;31672;31787.523187152674;32070;32120;32160;41453.79273103615;42730.57269427266;42773.35839962341;42797.14405711931;45985.31022034739;33703;33794.49308260427;34539.13652158616;35167.648323516434;35215.47845215458;35371.115722107155;35480.46779298261;36248.456273155396;36527.26945461129;36666.8166659165;38130.23739525139;38378.232435350576;38784;39160.804195979974;39314.213715726095;27460.038898638453;29052.709472905844;30597.54103688491;30660;34845;23551.764482355644;23648.52702945966;25966.740332596433;26526.86736566305;26576.734232657425 23:11:57 INFO - PROCESS | 14874 | |2;jquery.html;333.51806639406055;334.23793750249433;342.2521789889091;342.32732680283254;342.5273123090135;16436;16476.42332518362;17129.400470983517;17292;17297.0486623236;16230.188490575454;16453.341866325332;16496.34014639413;16683.49949501517;16694.916525417386;5232.293640358541;5284.867878303054;5388.0570900092525;5397.163439666858;5400.891982160374;5273.050850846846;5279.472052794728;5282.894342113155;5293.100172970585;5361.490658387447;3878.612138786113;3978.9005274868214;5234.869128271805;5720.542356611482;5864.354920958691;5800.390958949313;5834.64992100471;5849.85375365615;5851.64890106595;5856.677882716449;3565.94651080234;4998.450170481244;5092.643514953955;5107.7446127693465;5110.540051395392;16834.49496515094;17109.572260693458;17927.820721792876;19083.332083377016;19461.31885384019;2076.5223998480433;2190.3909575914745;2244.136007637055;2545.567253566898;2669.9065532706263;13003.479860805557;13061.693830616958;13128.803067953988;13182.802257966043;13529.120607160503;1729.844314011745;1742.0941110622532;1787.5352408373788;1802.342145117036;1810.9547261318442;52695.73652131753;53415.73292133553;54452.183217251775;58979.70510147465;62316;9254.305927055499;9527.190188833889;9528.809423811485;9606.855897161548;9677.177439917545;12247.448864801105;12301.569445069379;12317.322547259986;12357.691057723448;12365.814512782135;7188.784336469915;7208.603526805971;7226.783196504113;7256.2743725627015;7357.411407087528;6963;6977.825554361181;7009.334113259232;7043.119610048744;7043.92956070443;4055.168690418457;4063.532693740258;4101.384792281182;4181.184668989518;4205.91588168241;1768.0982698823436;1773.9622320942135;1778.3509019208154;1782.2069179215125;1791.0149417820146;939.5114540438933;940.9529523523796;948.2129832239225;969.4425705219527;1027.4349107990574;14109.223992680296;16052.839471605368;16464.341426342813;16522.669546609002;17152.48542543726;902.3593248793298;924.8751418558543;931.1014870649856;961.5384615384654;1026.3687831983277;8163.428560000862;8793.340499462565;8936.28509719234;9730.41617502952;10073.49632518371;522501;526732;535216;538816;538981;72756;76141.61929190319;77246.22753772503;77452.2254777445;77858.6107069461;1169.5088063013554;1170.5727409495644;1170.5961443302047;1176.9936704118027;1185.247367921359;13932.30338483092;15261.923690381476;15517.30172142279;15539.611509712347;15896.602584935468;33537.832310839265;33658.49512257367;34097.82951085229;34223.657763422045;35399.64600354066;45229;45388;45404.545954541354;47150;47635.28547071866;9015.684451044182;9422.811543769223;9592;9604.807903842024;9624.326297159132;11005.064569511682;11091.833622495507;15452.74616526472;17596.648067038845;17887;14397.568072957829;14772.63068423298;14857.405703771728;14859.628509287355;14893.180875051543;14094.36575354091;14344.065833100207;14520.927395362956;14749.852501474848;14932.850671493146;14385.784213237019;14432.567022989328;14616.707665846836;14845.554633361016;15064.246787660353;8108.594570271345;8345.165483451607;9641.469719165514;9651.372660777028;9700.6119755209;12572.434240459019;13888.236147012012;13919.512817051354;13981.300934953415;14132 23:11:57 INFO - PROCESS | 14874 | |3;mootools.html;1338.752330818798;1472.771720383341;1478.3938585180074;1645.9506214813553;1813.845823105036;6594.670266486681;7261.455390845688;7284.526505777134;7320.267973202677;7323.450741194419;7191.892121618167;7354.117505899299;7390;7390.445716571266;7398.260173982599;1992.392320342295;2021.6866385710239;2025.2000459818437;2243.3157886844547;2293.8279629027807;2262.4457008033055;2285.0631241191113;2286.2455389721354;2286.6798648189183;2290.9541809163807;2231.207921187979;2262.061244583504;2293.896774645145;2294.128231272114;2296.5062511560013;2235.9379294834985;2244.9102035918627;2249.4488850231714;2251.4596496840804;2275.72691277047;2278.362058623588;2281.4752606900506;2283.931482055524;2303.7581053989256;2318.4667526469007;7456.7762967111075;7499;7512.098548174254;7521.736739214156;7531.359834414081;4532.274836026253;4550.7724613769515;4561.543845615445;4641.466231383401;4653.208954477747;3097.287623846528;3098.3199532404533;3106.580611617448;3127.7654175936896;3143.1984843864666;939.492673956063;939.7744541310104;951.7906060666711;966.9226461883032;973.4694591447678;10026.047525485068;10041.447720375376;10046.19630429564;10050.798984020352;10055.446950417798;4024.7383920045104;4033.032072302685;4097.528784189856;4154.896127596834;4192.035831758712;8705.608247628872;8707.216350528483;8725.738227853175;8750.737477875675;8763.956180219058;4627.074585082997;4653.557911998355;4657.254839225708;4667.533246675305;4679.766011699401;4189.769562674082;4216.262154123016;4227.133437645275;4227.767472788964;4231.174920890397;3346.715529180047;3359.2945481448683;3573.10672331917;3610.133567943727;3635.8728794073922;1182.2197349749124;1185.9169858110022;1193.4271549656214;1195.235049568277;1204.9156559040957;1054.1145437832258;1054.3252318516156;1096.8080585897435;1186.7033241689578;1303.1008604063165;6939.167299923941;6962.094927659372;7019.157701075801;7039.92960070403;7040.894386584206;1118.9552417903355;1122.6688127002553;1124.1568823382463;1126.9098472122212;1148.2995372822572;5125.333706618116;5182.740862956837;5185.974070129625;5188.63679542436;5191.532762051434;8762.649494020168;8865.601047952858;8949.194572488508;8958.596863141174;9044;8678.435901666371;8781.25359344463;8931.508767017876;8945.642174312954;8969.103089690978;6927.3419025192525;6975.755848545276;7001.684924178424;7033.191183014019;7256.4557658175845;6684.83287917806;6731.831704207434;6735.393814556714;6740.258571557223;6762.797116086525;7757.72847950319;7931.762047138595;8041.597920104088;8046.758597242092;8052.154523775153;8039.196080391914;8132.3494120471405;8173.713920012771;8250.752477425687;8331.83336333282;6499.992501162327;6556.409923106943;6556.901646475211;6577.750227456768;6636.971269453243;6449.258335291313;6539.967300163468;6701.564398314094;6761.154855643044;7024.473164512579;6549.181352330958;6643.069970204078;6657.53397262187;6722.1261236039;6763;6459.03114532805;6470.482361410982;6488.643124628191;6492.28584855656;6599.505037122139;6074.119252708421;6096.817095487142;6102.938970610237;6108.35862234459;6129.478994285536;6110.511159107172;6150.876982460415;6160.537959653134;6186.10301506288;6192.442680158807;6139.416755408229;6206.534509911684;6207.6275423474735;6212.596181248205;6212.751489940532 23:11:57 INFO - PROCESS | 14874 | |4;prototype.html;317.0535950188687;321.09771541967075;323.44206244228707;329.711502435369;334.4381439182173;5884.176215329857;5915.875983563131;5946.07835785454;5947.910781338283;5952.375000624937;5725.971370143144;5908.320543137541;5911.290645122581;5912.231409916715;5913.467787899088;4518.118966801475;4545.250033744428;4562.543745625444;4565.406497155365;4569.885752856172;4323.156984388045;4466.955330446686;4479.969606990394;4545.363649089114;4565.06416184683;4404.427424434835;4409.514953355145;4418.80115394808;4427.11457708458;4427.380166776654;4261.083866968616;4416.697074363071;4434.2905135178535;4452.19860425125;4457.732536047832;3762.5108735864437;3788.280226756935;3804.2201348723447;3816.7709937403565;3855;5672.461116193955;5674.432556744334;5677.460641239076;5691.430856914317;5704.1443783432405;4953.356063711694;5025.919427323107;5077.949220507785;5192.324997750268;5226.111561034633;6243.063540468921;6280.995040793497;6286.057091436275;6294.559380843343;6296.527760417941;4300.978495107535;4301.956980430218;4303.634191093761;4304.6125848673455;4320.82716691332;6366.87266254677;6406.103145559626;6503.089567460559;6513;6525.412712855818;4409.779511024436;4411.823527058882;4435.090806384684;4436.0906014267;4439.64482841372;4488.685791994529;4489.034857505652;4494.258447356149;4494.865154045384;4497.2129877271345;5205.505476979681;5210.322658054429;5213.13983192769;5218.452062533455;5220.3735551734035;6098.176746139215;6323.20959880015;6328.082428047999;6336;6344.49244060474;1557.6728886933645;1578.0610536730626;1579.6050987253186;1579.6998570271612;1580.2335867104446;989.1641562879355;1046.1682962045193;1053.3995622495104;1053.910417614496;1068.893110688925;6012.669303188367;6016.398360164036;6029.60807547508;6032.577719559588;6033.5173186145;6539.967300163468;6542.34576542342;6545.509086818508;6564.638944857983;6575.276719560845;6012.068129439944;6020.096985452217;6020.337762846083;6024.698765061729;6028.125921741323;3436.0722604896537;3537.3102245061964;3540.32733780586;3541.7520773545602;3547.2018795770746;6718.294579069127;6719.496037797087;6725.831854203586;6728.7308507659145;6757.729690812411;6425.293217746044;6740.123783908159;6744.42672372844;6751.527393082437;6760.898586521206;6235.314115447297;6581.3747693969;6684.030815531818;6696.06255124283;6699.464042876558;6494.935050649433;6526.902096468461;6584.242812076673;6596.60420374779;6602.900956485752;6451.161349024596;6491.831470335385;6495.253045899782;6503.772367967098;6504.869902602016;6608.43828274602;6683.9331606685255;6759.898601521079;6765.154355705537;6770.52606317553;4384.978075109604;4430.113977204507;4435.379046933367;4437.1125774845805;4437.889052773707;6562.671866406756;6595.208574971034;6601.603903765597;6606.636634985122;6611.909035009169;6240.095186198067;6401.615903045832;6406.935930640634;6423.935760642334;6444.001179817136;6419.197600299963;6424.646644434601;6429.196350456193;6433.613983161025;6433.613983161025;6248.094026366242;6288.11966324724;6289.465395441439;6297.275813281532;6319.210098737658;6213.782517611862;6412.422881940648;6447.516436267392;6472.223333200046;6472.935270647234;6269.119264220624;6276.560640755286;6280.089387038763;6280.842978925563;6290.716917738621 23:11:57 INFO - PROCESS | 14874 | |5;yui.html;706.4595584377952;755.7128291249326;825.6944930375762;831.7255305749103;841.9115992820754;12648.683782905431;12726.872731272684;12847.100702950796;12868.227906325626;12884.935575322123;12117.33354665493;12207.084468664842;12313.507459701601;12330.938345308261;12345.567905123322;679.5718697220744;690.492488021304;827.7765003449065;837.6105111123327;839.4837175137308;834.4159088637947;834.4993004197463;840.0129847429276;840.2269911681268;840.8318336332727;723.4827098624482;729.4456213277894;873.7990262239689;881.7487016200384;883.6686242659002;860.7417774667606;864.2049314630555;870.0820634230884;870.7605408512646;870.8606622940299;638.4764493115647;640.2924768131242;640.7629177204418;641.5445034025847;644.0339490763854;12725.490980360775;12803.359832008455;12848.678783030406;12889.484420623165;12956;11078.723031924266;11257.887421125766;11286.379249141293;11505;11516.251443656136;9689.27330450219;9722.736044314264;9730.562124704406;9784.853227201598;9824.57543656173;3466.618671946084;3532.9116772080647;3545.8758943437115;3560.5045880730154;3569.8929032129076;43629.78185109086;43906;44274;46448;46486.30270545944;9421.199198068103;9448;9574.425534467815;9743;9897.653582124734;16948.06785626778;16973;16981.066041367598;16983.575410614834;16986.235619397157;6662.933370666328;6726.630035348005;6831.829204269933;6937.895931561031;7075.71697132109;3890.4164375343357;3915.6671682906704;4042.0501182222156;4058.6144316289906;4062.1266427718183;3171.873125074971;3197.136773071304;3206.5671134396557;3209.6950789674943;3210.7270881974828;531.1793279383362;541.0774629257107;544.8801263721975;565.0958466453641;574.379669956446;575.890580789657;631.3875540725489;637.3681840450124;642.1010585180691;656.8456412743002;7428.2571742825285;7586.924130758622;7707.499012564165;7748;7800.531968081933;534.8956953394129;549.85978575463;593.2110293309887;600.7116584039685;604.3533419241458;3434.5363375944426;3641.4901913732097;3650.452432135201;3675.1547144156457;3678.3746763050344;48075.5192448078;48817.511824881294;49475.752621236665;49728;52586.474135258155;49216.50783492191;49880;49919.25121123186;50441.24338134931;50483.24275135876;44013.559864400944;44058.33912491315;46165.30752038722;47322.290165647544;48237.517624823304;7582.54504729718;7683.5005724629955;7977.48146370484;8019.358451323997;8360.122187170502;34622.82688586541;35044.12389690278;35854.82072589621;36598.634013659524;36674.26651467009;44224.77887610541;44616.77691611521;45640.771796140805;46104.7694761524;47516.762416187696;10017.5492102857;10173.898261017592;10177.49112544355;10189.286749927434;10525.421101839473;11321.71695707614;11465.713357166138;11530.481128349076;11591.594294199662;11899.821502677294;10205.285630005828;10248.38509689421;10325.070743633109;10446.216533760151;10938.757554701426;9861.802763944825;10248.128909042814;10283.228757843042;10498.947505262426;10590;9761.365511241747;10032.197424206191;10037.046480584333;10038.996100389902;10071.84892226632;8604.201726832785;8777.253933415732;8779.297656187362;8838.513881736566;8932.19610235082;7412.295831895961;7487.47587668858;7671.046986160647;7970.362371010421;8006.399520035904 23:11:57 INFO - PROCESS | 14874 | __end_tp_report 23:11:57 INFO - PROCESS | 14874 | __start_cc_report 23:11:57 INFO - PROCESS | 14874 | _x_x_mozilla_cycle_collect,962 23:11:57 INFO - PROCESS | 14874 | __end_cc_report 23:11:57 INFO - PROCESS | 14874 | __startTimestamp1451632317562__endTimestamp 23:11:57 INFO - PROCESS | 14874 | 23:11:57 INFO - PROCESS | 14874 | ------- Summary: start ------- 23:11:57 INFO - PROCESS | 14874 | Number of tests: 6 23:11:57 INFO - PROCESS | 14874 | 23:11:57 INFO - PROCESS | 14874 | [#0] dojo.html Cycles:165 Average:5188.54 Median:5407.05 stddev:559.67 (10.4%) stddev-sans-first:536.93 23:11:57 INFO - PROCESS | 14874 | Values: 3102.5 3133.8 3187.6 3196.7 3220.7 5033.7 5149.6 5212.6 5220.6 5252.2 5203.5 5227.1 5248.2 5263.4 5277.8 4710.0 4717.1 4721.8 4774.1 4822.6 4712.6 4836.5 4860.1 4863.2 4917.5 4694.0 4723.3 4786.0 4802.9 4805.0 4691.7 4705.5 4717.9 4719.7 4735.8 4645.6 4673.0 4691.2 4698.3 4738.5 5003.9 5065.3 5082.1 5091.0 5113.5 5484.2 5491.0 5493.6 5510.9 5536.1 5515.5 5520.9 5524.4 5540.1 5546.2 5124.9 5177.7 5214.2 5216.4 5242.3 5716.1 5728.2 5751.3 5768.3 5787.1 5400.4 5407.1 5489.0 5523.9 5526.5 5510.8 5595.1 5615.3 5620.2 5626.5 5548.7 5620.2 5632.2 5634.4 5678.1 5596.1 5644.7 5648.9 5649.8 5652.4 4265.0 4314.0 4349.8 4387.0 4421.0 3913.9 3918.4 3921.4 3940.3 3946.6 5268.2 5272.1 5277.4 5281.6 5322.3 5439.5 5544.4 5557.6 5602.1 5653.8 5271.4 5275.4 5278.4 5284.5 5289.7 4746.0 4754.1 4762.8 4766.8 4810.7 5572.9 5708.5 5720.7 5768.3 5823.2 5575.1 5579.9 5585.3 5595.9 5602.0 5699.3 5773.0 5778.3 5778.9 5780.5 5326.3 5427.8 5489.2 5580.8 5635.5 5563.9 5569.2 5579.2 5581.8 5596.8 5303.4 5436.0 5481.7 5490.0 5534.1 5421.2 5441.8 5476.4 5491.0 5530.9 5383.6 5418.0 5428.5 5434.6 5441.3 5306.4 5485.2 5489.5 5511.8 5524.3 5339.7 5351.8 5418.0 5426.8 5455.9 23:11:57 INFO - PROCESS | 14874 | 23:11:57 INFO - PROCESS | 14874 | [#1] ext.html Cycles:180 Average:46400.50 Median:18991.72 stddev:79360.57 (417.9%) stddev-sans-first:79508.48 23:11:57 INFO - PROCESS | 14874 | Values: 533.1 533.7 543.1 557.5 559.7 28239.3 28885.1 28886.7 28918.2 28920.0 36882.3 37190.3 37224.0 37248.3 37341.3 8370.2 8477.5 8528.7 8533.8 8559.5 7458.4 7631.8 8336.4 8425.9 8453.5 7523.6 10044.9 10232.9 10238.0 10242.2 9790.6 9907.7 9914.7 9919.7 10020.4 7598.1 7750.1 9792.9 9899.0 9953.8 36143.8 36281.3 36592.6 36616.0 36814.6 3321.4 3389.9 3444.3 3492.5 3682.2 30456.0 31031.7 31436.2 31606.0 32396.4 3701.4 3727.3 3732.2 3772.8 3841.2 271958.0 273006.0 273826.0 274817.0 275313.6 59485.0 59698.4 59815.7 59936.4 60017.4 58481.7 58584.0 58586.0 58640.4 58730.7 14751.9 15199.8 15228.6 15231.5 15284.6 11825.8 11992.6 12018.2 12020.4 12030.5 19764.8 20187.5 20260.2 20292.2 20315.8 7359.4 7944.4 7959.1 7979.8 7994.9 925.6 1017.7 1031.7 1058.2 1070.0 28647.7 28844.7 29206.9 29259.7 30763.7 954.9 1009.4 1038.2 1107.5 1147.0 13579.7 13883.4 16257.2 16385.3 16388.8 293710.0 295827.0 298777.0 299974.0 493452.0 48075.8 55864.7 56966.7 56984.7 57137.7 1246.7 1343.6 1353.8 1363.6 1366.3 26514.5 27877.3 28105.7 28217.3 28460.4 44574.5 45256.0 45330.3 45560.0 45737.8 282078.0 283758.0 284042.0 284250.0 284306.0 31672.0 31787.5 32070.0 32120.0 32160.0 41453.8 42730.6 42773.4 42797.1 45985.3 33703.0 33794.5 34539.1 35167.6 35215.5 35371.1 35480.5 36248.5 36527.3 36666.8 38130.2 38378.2 38784.0 39160.8 39314.2 27460.0 29052.7 30597.5 30660.0 34845.0 23551.8 23648.5 25966.7 26526.9 26576.7 23:11:57 INFO - PROCESS | 14874 | 23:11:57 INFO - PROCESS | 14874 | [#2] jquery.html Cycles:180 Average:28253.23 Median:17283.09 stddev:86925.24 (502.9%) stddev-sans-first:87143.81 23:11:57 INFO - PROCESS | 14874 | Values: 333.5 334.2 342.3 342.3 342.5 16436.0 16476.4 17129.4 17292.0 17297.0 16230.2 16453.3 16496.3 16683.5 16694.9 5232.3 5284.9 5388.1 5397.2 5400.9 5273.1 5279.5 5282.9 5293.1 5361.5 3878.6 3978.9 5234.9 5720.5 5864.4 5800.4 5834.6 5849.9 5851.6 5856.7 3565.9 4998.5 5092.6 5107.7 5110.5 16834.5 17109.6 17927.8 19083.3 19461.3 2076.5 2190.4 2244.1 2545.6 2669.9 13003.5 13061.7 13128.8 13182.8 13529.1 1729.8 1742.1 1787.5 1802.3 1811.0 52695.7 53415.7 54452.2 58979.7 62316.0 9254.3 9527.2 9528.8 9606.9 9677.2 12247.4 12301.6 12317.3 12357.7 12365.8 7188.8 7208.6 7226.8 7256.3 7357.4 6963.0 6977.8 7009.3 7043.1 7043.9 4055.2 4063.5 4101.4 4181.2 4205.9 1768.1 1774.0 1778.4 1782.2 1791.0 939.5 941.0 948.2 969.4 1027.4 14109.2 16052.8 16464.3 16522.7 17152.5 902.4 924.9 931.1 961.5 1026.4 8163.4 8793.3 8936.3 9730.4 10073.5 522501.0 526732.0 535216.0 538816.0 538981.0 72756.0 76141.6 77246.2 77452.2 77858.6 1169.5 1170.6 1170.6 1177.0 1185.2 13932.3 15261.9 15517.3 15539.6 15896.6 33537.8 33658.5 34097.8 34223.7 35399.6 45229.0 45388.0 45404.5 47150.0 47635.3 9015.7 9422.8 9592.0 9604.8 9624.3 11005.1 11091.8 15452.7 17596.6 17887.0 14397.6 14772.6 14857.4 14859.6 14893.2 14094.4 14344.1 14520.9 14749.9 14932.9 14385.8 14432.6 14616.7 14845.6 15064.2 8108.6 8345.2 9641.5 9651.4 9700.6 12572.4 13888.2 13919.5 13981.3 14132.0 23:11:57 INFO - PROCESS | 14874 | 23:11:57 INFO - PROCESS | 14874 | [#3] mootools.html Cycles:180 Average:5191.88 Median:6134.45 stddev:2630.04 (42.9%) stddev-sans-first:2621.47 23:11:57 INFO - PROCESS | 14874 | Values: 1338.8 1472.8 1478.4 1646.0 1813.8 6594.7 7261.5 7284.5 7320.3 7323.5 7191.9 7354.1 7390.0 7390.4 7398.3 1992.4 2021.7 2025.2 2243.3 2293.8 2262.4 2285.1 2286.2 2286.7 2291.0 2231.2 2262.1 2293.9 2294.1 2296.5 2235.9 2244.9 2249.4 2251.5 2275.7 2278.4 2281.5 2283.9 2303.8 2318.5 7456.8 7499.0 7512.1 7521.7 7531.4 4532.3 4550.8 4561.5 4641.5 4653.2 3097.3 3098.3 3106.6 3127.8 3143.2 939.5 939.8 951.8 966.9 973.5 10026.0 10041.4 10046.2 10050.8 10055.4 4024.7 4033.0 4097.5 4154.9 4192.0 8705.6 8707.2 8725.7 8750.7 8764.0 4627.1 4653.6 4657.3 4667.5 4679.8 4189.8 4216.3 4227.1 4227.8 4231.2 3346.7 3359.3 3573.1 3610.1 3635.9 1182.2 1185.9 1193.4 1195.2 1204.9 1054.1 1054.3 1096.8 1186.7 1303.1 6939.2 6962.1 7019.2 7039.9 7040.9 1119.0 1122.7 1124.2 1126.9 1148.3 5125.3 5182.7 5186.0 5188.6 5191.5 8762.6 8865.6 8949.2 8958.6 9044.0 8678.4 8781.3 8931.5 8945.6 8969.1 6927.3 6975.8 7001.7 7033.2 7256.5 6684.8 6731.8 6735.4 6740.3 6762.8 7757.7 7931.8 8041.6 8046.8 8052.2 8039.2 8132.3 8173.7 8250.8 8331.8 6500.0 6556.4 6556.9 6577.8 6637.0 6449.3 6540.0 6701.6 6761.2 7024.5 6549.2 6643.1 6657.5 6722.1 6763.0 6459.0 6470.5 6488.6 6492.3 6599.5 6074.1 6096.8 6102.9 6108.4 6129.5 6110.5 6150.9 6160.5 6186.1 6192.4 6139.4 6206.5 6207.6 6212.6 6212.8 23:11:57 INFO - PROCESS | 14874 | 23:11:57 INFO - PROCESS | 14874 | [#4] prototype.html Cycles:180 Average:5259.30 Median:6014.53 stddev:1611.02 (26.8%) stddev-sans-first:1572.25 23:11:57 INFO - PROCESS | 14874 | Values: 317.1 321.1 323.4 329.7 334.4 5884.2 5915.9 5946.1 5947.9 5952.4 5726.0 5908.3 5911.3 5912.2 5913.5 4518.1 4545.3 4562.5 4565.4 4569.9 4323.2 4467.0 4480.0 4545.4 4565.1 4404.4 4409.5 4418.8 4427.1 4427.4 4261.1 4416.7 4434.3 4452.2 4457.7 3762.5 3788.3 3804.2 3816.8 3855.0 5672.5 5674.4 5677.5 5691.4 5704.1 4953.4 5025.9 5077.9 5192.3 5226.1 6243.1 6281.0 6286.1 6294.6 6296.5 4301.0 4302.0 4303.6 4304.6 4320.8 6366.9 6406.1 6503.1 6513.0 6525.4 4409.8 4411.8 4435.1 4436.1 4439.6 4488.7 4489.0 4494.3 4494.9 4497.2 5205.5 5210.3 5213.1 5218.5 5220.4 6098.2 6323.2 6328.1 6336.0 6344.5 1557.7 1578.1 1579.6 1579.7 1580.2 989.2 1046.2 1053.4 1053.9 1068.9 6012.7 6016.4 6029.6 6032.6 6033.5 6540.0 6542.3 6545.5 6564.6 6575.3 6012.1 6020.1 6020.3 6024.7 6028.1 3436.1 3537.3 3540.3 3541.8 3547.2 6718.3 6719.5 6725.8 6728.7 6757.7 6425.3 6740.1 6744.4 6751.5 6760.9 6235.3 6581.4 6684.0 6696.1 6699.5 6494.9 6526.9 6584.2 6596.6 6602.9 6451.2 6491.8 6495.3 6503.8 6504.9 6608.4 6683.9 6759.9 6765.2 6770.5 4385.0 4430.1 4435.4 4437.1 4437.9 6562.7 6595.2 6601.6 6606.6 6611.9 6240.1 6401.6 6406.9 6423.9 6444.0 6419.2 6424.6 6429.2 6433.6 6433.6 6248.1 6288.1 6289.5 6297.3 6319.2 6213.8 6412.4 6447.5 6472.2 6472.9 6269.1 6276.6 6280.1 6280.8 6290.7 23:11:57 INFO - PROCESS | 14874 | 23:11:57 INFO - PROCESS | 14874 | [#5] yui.html Cycles:180 Average:13051.01 Median:49346.13 stddev:15263.20 (30.9%) stddev-sans-first:15277.86 23:11:57 INFO - PROCESS | 14874 | Values: 706.5 755.7 825.7 831.7 841.9 12648.7 12726.9 12847.1 12868.2 12884.9 12117.3 12207.1 12313.5 12330.9 12345.6 679.6 690.5 827.8 837.6 839.5 834.4 834.5 840.0 840.2 840.8 723.5 729.4 873.8 881.7 883.7 860.7 864.2 870.1 870.8 870.9 638.5 640.3 640.8 641.5 644.0 12725.5 12803.4 12848.7 12889.5 12956.0 11078.7 11257.9 11286.4 11505.0 11516.3 9689.3 9722.7 9730.6 9784.9 9824.6 3466.6 3532.9 3545.9 3560.5 3569.9 43629.8 43906.0 44274.0 46448.0 46486.3 9421.2 9448.0 9574.4 9743.0 9897.7 16948.1 16973.0 16981.1 16983.6 16986.2 6662.9 6726.6 6831.8 6937.9 7075.7 3890.4 3915.7 4042.1 4058.6 4062.1 3171.9 3197.1 3206.6 3209.7 3210.7 531.2 541.1 544.9 565.1 574.4 575.9 631.4 637.4 642.1 656.8 7428.3 7586.9 7707.5 7748.0 7800.5 534.9 549.9 593.2 600.7 604.4 3434.5 3641.5 3650.5 3675.2 3678.4 48075.5 48817.5 49475.8 49728.0 52586.5 49216.5 49880.0 49919.3 50441.2 50483.2 44013.6 44058.3 46165.3 47322.3 48237.5 7582.5 7683.5 7977.5 8019.4 8360.1 34622.8 35044.1 35854.8 36598.6 36674.3 44224.8 44616.8 45640.8 46104.8 47516.8 10017.5 10173.9 10177.5 10189.3 10525.4 11321.7 11465.7 11530.5 11591.6 11899.8 10205.3 10248.4 10325.1 10446.2 10938.8 9861.8 10248.1 10283.2 10498.9 10590.0 9761.4 10032.2 10037.0 10039.0 10071.8 8604.2 8777.3 8779.3 8838.5 8932.2 7412.3 7487.5 7671.0 7970.4 8006.4 23:11:57 INFO - PROCESS | 14874 | -------- Summary: end -------- 23:11:57 INFO - PROCESS | 14874 | 23:11:58 INFO - TEST-INFO | 14874: exit 0 23:11:58 INFO - TEST-OK | dromaeo_css | took 1112894ms 23:11:58 INFO - TEST-START | kraken 23:11:58 INFO - operating with platform_type : linux_ 23:11:58 INFO - Initialising browser for kraken test... 23:11:58 INFO - TEST-INFO | started process 15068 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdG2Rkt/profile http://localhost:60925/getInfo.html) 23:12:02 INFO - PROCESS | 15068 | __metrics Screen width/height:1600/1200 23:12:02 INFO - PROCESS | 15068 | colorDepth:24 23:12:02 INFO - PROCESS | 15068 | Browser inner width/height: 1024/697 23:12:02 INFO - PROCESS | 15068 | __metrics 23:12:02 INFO - PROCESS | 15068 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:12:02 INFO - PROCESS | 15068 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:12:03 INFO - TEST-INFO | 15068: exit 0 23:12:03 INFO - Browser initialized. 23:12:03 INFO - Running cycle 1/1 for kraken test... 23:12:03 INFO - TEST-INFO | started process 15155 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdG2Rkt/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:12:15 INFO - PROCESS | 15155 | RSS: Main: 150175744 23:12:15 INFO - PROCESS | 15155 | 23:12:17 INFO - PROCESS | 15155 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60925/tests/kraken/driver.html?testName=audio-beat-detection) 23:12:18 INFO - PROCESS | 15155 | RSS: Main: 184578048 23:12:18 INFO - PROCESS | 15155 | 23:12:20 INFO - PROCESS | 15155 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60925/tests/kraken/driver.html?testName=audio-dft) 23:12:21 INFO - PROCESS | 15155 | RSS: Main: 174190592 23:12:21 INFO - PROCESS | 15155 | 23:12:24 INFO - PROCESS | 15155 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60925/tests/kraken/driver.html?testName=audio-fft) 23:12:25 INFO - PROCESS | 15155 | RSS: Main: 160894976 23:12:25 INFO - PROCESS | 15155 | 23:12:27 INFO - PROCESS | 15155 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60925/tests/kraken/driver.html?testName=audio-oscillator) 23:12:27 INFO - PROCESS | 15155 | RSS: Main: 162168832 23:12:27 INFO - PROCESS | 15155 | 23:12:29 INFO - PROCESS | 15155 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60925/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:12:30 INFO - PROCESS | 15155 | RSS: Main: 165081088 23:12:30 INFO - PROCESS | 15155 | 23:12:33 INFO - PROCESS | 15155 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60925/tests/kraken/driver.html?testName=imaging-darkroom) 23:12:33 INFO - PROCESS | 15155 | RSS: Main: 164212736 23:12:33 INFO - PROCESS | 15155 | 23:12:37 INFO - PROCESS | 15155 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60925/tests/kraken/driver.html?testName=imaging-desaturate) 23:12:37 INFO - PROCESS | 15155 | RSS: Main: 166391808 23:12:37 INFO - PROCESS | 15155 | 23:12:40 INFO - PROCESS | 15155 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60925/tests/kraken/driver.html?testName=json-parse-financial) 23:12:41 INFO - PROCESS | 15155 | RSS: Main: 166129664 23:12:41 INFO - PROCESS | 15155 | 23:12:42 INFO - PROCESS | 15155 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60925/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:12:43 INFO - PROCESS | 15155 | RSS: Main: 178622464 23:12:43 INFO - PROCESS | 15155 | 23:12:45 INFO - PROCESS | 15155 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60925/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:12:45 INFO - PROCESS | 15155 | RSS: Main: 177123328 23:12:45 INFO - PROCESS | 15155 | 23:12:47 INFO - PROCESS | 15155 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60925/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:12:48 INFO - PROCESS | 15155 | RSS: Main: 185298944 23:12:48 INFO - PROCESS | 15155 | 23:12:50 INFO - PROCESS | 15155 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60925/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:12:51 INFO - PROCESS | 15155 | RSS: Main: 192532480 23:12:51 INFO - PROCESS | 15155 | 23:12:54 INFO - PROCESS | 15155 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60925/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:12:54 INFO - PROCESS | 15155 | RSS: Main: 191418368 23:12:54 INFO - PROCESS | 15155 | 23:12:56 INFO - PROCESS | 15155 | Cycle 1(1): loaded http://localhost:60925/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60925/tests/kraken/driver.html?testName=ai-astar) 23:12:56 INFO - PROCESS | 15155 | RSS: Main: 250191872 23:12:56 INFO - PROCESS | 15155 | 23:12:56 INFO - PROCESS | 15155 | __start_tp_report 23:12:56 INFO - PROCESS | 15155 | _x_x_mozilla_page_load 23:12:56 INFO - PROCESS | 15155 | _x_x_mozilla_page_load_details 23:12:56 INFO - PROCESS | 15155 | |i|pagename|runs| 23:12:56 INFO - PROCESS | 15155 | |0;ai-astar;111;112;103;110;111;113;101;110;110;101 23:12:56 INFO - PROCESS | 15155 | |1;audio-beat-detection;156;127;151;161;131;156;157;133;183;124 23:12:56 INFO - PROCESS | 15155 | |2;audio-dft;164;161;164;166;167;164;161;163;164;162 23:12:56 INFO - PROCESS | 15155 | |3;audio-fft;75;74;82;95;70;73;73;115;93;71 23:12:56 INFO - PROCESS | 15155 | |4;audio-oscillator;97;96;139;95;97;95;140;97;96;140 23:12:56 INFO - PROCESS | 15155 | |5;imaging-gaussian-blur;109;109;110;110;110;109;110;110;110;109 23:12:56 INFO - PROCESS | 15155 | |6;imaging-darkroom;148;147;148;148;147;148;147;147;146;146 23:12:56 INFO - PROCESS | 15155 | |7;imaging-desaturate;95;96;96;95;96;96;97;96;96;96 23:12:56 INFO - PROCESS | 15155 | |8;json-parse-financial;59;58;58;56;58;61;57;66;57;57 23:12:56 INFO - PROCESS | 15155 | |9;json-stringify-tinderbox;69;69;68;69;69;69;69;69;69;69 23:12:56 INFO - PROCESS | 15155 | |10;stanford-crypto-aes;86;95;88;88;88;86;87;96;95;87 23:12:56 INFO - PROCESS | 15155 | |11;stanford-crypto-ccm;117;125;120;117;124;125;116;119;117;121 23:12:56 INFO - PROCESS | 15155 | |12;stanford-crypto-pbkdf2;142;154;154;154;154;144;142;160;150;144 23:12:56 INFO - PROCESS | 15155 | |13;stanford-crypto-sha256-iterative;67;70;69;68;69;68;67;70;69;67 23:12:56 INFO - PROCESS | 15155 | __end_tp_report 23:12:56 INFO - PROCESS | 15155 | __start_cc_report 23:12:56 INFO - PROCESS | 15155 | _x_x_mozilla_cycle_collect,912 23:12:56 INFO - PROCESS | 15155 | __end_cc_report 23:12:56 INFO - PROCESS | 15155 | __startTimestamp1451632376502__endTimestamp 23:12:56 INFO - PROCESS | 15155 | 23:12:56 INFO - PROCESS | 15155 | ------- Summary: start ------- 23:12:56 INFO - PROCESS | 15155 | Number of tests: 14 23:12:56 INFO - PROCESS | 15155 | 23:12:56 INFO - PROCESS | 15155 | [#0] ai-astar Cycles:10 Average:108.20 Median:110.50 stddev:4.64 (4.2%) stddev-sans-first:4.81 23:12:56 INFO - PROCESS | 15155 | Values: 111.0 112.0 103.0 110.0 111.0 113.0 101.0 110.0 110.0 101.0 23:12:56 INFO - PROCESS | 15155 | 23:12:56 INFO - PROCESS | 15155 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:156.00 stddev:18.69 (12.0%) stddev-sans-first:19.59 23:12:56 INFO - PROCESS | 15155 | Values: 156.0 127.0 151.0 161.0 131.0 156.0 157.0 133.0 183.0 124.0 23:12:56 INFO - PROCESS | 15155 | 23:12:56 INFO - PROCESS | 15155 | [#2] audio-dft Cycles:10 Average:163.60 Median:164.00 stddev:1.96 (1.2%) stddev-sans-first:2.07 23:12:56 INFO - PROCESS | 15155 | Values: 164.0 161.0 164.0 166.0 167.0 164.0 161.0 163.0 164.0 162.0 23:12:56 INFO - PROCESS | 15155 | 23:12:56 INFO - PROCESS | 15155 | [#3] audio-fft Cycles:10 Average:82.10 Median:74.50 stddev:14.60 (19.6%) stddev-sans-first:15.26 23:12:56 INFO - PROCESS | 15155 | Values: 75.0 74.0 82.0 95.0 70.0 73.0 73.0 115.0 93.0 71.0 23:12:56 INFO - PROCESS | 15155 | 23:12:56 INFO - PROCESS | 15155 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:96.00 stddev:21.04 (21.9%) stddev-sans-first:21.85 23:12:56 INFO - PROCESS | 15155 | Values: 97.0 96.0 139.0 95.0 97.0 95.0 140.0 97.0 96.0 140.0 23:12:56 INFO - PROCESS | 15155 | 23:12:56 INFO - PROCESS | 15155 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 23:12:56 INFO - PROCESS | 15155 | Values: 109.0 109.0 110.0 110.0 110.0 109.0 110.0 110.0 110.0 109.0 23:12:56 INFO - PROCESS | 15155 | 23:12:56 INFO - PROCESS | 15155 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 23:12:56 INFO - PROCESS | 15155 | Values: 148.0 147.0 148.0 148.0 147.0 148.0 147.0 147.0 146.0 146.0 23:12:56 INFO - PROCESS | 15155 | 23:12:56 INFO - PROCESS | 15155 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 23:12:56 INFO - PROCESS | 15155 | Values: 95.0 96.0 96.0 95.0 96.0 96.0 97.0 96.0 96.0 96.0 23:12:56 INFO - PROCESS | 15155 | 23:12:56 INFO - PROCESS | 15155 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:58.00 stddev:2.91 (5.0%) stddev-sans-first:3.08 23:12:56 INFO - PROCESS | 15155 | Values: 59.0 58.0 58.0 56.0 58.0 61.0 57.0 66.0 57.0 57.0 23:12:56 INFO - PROCESS | 15155 | 23:12:56 INFO - PROCESS | 15155 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 23:12:56 INFO - PROCESS | 15155 | Values: 69.0 69.0 68.0 69.0 69.0 69.0 69.0 69.0 69.0 69.0 23:12:56 INFO - PROCESS | 15155 | 23:12:56 INFO - PROCESS | 15155 | [#10] stanford-crypto-aes Cycles:10 Average:89.60 Median:88.00 stddev:4.03 (4.6%) stddev-sans-first:4.06 23:12:56 INFO - PROCESS | 15155 | Values: 86.0 95.0 88.0 88.0 88.0 86.0 87.0 96.0 95.0 87.0 23:12:56 INFO - PROCESS | 15155 | 23:12:56 INFO - PROCESS | 15155 | [#11] stanford-crypto-ccm Cycles:10 Average:120.10 Median:120.50 stddev:3.51 (2.9%) stddev-sans-first:3.54 23:12:56 INFO - PROCESS | 15155 | Values: 117.0 125.0 120.0 117.0 124.0 125.0 116.0 119.0 117.0 121.0 23:12:56 INFO - PROCESS | 15155 | 23:12:56 INFO - PROCESS | 15155 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.80 Median:154.00 stddev:6.36 (4.1%) stddev-sans-first:6.08 23:12:56 INFO - PROCESS | 15155 | Values: 142.0 154.0 154.0 154.0 154.0 144.0 142.0 160.0 150.0 144.0 23:12:56 INFO - PROCESS | 15155 | 23:12:56 INFO - PROCESS | 15155 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:69.00 stddev:1.17 (1.7%) stddev-sans-first:1.13 23:12:56 INFO - PROCESS | 15155 | Values: 67.0 70.0 69.0 68.0 69.0 68.0 67.0 70.0 69.0 67.0 23:12:56 INFO - PROCESS | 15155 | -------- Summary: end -------- 23:12:56 INFO - PROCESS | 15155 | 23:12:57 INFO - TEST-INFO | 15155: exit 0 23:12:57 INFO - TEST-OK | kraken | took 59107ms 23:12:57 INFO - TEST-START | v8_7 23:12:57 INFO - operating with platform_type : linux_ 23:12:57 INFO - Initialising browser for v8_7 test... 23:12:57 INFO - TEST-INFO | started process 15407 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRzXOxX/profile http://localhost:60925/getInfo.html) 23:13:01 INFO - PROCESS | 15407 | __metrics Screen width/height:1600/1200 23:13:01 INFO - PROCESS | 15407 | colorDepth:24 23:13:01 INFO - PROCESS | 15407 | Browser inner width/height: 1024/697 23:13:01 INFO - PROCESS | 15407 | __metrics 23:13:01 INFO - PROCESS | 15407 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:13:01 INFO - PROCESS | 15407 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:13:02 INFO - TEST-INFO | 15407: exit 0 23:13:02 INFO - Browser initialized. 23:13:02 INFO - Running cycle 1/1 for v8_7 test... 23:13:02 INFO - TEST-INFO | started process 15494 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRzXOxX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:13:14 INFO - PROCESS | 15494 | RSS: Main: 150388736 23:13:14 INFO - PROCESS | 15494 | 23:13:35 INFO - PROCESS | 15494 | Cycle 1(1): loaded http://localhost:60925/tests/v8_7/run.html (next: http://localhost:60925/tests/v8_7/run.html) 23:13:36 INFO - PROCESS | 15494 | RSS: Main: 581730304 23:13:36 INFO - PROCESS | 15494 | 23:13:36 INFO - PROCESS | 15494 | __start_tp_report 23:13:36 INFO - PROCESS | 15494 | _x_x_mozilla_page_load 23:13:36 INFO - PROCESS | 15494 | _x_x_mozilla_page_load_details 23:13:36 INFO - PROCESS | 15494 | |i|pagename|runs| 23:13:36 INFO - PROCESS | 15494 | |0;Richards;170.09695526450076 23:13:36 INFO - PROCESS | 15494 | |1;DeltaBlue;190.43991620643686 23:13:36 INFO - PROCESS | 15494 | |2;Encrypt;280.58361391694723 23:13:36 INFO - PROCESS | 15494 | |3;Decrypt;5306.878306878307 23:13:36 INFO - PROCESS | 15494 | |4;RayTrace;1990.0596421471173 23:13:36 INFO - PROCESS | 15494 | |5;Earley;813.0081300813008 23:13:36 INFO - PROCESS | 15494 | |6;Boyer;11800 23:13:36 INFO - PROCESS | 15494 | |7;RegExp;25743.589743589742 23:13:36 INFO - PROCESS | 15494 | |8;Splay;646.5295629820051 23:13:36 INFO - PROCESS | 15494 | |9;NavierStokes;4845.410628019324 23:13:36 INFO - PROCESS | 15494 | __end_tp_report 23:13:36 INFO - PROCESS | 15494 | __startTimestamp1451632416038__endTimestamp 23:13:36 INFO - PROCESS | 15494 | 23:13:36 INFO - PROCESS | 15494 | ------- Summary: start ------- 23:13:36 INFO - PROCESS | 15494 | Number of tests: 10 23:13:36 INFO - PROCESS | 15494 | 23:13:36 INFO - PROCESS | 15494 | [#0] Richards Cycles:1 Average:170.10 Median:170.10 stddev:0.00 (0.0%) 23:13:36 INFO - PROCESS | 15494 | Values: 170.1 23:13:36 INFO - PROCESS | 15494 | 23:13:36 INFO - PROCESS | 15494 | [#1] DeltaBlue Cycles:1 Average:190.44 Median:190.44 stddev:0.00 (0.0%) 23:13:36 INFO - PROCESS | 15494 | Values: 190.4 23:13:36 INFO - PROCESS | 15494 | 23:13:36 INFO - PROCESS | 15494 | [#2] Encrypt Cycles:1 Average:280.58 Median:280.58 stddev:0.00 (0.0%) 23:13:36 INFO - PROCESS | 15494 | Values: 280.6 23:13:36 INFO - PROCESS | 15494 | 23:13:36 INFO - PROCESS | 15494 | [#3] Decrypt Cycles:1 Average:5306.88 Median:5306.88 stddev:0.00 (0.0%) 23:13:36 INFO - PROCESS | 15494 | Values: 5306.9 23:13:36 INFO - PROCESS | 15494 | 23:13:36 INFO - PROCESS | 15494 | [#4] RayTrace Cycles:1 Average:1990.06 Median:1990.06 stddev:0.00 (0.0%) 23:13:36 INFO - PROCESS | 15494 | Values: 1990.1 23:13:36 INFO - PROCESS | 15494 | 23:13:36 INFO - PROCESS | 15494 | [#5] Earley Cycles:1 Average:813.01 Median:813.01 stddev:0.00 (0.0%) 23:13:36 INFO - PROCESS | 15494 | Values: 813.0 23:13:36 INFO - PROCESS | 15494 | 23:13:36 INFO - PROCESS | 15494 | [#6] Boyer Cycles:1 Average:11800.00 Median:11800.00 stddev:0.00 (0.0%) 23:13:36 INFO - PROCESS | 15494 | Values: 11800.0 23:13:36 INFO - PROCESS | 15494 | 23:13:36 INFO - PROCESS | 15494 | [#7] RegExp Cycles:1 Average:25743.59 Median:25743.59 stddev:0.00 (0.0%) 23:13:36 INFO - PROCESS | 15494 | Values: 25743.6 23:13:36 INFO - PROCESS | 15494 | 23:13:36 INFO - PROCESS | 15494 | [#8] Splay Cycles:1 Average:646.53 Median:646.53 stddev:0.00 (0.0%) 23:13:36 INFO - PROCESS | 15494 | Values: 646.5 23:13:36 INFO - PROCESS | 15494 | 23:13:36 INFO - PROCESS | 15494 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 23:13:36 INFO - PROCESS | 15494 | Values: 4845.4 23:13:36 INFO - PROCESS | 15494 | -------- Summary: end -------- 23:13:36 INFO - PROCESS | 15494 | 23:13:36 INFO - TEST-INFO | 15494: exit 0 23:13:36 INFO - TEST-OK | v8_7 | took 39495ms 23:13:36 INFO - SUITE-END | took 1211s 23:13:37 INFO - Completed test suite (00:20:11) 23:13:37 INFO - Working with test: dromaeo_css 23:13:37 INFO - Generating results file: dromaeo_css 23:13:37 INFO - Working with test: kraken 23:13:37 INFO - Generating results file: kraken 23:13:37 INFO - javascript benchmark 23:13:37 INFO - Working with test: v8_7 23:13:37 INFO - Generating results file: v8_7 23:13:37 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:13:37 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 23:13:37 INFO - process_Request line: dromaeo_css 6818.46 graph.html#tests=[[72,64,35]] 23:13:37 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:13:37 INFO - process_Request line: kraken 1519.20 graph.html#tests=[[232,64,35]] 23:13:37 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:13:37 INFO - process_Request line: v8_7 19602.23 graph.html#tests=[[230,64,35]] 23:13:37 INFO - RETURN: dromaeo_css: 6818.46 23:13:37 INFO - RETURN: kraken: 1519.20 23:13:37 INFO - RETURN: v8_7: 19602.23 23:13:37 INFO - javascript benchmark 23:13:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3102.4880894652383, 3133.843307834608, 3187.6174859016905, 3196.7122958933705, 3220.6779322067787, 5033.723145227011, 5149.562287205592, 5212.582993360532, 5220.582353411733, 5252.212168174771, 5203.505666961642, 5227.137522308814, 5248.212768084789, 5263.394709608397, 5277.762500687469, 4710.034442939198, 4717.127331443677, 4721.763911804396, 4774.116788394141, 4822.5900798432, 4712.5523075307965, 4836.467988521277, 4860.052289803472, 4863.1732605457155, 4917.459079501252, 4693.9765301173275, 4723.267893476499, 4786.0, 4802.927956080662, 4804.951950480486, 4691.671582989192, 4705.458872229703, 4717.858464246078, 4719.716816990992, 4735.83424580138, 4645.558671926162, 4672.953270467286, 4691.1555919934735, 4698.3187437821325, 4738.455077666078, 5003.899922001576, 5065.290859279704, 5082.059818933509, 5090.956353947469, 5113.51421614946, 5484.232207490954, 5491.0, 5493.587980901409, 5510.889782204374, 5536.114221724505, 5515.503604675559, 5520.861978450531, 5524.364698059694, 5540.113581826889, 5546.223528705985, 5124.92312615311, 5177.689338639693, 5214.191800270926, 5216.374035115772, 5242.344706911636, 5716.056850619601, 5728.169415434739, 5751.338596061423, 5768.278965129359, 5787.131930210502, 5400.432954539795, 5407.053765591006, 5488.958362372781, 5523.889522209533, 5526.50261476469, 5510.8071217507195, 5595.104783234744, 5615.326160860723, 5620.185073164368, 5626.521745651584, 5548.722563871871, 5620.156976453564, 5632.183333416631, 5634.4365563443325, 5678.119891416837, 5596.076647353222, 5644.74598643062, 5648.943510564924, 5649.830505084854, 5652.406497317805, 4264.957350426456, 4314.0, 4349.782510874507, 4387.0, 4421.005273813366, 3913.9021524462114, 3918.3730603103368, 3921.4117882317883, 3940.2513522430645, 3946.565877753445, 5268.1834315681135, 5272.130098533776, 5277.366715994029, 5281.577473802164, 5322.33470816148, 5439.5104440600535, 5544.362398324244, 5557.638753481011, 5602.131669591138, 5653.802116925888, 5271.446498117719, 5275.4460781618145, 5278.419373868871, 5284.524392804666, 5289.735513224324, 4745.976270118696, 4754.120487709784, 4762.833300834454, 4766.833160839424, 4810.735409552508, 5572.916406253909, 5708.514776244066, 5720.656760594377, 5768.3366412862215, 5823.18475413451, 5575.135853942646, 5579.916301255404, 5585.301837270341, 5595.916061259166, 5602.0, 5699.316082070178, 5772.9711351442975, 5778.306603207642, 5778.94221057784, 5780.508656764222, 5326.307580014728, 5427.782888684408, 5489.231507589021, 5580.832575022756, 5635.492805647347, 5563.916541251803, 5569.220309156641, 5579.218909352613, 5581.827816158652, 5596.776128954796, 5303.390110137229, 5435.972820136032, 5481.725913704219, 5490.039243132356, 5534.1145416733125, 5421.186821976577, 5441.809536666197, 5476.424975377528, 5491.0, 5530.91703624454, 5383.596230282823, 5418.02475554404, 5428.511433970962, 5434.5652347812875, 5441.29263195782, 5306.389765176899, 5485.177223416519, 5489.451054894478, 5511.787406770504, 5524.281843360337, 5339.733013349394, 5351.812686556108, 5418.0, 5426.7829286829665, 5455.863603409946], "unit": "score", "name": "dojo.html", "value": 5153.4897594239565}, {"lowerIsBetter": false, "replicates": [533.0644718518998, 533.6664584634603, 543.0605053257864, 557.5121768452603, 559.7145455817537, 28239.29401764957, 28885.133445996602, 28886.71113288864, 28918.24062871824, 28919.975601707887, 36882.262354752886, 37190.256194876085, 37224.0, 37248.25503489935, 37341.253174936486, 8370.246677798998, 8477.491350518958, 8528.70149544766, 8533.786655333604, 8559.486430814171, 7458.4033277337685, 7631.847363052736, 8336.416450848412, 8425.915740842605, 8453.450525715809, 7523.623818809037, 10044.949775251114, 10232.897671023306, 10238.0, 10242.180625549976, 9790.5594248259, 9907.702768916944, 9914.702558923243, 9919.702408927707, 10020.448875311855, 7598.0502437195355, 7750.069991600988, 9792.90207097927, 9898.950505247427, 9953.75115622108, 36143.81928090369, 36281.27437451236, 36592.63407365946, 36616.0, 36814.631853681385, 3321.4021476134285, 3389.9491507627404, 3444.3111377724554, 3492.511048453219, 3682.2451397463456, 30456.0, 31031.689683103104, 31436.214094647818, 31606.0, 32396.35207295841, 3701.444783282529, 3727.2918145552258, 3732.197577520819, 3772.830222639988, 3841.2138952776268, 271958.0, 273006.0, 273826.0, 274817.0, 275313.6234318836, 59485.0, 59698.40301597015, 59815.70092149511, 59936.40063599308, 60017.39982600205, 58481.70759146177, 58584.0, 58586.0, 58640.413595863494, 58730.70634646885, 14751.926240368944, 15199.848001520064, 15228.619284517976, 15231.543053708185, 15284.617884552752, 11825.822612660817, 11992.580259690869, 12018.15872888907, 12020.398980051137, 12030.458629361525, 19764.802351976297, 20187.495312617008, 20260.189592416435, 20292.18831246763, 20315.796842031687, 7359.374453171434, 7944.364450843918, 7959.110258408736, 7979.8404031919035, 7994.920050799417, 925.5511077127587, 1017.6743442098606, 1031.742064483879, 1058.2116323339162, 1069.983950240747, 28647.71352286492, 28844.711552884204, 29206.853965730035, 29259.707402926124, 30763.69236307653, 954.8615450759739, 1009.3849840255532, 1038.2265212416798, 1107.5182295701234, 1147.0135683312344, 13579.728405432033, 13883.37524811386, 16257.187140643156, 16385.262663180187, 16388.83611163873, 293710.0, 295827.0, 298777.0, 299974.0, 493452.0, 48075.75962120167, 55864.72067639717, 56966.71516642473, 56984.715076424356, 57137.71431142901, 1246.7381849811459, 1343.563341913882, 1353.810466534686, 1363.638635761524, 1366.2606474019726, 26514.469710605295, 27877.303067423476, 28105.71894281031, 28217.294567635974, 28460.43079138447, 44574.54839983832, 45256.0, 45330.32004520001, 45560.0, 45737.77131114456, 282078.0, 283758.0, 284042.0, 284250.0, 284306.0, 31672.0, 31787.523187152674, 32070.0, 32120.0, 32160.0, 41453.79273103615, 42730.57269427266, 42773.35839962341, 42797.14405711931, 45985.31022034739, 33703.0, 33794.49308260427, 34539.13652158616, 35167.648323516434, 35215.47845215458, 35371.115722107155, 35480.46779298261, 36248.456273155396, 36527.26945461129, 36666.8166659165, 38130.23739525139, 38378.232435350576, 38784.0, 39160.804195979974, 39314.213715726095, 27460.038898638453, 29052.709472905844, 30597.54103688491, 30660.0, 34845.0, 23551.764482355644, 23648.52702945966, 25966.740332596433, 26526.86736566305, 26576.734232657425], "unit": "score", "name": "ext.html", "value": 18348.93432359453}, {"lowerIsBetter": false, "replicates": [333.51806639406055, 334.23793750249433, 342.2521789889091, 342.32732680283254, 342.5273123090135, 16436.0, 16476.42332518362, 17129.400470983517, 17292.0, 17297.0486623236, 16230.188490575454, 16453.341866325332, 16496.34014639413, 16683.49949501517, 16694.916525417386, 5232.293640358541, 5284.867878303054, 5388.0570900092525, 5397.163439666858, 5400.891982160374, 5273.050850846846, 5279.472052794728, 5282.894342113155, 5293.100172970585, 5361.490658387447, 3878.612138786113, 3978.9005274868214, 5234.869128271805, 5720.542356611482, 5864.354920958691, 5800.390958949313, 5834.64992100471, 5849.85375365615, 5851.64890106595, 5856.677882716449, 3565.94651080234, 4998.450170481244, 5092.643514953955, 5107.7446127693465, 5110.540051395392, 16834.49496515094, 17109.572260693458, 17927.820721792876, 19083.332083377016, 19461.31885384019, 2076.5223998480433, 2190.3909575914745, 2244.136007637055, 2545.567253566898, 2669.9065532706263, 13003.479860805557, 13061.693830616958, 13128.803067953988, 13182.802257966043, 13529.120607160503, 1729.844314011745, 1742.0941110622532, 1787.5352408373788, 1802.342145117036, 1810.9547261318442, 52695.73652131753, 53415.73292133553, 54452.183217251775, 58979.70510147465, 62316.0, 9254.305927055499, 9527.190188833889, 9528.809423811485, 9606.855897161548, 9677.177439917545, 12247.448864801105, 12301.569445069379, 12317.322547259986, 12357.691057723448, 12365.814512782135, 7188.784336469915, 7208.603526805971, 7226.783196504113, 7256.2743725627015, 7357.411407087528, 6963.0, 6977.825554361181, 7009.334113259232, 7043.119610048744, 7043.92956070443, 4055.168690418457, 4063.532693740258, 4101.384792281182, 4181.184668989518, 4205.91588168241, 1768.0982698823436, 1773.9622320942135, 1778.3509019208154, 1782.2069179215125, 1791.0149417820146, 939.5114540438933, 940.9529523523796, 948.2129832239225, 969.4425705219527, 1027.4349107990574, 14109.223992680296, 16052.839471605368, 16464.341426342813, 16522.669546609002, 17152.48542543726, 902.3593248793298, 924.8751418558543, 931.1014870649856, 961.5384615384654, 1026.3687831983277, 8163.428560000862, 8793.340499462565, 8936.28509719234, 9730.41617502952, 10073.49632518371, 522501.0, 526732.0, 535216.0, 538816.0, 538981.0, 72756.0, 76141.61929190319, 77246.22753772503, 77452.2254777445, 77858.6107069461, 1169.5088063013554, 1170.5727409495644, 1170.5961443302047, 1176.9936704118027, 1185.247367921359, 13932.30338483092, 15261.923690381476, 15517.30172142279, 15539.611509712347, 15896.602584935468, 33537.832310839265, 33658.49512257367, 34097.82951085229, 34223.657763422045, 35399.64600354066, 45229.0, 45388.0, 45404.545954541354, 47150.0, 47635.28547071866, 9015.684451044182, 9422.811543769223, 9592.0, 9604.807903842024, 9624.326297159132, 11005.064569511682, 11091.833622495507, 15452.74616526472, 17596.648067038845, 17887.0, 14397.568072957829, 14772.63068423298, 14857.405703771728, 14859.628509287355, 14893.180875051543, 14094.36575354091, 14344.065833100207, 14520.927395362956, 14749.852501474848, 14932.850671493146, 14385.784213237019, 14432.567022989328, 14616.707665846836, 14845.554633361016, 15064.246787660353, 8108.594570271345, 8345.165483451607, 9641.469719165514, 9651.372660777028, 9700.6119755209, 12572.434240459019, 13888.236147012012, 13919.512817051354, 13981.300934953415, 14132.0], "unit": "score", "name": "jquery.html", "value": 8730.850242863}, {"lowerIsBetter": false, "replicates": [1338.752330818798, 1472.771720383341, 1478.3938585180074, 1645.9506214813553, 1813.845823105036, 6594.670266486681, 7261.455390845688, 7284.526505777134, 7320.267973202677, 7323.450741194419, 7191.892121618167, 7354.117505899299, 7390.0, 7390.445716571266, 7398.260173982599, 1992.392320342295, 2021.6866385710239, 2025.2000459818437, 2243.3157886844547, 2293.8279629027807, 2262.4457008033055, 2285.0631241191113, 2286.2455389721354, 2286.6798648189183, 2290.9541809163807, 2231.207921187979, 2262.061244583504, 2293.896774645145, 2294.128231272114, 2296.5062511560013, 2235.9379294834985, 2244.9102035918627, 2249.4488850231714, 2251.4596496840804, 2275.72691277047, 2278.362058623588, 2281.4752606900506, 2283.931482055524, 2303.7581053989256, 2318.4667526469007, 7456.7762967111075, 7499.0, 7512.098548174254, 7521.736739214156, 7531.359834414081, 4532.274836026253, 4550.7724613769515, 4561.543845615445, 4641.466231383401, 4653.208954477747, 3097.287623846528, 3098.3199532404533, 3106.580611617448, 3127.7654175936896, 3143.1984843864666, 939.492673956063, 939.7744541310104, 951.7906060666711, 966.9226461883032, 973.4694591447678, 10026.047525485068, 10041.447720375376, 10046.19630429564, 10050.798984020352, 10055.446950417798, 4024.7383920045104, 4033.032072302685, 4097.528784189856, 4154.896127596834, 4192.035831758712, 8705.608247628872, 8707.216350528483, 8725.738227853175, 8750.737477875675, 8763.956180219058, 4627.074585082997, 4653.557911998355, 4657.254839225708, 4667.533246675305, 4679.766011699401, 4189.769562674082, 4216.262154123016, 4227.133437645275, 4227.767472788964, 4231.174920890397, 3346.715529180047, 3359.2945481448683, 3573.10672331917, 3610.133567943727, 3635.8728794073922, 1182.2197349749124, 1185.9169858110022, 1193.4271549656214, 1195.235049568277, 1204.9156559040957, 1054.1145437832258, 1054.3252318516156, 1096.8080585897435, 1186.7033241689578, 1303.1008604063165, 6939.167299923941, 6962.094927659372, 7019.157701075801, 7039.92960070403, 7040.894386584206, 1118.9552417903355, 1122.6688127002553, 1124.1568823382463, 1126.9098472122212, 1148.2995372822572, 5125.333706618116, 5182.740862956837, 5185.974070129625, 5188.63679542436, 5191.532762051434, 8762.649494020168, 8865.601047952858, 8949.194572488508, 8958.596863141174, 9044.0, 8678.435901666371, 8781.25359344463, 8931.508767017876, 8945.642174312954, 8969.103089690978, 6927.3419025192525, 6975.755848545276, 7001.684924178424, 7033.191183014019, 7256.4557658175845, 6684.83287917806, 6731.831704207434, 6735.393814556714, 6740.258571557223, 6762.797116086525, 7757.72847950319, 7931.762047138595, 8041.597920104088, 8046.758597242092, 8052.154523775153, 8039.196080391914, 8132.3494120471405, 8173.713920012771, 8250.752477425687, 8331.83336333282, 6499.992501162327, 6556.409923106943, 6556.901646475211, 6577.750227456768, 6636.971269453243, 6449.258335291313, 6539.967300163468, 6701.564398314094, 6761.154855643044, 7024.473164512579, 6549.181352330958, 6643.069970204078, 6657.53397262187, 6722.1261236039, 6763.0, 6459.03114532805, 6470.482361410982, 6488.643124628191, 6492.28584855656, 6599.505037122139, 6074.119252708421, 6096.817095487142, 6102.938970610237, 6108.35862234459, 6129.478994285536, 6110.511159107172, 6150.876982460415, 6160.537959653134, 6186.10301506288, 6192.442680158807, 6139.416755408229, 6206.534509911684, 6207.6275423474735, 6212.596181248205, 6212.751489940532], "unit": "score", "name": "mootools.html", "value": 4312.060201697924}, {"lowerIsBetter": false, "replicates": [317.0535950188687, 321.09771541967075, 323.44206244228707, 329.711502435369, 334.4381439182173, 5884.176215329857, 5915.875983563131, 5946.07835785454, 5947.910781338283, 5952.375000624937, 5725.971370143144, 5908.320543137541, 5911.290645122581, 5912.231409916715, 5913.467787899088, 4518.118966801475, 4545.250033744428, 4562.543745625444, 4565.406497155365, 4569.885752856172, 4323.156984388045, 4466.955330446686, 4479.969606990394, 4545.363649089114, 4565.06416184683, 4404.427424434835, 4409.514953355145, 4418.80115394808, 4427.11457708458, 4427.380166776654, 4261.083866968616, 4416.697074363071, 4434.2905135178535, 4452.19860425125, 4457.732536047832, 3762.5108735864437, 3788.280226756935, 3804.2201348723447, 3816.7709937403565, 3855.0, 5672.461116193955, 5674.432556744334, 5677.460641239076, 5691.430856914317, 5704.1443783432405, 4953.356063711694, 5025.919427323107, 5077.949220507785, 5192.324997750268, 5226.111561034633, 6243.063540468921, 6280.995040793497, 6286.057091436275, 6294.559380843343, 6296.527760417941, 4300.978495107535, 4301.956980430218, 4303.634191093761, 4304.6125848673455, 4320.82716691332, 6366.87266254677, 6406.103145559626, 6503.089567460559, 6513.0, 6525.412712855818, 4409.779511024436, 4411.823527058882, 4435.090806384684, 4436.0906014267, 4439.64482841372, 4488.685791994529, 4489.034857505652, 4494.258447356149, 4494.865154045384, 4497.2129877271345, 5205.505476979681, 5210.322658054429, 5213.13983192769, 5218.452062533455, 5220.3735551734035, 6098.176746139215, 6323.20959880015, 6328.082428047999, 6336.0, 6344.49244060474, 1557.6728886933645, 1578.0610536730626, 1579.6050987253186, 1579.6998570271612, 1580.2335867104446, 989.1641562879355, 1046.1682962045193, 1053.3995622495104, 1053.910417614496, 1068.893110688925, 6012.669303188367, 6016.398360164036, 6029.60807547508, 6032.577719559588, 6033.5173186145, 6539.967300163468, 6542.34576542342, 6545.509086818508, 6564.638944857983, 6575.276719560845, 6012.068129439944, 6020.096985452217, 6020.337762846083, 6024.698765061729, 6028.125921741323, 3436.0722604896537, 3537.3102245061964, 3540.32733780586, 3541.7520773545602, 3547.2018795770746, 6718.294579069127, 6719.496037797087, 6725.831854203586, 6728.7308507659145, 6757.729690812411, 6425.293217746044, 6740.123783908159, 6744.42672372844, 6751.527393082437, 6760.898586521206, 6235.314115447297, 6581.3747693969, 6684.030815531818, 6696.06255124283, 6699.464042876558, 6494.935050649433, 6526.902096468461, 6584.242812076673, 6596.60420374779, 6602.900956485752, 6451.161349024596, 6491.831470335385, 6495.253045899782, 6503.772367967098, 6504.869902602016, 6608.43828274602, 6683.9331606685255, 6759.898601521079, 6765.154355705537, 6770.52606317553, 4384.978075109604, 4430.113977204507, 4435.379046933367, 4437.1125774845805, 4437.889052773707, 6562.671866406756, 6595.208574971034, 6601.603903765597, 6606.636634985122, 6611.909035009169, 6240.095186198067, 6401.615903045832, 6406.935930640634, 6423.935760642334, 6444.001179817136, 6419.197600299963, 6424.646644434601, 6429.196350456193, 6433.613983161025, 6433.613983161025, 6248.094026366242, 6288.11966324724, 6289.465395441439, 6297.275813281532, 6319.210098737658, 6213.782517611862, 6412.422881940648, 6447.516436267392, 6472.223333200046, 6472.935270647234, 6269.119264220624, 6276.560640755286, 6280.089387038763, 6280.842978925563, 6290.716917738621], "unit": "score", "name": "prototype.html", "value": 4731.282206817162}, {"lowerIsBetter": false, "replicates": [706.4595584377952, 755.7128291249326, 825.6944930375762, 831.7255305749103, 841.9115992820754, 12648.683782905431, 12726.872731272684, 12847.100702950796, 12868.227906325626, 12884.935575322123, 12117.33354665493, 12207.084468664842, 12313.507459701601, 12330.938345308261, 12345.567905123322, 679.5718697220744, 690.492488021304, 827.7765003449065, 837.6105111123327, 839.4837175137308, 834.4159088637947, 834.4993004197463, 840.0129847429276, 840.2269911681268, 840.8318336332727, 723.4827098624482, 729.4456213277894, 873.7990262239689, 881.7487016200384, 883.6686242659002, 860.7417774667606, 864.2049314630555, 870.0820634230884, 870.7605408512646, 870.8606622940299, 638.4764493115647, 640.2924768131242, 640.7629177204418, 641.5445034025847, 644.0339490763854, 12725.490980360775, 12803.359832008455, 12848.678783030406, 12889.484420623165, 12956.0, 11078.723031924266, 11257.887421125766, 11286.379249141293, 11505.0, 11516.251443656136, 9689.27330450219, 9722.736044314264, 9730.562124704406, 9784.853227201598, 9824.57543656173, 3466.618671946084, 3532.9116772080647, 3545.8758943437115, 3560.5045880730154, 3569.8929032129076, 43629.78185109086, 43906.0, 44274.0, 46448.0, 46486.30270545944, 9421.199198068103, 9448.0, 9574.425534467815, 9743.0, 9897.653582124734, 16948.06785626778, 16973.0, 16981.066041367598, 16983.575410614834, 16986.235619397157, 6662.933370666328, 6726.630035348005, 6831.829204269933, 6937.895931561031, 7075.71697132109, 3890.4164375343357, 3915.6671682906704, 4042.0501182222156, 4058.6144316289906, 4062.1266427718183, 3171.873125074971, 3197.136773071304, 3206.5671134396557, 3209.6950789674943, 3210.7270881974828, 531.1793279383362, 541.0774629257107, 544.8801263721975, 565.0958466453641, 574.379669956446, 575.890580789657, 631.3875540725489, 637.3681840450124, 642.1010585180691, 656.8456412743002, 7428.2571742825285, 7586.924130758622, 7707.499012564165, 7748.0, 7800.531968081933, 534.8956953394129, 549.85978575463, 593.2110293309887, 600.7116584039685, 604.3533419241458, 3434.5363375944426, 3641.4901913732097, 3650.452432135201, 3675.1547144156457, 3678.3746763050344, 48075.5192448078, 48817.511824881294, 49475.752621236665, 49728.0, 52586.474135258155, 49216.50783492191, 49880.0, 49919.25121123186, 50441.24338134931, 50483.24275135876, 44013.559864400944, 44058.33912491315, 46165.30752038722, 47322.290165647544, 48237.517624823304, 7582.54504729718, 7683.5005724629955, 7977.48146370484, 8019.358451323997, 8360.122187170502, 34622.82688586541, 35044.12389690278, 35854.82072589621, 36598.634013659524, 36674.26651467009, 44224.77887610541, 44616.77691611521, 45640.771796140805, 46104.7694761524, 47516.762416187696, 10017.5492102857, 10173.898261017592, 10177.49112544355, 10189.286749927434, 10525.421101839473, 11321.71695707614, 11465.713357166138, 11530.481128349076, 11591.594294199662, 11899.821502677294, 10205.285630005828, 10248.38509689421, 10325.070743633109, 10446.216533760151, 10938.757554701426, 9861.802763944825, 10248.128909042814, 10283.228757843042, 10498.947505262426, 10590.0, 9761.365511241747, 10032.197424206191, 10037.046480584333, 10038.996100389902, 10071.84892226632, 8604.201726832785, 8777.253933415732, 8779.297656187362, 8838.513881736566, 8932.19610235082, 7412.295831895961, 7487.47587668858, 7671.046986160647, 7970.362371010421, 8006.399520035904], "unit": "score", "name": "yui.html", "value": 5965.470244653749}], "name": "dromaeo_css", "value": 6818.460499162266}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 103.0, 110.0, 111.0, 113.0, 101.0, 110.0, 110.0, 101.0], "unit": "score", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [156.0, 127.0, 151.0, 161.0, 131.0, 156.0, 157.0, 133.0, 183.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 147.9}, {"lowerIsBetter": true, "replicates": [164.0, 161.0, 164.0, 166.0, 167.0, 164.0, 161.0, 163.0, 164.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.6}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 82.0, 95.0, 70.0, 73.0, 73.0, 115.0, 93.0, 71.0], "unit": "score", "name": "audio-fft", "value": 82.1}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 139.0, 95.0, 97.0, 95.0, 140.0, 97.0, 96.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 109.2}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 148.0, 148.0, 147.0, 148.0, 147.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 58.0, 56.0, 58.0, 61.0, 57.0, 66.0, 57.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.7}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [86.0, 95.0, 88.0, 88.0, 88.0, 86.0, 87.0, 96.0, 95.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.6}, {"lowerIsBetter": true, "replicates": [117.0, 125.0, 120.0, 117.0, 124.0, 125.0, 116.0, 119.0, 117.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.1}, {"lowerIsBetter": true, "replicates": [142.0, 154.0, 154.0, 154.0, 154.0, 144.0, 142.0, 160.0, 150.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.8}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 69.0, 68.0, 69.0, 68.0, 67.0, 70.0, 69.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1519.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.09695526450076], "unit": "score", "name": "Richards", "value": 207.54045799999997}, {"lowerIsBetter": false, "replicates": [190.43991620643686], "unit": "score", "name": "DeltaBlue", "value": 347.1856180000001}, {"lowerIsBetter": false, "replicates": [280.58361391694723], "unit": "score", "name": "Encrypt", "value": 948.6690839999999}, {"lowerIsBetter": false, "replicates": [5306.878306878307], "unit": "score", "name": "Decrypt", "value": 50.15773579262209}, {"lowerIsBetter": false, "replicates": [1990.0596421471173], "unit": "score", "name": "RayTrace", "value": 371.84262437562455}, {"lowerIsBetter": false, "replicates": [813.0081300813008], "unit": "score", "name": "Earley", "value": 819.7494899999999}, {"lowerIsBetter": false, "replicates": [11800.0], "unit": "score", "name": "Boyer", "value": 56.4799152542373}, {"lowerIsBetter": false, "replicates": [25743.589743589742], "unit": "score", "name": "RegExp", "value": 35.38686752988046}, {"lowerIsBetter": false, "replicates": [646.5295629820051], "unit": "score", "name": "Splay", "value": 126.0437335984095}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19602.23069751048}]} 23:13:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19602.23"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1519.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6818.46"}}} 23:13:37 INFO - Return code: 0 23:13:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:13:37 INFO - # TBPL SUCCESS # 23:13:37 INFO - Running post-action listener: _resource_record_post_action 23:13:37 INFO - Running post-run listener: _resource_record_post_run 23:13:38 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 4096; Write bytes: 555245568; Read time: 40; Write time: 531284 23:13:38 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235401216; Read time: 0; Write time: 350276 23:13:38 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 319844352; Read time: 40; Write time: 181008 23:13:38 INFO - Running post-run listener: _upload_blobber_files 23:13:38 INFO - Blob upload gear active. 23:13:38 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:13:38 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 23:13:38 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'] 23:13:38 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 23:13:39 INFO - (blobuploader) - INFO - Open directory for files ... 23:13:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:13:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:13:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:13:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:13:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:13:39 INFO - (blobuploader) - INFO - Done attempting. 23:13:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:13:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:13:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:13:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:13:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:13:40 INFO - (blobuploader) - INFO - Done attempting. 23:13:40 INFO - (blobuploader) - INFO - Iteration through files over. 23:13:40 INFO - Return code: 0 23:13:40 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:13:40 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:13:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/535242059b31c180518b6275496dc7e290d0ebf526778f53c4ae15e319924982098b2fc58c18cd5b47538f4c0b5f574f3ce2078ea946580f306d78f33efc77b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3941b016dfd8235290c4eeae5ab39f77fbc0dafa9b542c7aaa21ef59eff32c6b9b1b6db5d7b73264297310930a118a576b1458fba746dbbf22e6993c64f5b8e4"} 23:13:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:13:40 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:13:40 INFO - Contents: 23:13:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/535242059b31c180518b6275496dc7e290d0ebf526778f53c4ae15e319924982098b2fc58c18cd5b47538f4c0b5f574f3ce2078ea946580f306d78f33efc77b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3941b016dfd8235290c4eeae5ab39f77fbc0dafa9b542c7aaa21ef59eff32c6b9b1b6db5d7b73264297310930a118a576b1458fba746dbbf22e6993c64f5b8e4"} 23:13:40 INFO - Copying logs to upload dir... 23:13:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1272.182517 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-31 23:13:40.505682) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 23:13:40.509467) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1451628954.252844-609829084 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/535242059b31c180518b6275496dc7e290d0ebf526778f53c4ae15e319924982098b2fc58c18cd5b47538f4c0b5f574f3ce2078ea946580f306d78f33efc77b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3941b016dfd8235290c4eeae5ab39f77fbc0dafa9b542c7aaa21ef59eff32c6b9b1b6db5d7b73264297310930a118a576b1458fba746dbbf22e6993c64f5b8e4"} build_url:https://queue.taskcluster.net/v1/task/BFHT1GX_RMOL7JQLEjLNQA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011422 build_url: 'https://queue.taskcluster.net/v1/task/BFHT1GX_RMOL7JQLEjLNQA/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/535242059b31c180518b6275496dc7e290d0ebf526778f53c4ae15e319924982098b2fc58c18cd5b47538f4c0b5f574f3ce2078ea946580f306d78f33efc77b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3941b016dfd8235290c4eeae5ab39f77fbc0dafa9b542c7aaa21ef59eff32c6b9b1b6db5d7b73264297310930a118a576b1458fba746dbbf22e6993c64f5b8e4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 23:13:40.537838) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 23:13:40.538231) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1451628954.252844-609829084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004435 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 23:13:40.622196) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 23:13:40.622544) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 23:13:40.622870) ========= ========= Total master_lag: 0.77 =========