builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1453910414.51 results: success (0) buildid: 20160127053017 builduid: f6c3a2ad3b394252ac4a824b687bb89d revision: 60c5168a485cb166abd27b8eb0b83b919ac4b166 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-27 08:00:14.506200) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-27 08:00:14.506632) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-27 08:00:14.506941) ========= 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=8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006453 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-27 08:00:14.530452) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-27 08:00:14.530743) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-27 08:00:14.544171) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:00:14.544495) ========= 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=8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004673 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:00:14.592923) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-27 08:00:14.593219) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-27 08:00:14.593600) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:00:14.593883) ========= 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=8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-27 08:00:15-- 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% 84.5M=0s 2016-01-27 08:00:15 (84.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099834 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:00:14.706311) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:00:14.706645) ========= 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=8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022222 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:00:14.756091) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:00:14.756427) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 60c5168a485cb166abd27b8eb0b83b919ac4b166 --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 60c5168a485cb166abd27b8eb0b83b919ac4b166 --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=8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-27 08:00:15,309 truncating revision to first 12 chars 2016-01-27 08:00:15,309 Setting DEBUG logging. 2016-01-27 08:00:15,309 attempt 1/10 2016-01-27 08:00:15,309 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/60c5168a485c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-27 08:00:15,564 unpacking tar archive at: fx-team-60c5168a485c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.540741 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:00:15.310996) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-27 08:00:15.311354) ========= echo 60c5168a485cb166abd27b8eb0b83b919ac4b166 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'60c5168a485cb166abd27b8eb0b83b919ac4b166'] 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=8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 60c5168a485cb166abd27b8eb0b83b919ac4b166 program finished with exit code 0 elapsedTime=0.004669 script_repo_revision: '60c5168a485cb166abd27b8eb0b83b919ac4b166' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-27 08:00:15.362094) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-27 08:00:15.362380) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-27 08:00:15.372584) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-27 08:00:15.372929) ========= /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=8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:00:16 INFO - MultiFileLogger online at 20160127 08:00:16 in /builds/slave/test-pgo 08:00:16 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 08:00:16 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:00:16 INFO - {'append_to_log': False, 08:00:16 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:00:16 INFO - 'blob_upload_branch': 'Fx-Team', 08:00:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:00:16 INFO - 'branch': 'Fx-Team', 08:00:16 INFO - 'buildbot_json_path': 'buildprops.json', 08:00:16 INFO - 'config_files': ('talos/linux_config.py',), 08:00:16 INFO - 'default_actions': ('clobber', 08:00:16 INFO - 'read-buildbot-config', 08:00:16 INFO - 'download-and-extract', 08:00:16 INFO - 'populate-webroot', 08:00:16 INFO - 'create-virtualenv', 08:00:16 INFO - 'install', 08:00:16 INFO - 'run-tests'), 08:00:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:00:16 INFO - 'download_minidump_stackwalk': True, 08:00:16 INFO - 'download_symbols': 'ondemand', 08:00:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:00:16 INFO - 'tooltool.py': '/tools/tooltool.py', 08:00:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:00:16 INFO - '/tools/misc-python/virtualenv.py')}, 08:00:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:00:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:00:16 INFO - 'installer_path': 'installer.exe', 08:00:16 INFO - 'log_level': 'info', 08:00:16 INFO - 'log_name': 'talos', 08:00:16 INFO - 'log_to_console': True, 08:00:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:00:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:00:16 INFO - 'opt_config_files': (), 08:00:16 INFO - 'pip_index': False, 08:00:16 INFO - 'sps_profile': False, 08:00:16 INFO - 'sps_profile_interval': 0, 08:00:16 INFO - 'suite': 'dromaeojs', 08:00:16 INFO - 'system_bits': '32', 08:00:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:00:16 INFO - 'title': 'talos-linux64-ix-038', 08:00:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:00:16 INFO - 'use_talos_json': True, 08:00:16 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:00:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:00:16 INFO - 'work_dir': 'build'} 08:00:16 INFO - ##### 08:00:16 INFO - ##### Running clobber step. 08:00:16 INFO - ##### 08:00:16 INFO - Running pre-action listener: _resource_record_pre_action 08:00:16 INFO - Running main action method: clobber 08:00:16 INFO - rmtree: /builds/slave/test-pgo/build 08:00:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:00:17 INFO - Running post-action listener: _resource_record_post_action 08:00:17 INFO - ##### 08:00:17 INFO - ##### Running read-buildbot-config step. 08:00:17 INFO - ##### 08:00:17 INFO - Running pre-action listener: _resource_record_pre_action 08:00:17 INFO - Running main action method: read_buildbot_config 08:00:17 INFO - Using buildbot properties: 08:00:17 INFO - { 08:00:17 INFO - "project": "", 08:00:17 INFO - "product": "firefox", 08:00:17 INFO - "script_repo_revision": "production", 08:00:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:00:17 INFO - "repository": "", 08:00:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:00:17 INFO - "buildid": "20160127053017", 08:00:17 INFO - "pgo_build": "True", 08:00:17 INFO - "basedir": "/builds/slave/test-pgo", 08:00:17 INFO - "buildnumber": 455, 08:00:17 INFO - "slavename": "talos-linux64-ix-038", 08:00:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:00:17 INFO - "platform": "ubuntu64_hw", 08:00:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:00:17 INFO - "branch": "fx-team", 08:00:17 INFO - "repo_path": "integration/fx-team", 08:00:17 INFO - "revision": "60c5168a485cb166abd27b8eb0b83b919ac4b166", 08:00:17 INFO - "stage_platform": "linux64-pgo", 08:00:17 INFO - "builduid": "f6c3a2ad3b394252ac4a824b687bb89d", 08:00:17 INFO - "slavebuilddir": "test" 08:00:17 INFO - } 08:00:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 08:00:17 INFO - Running post-action listener: _resource_record_post_action 08:00:17 INFO - ##### 08:00:17 INFO - ##### Running download-and-extract step. 08:00:17 INFO - ##### 08:00:17 INFO - Running pre-action listener: _resource_record_pre_action 08:00:17 INFO - Running main action method: download_and_extract 08:00:17 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:00:17 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')]} 08:00:17 INFO - https://queue.taskcluster.net/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:00:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/test_packages.json 08:00:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/test_packages.json 08:00:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:00:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:00:19 INFO - Downloaded 1448 bytes. 08:00:19 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:00:19 INFO - Using the following test package requirements: 08:00:19 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:00:19 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:00:19 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:00:19 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:19 INFO - u'jsshell-linux-x86_64.zip'], 08:00:19 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:00:19 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:00:19 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:00:19 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:00:19 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:00:19 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:00:19 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:00:19 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:19 INFO - https://queue.taskcluster.net/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:00:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:00:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:00:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:00:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:00:22 INFO - Downloaded 22503517 bytes. 08:00:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:00:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:00:23 INFO - Return code: 0 08:00:23 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:00:23 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')]} 08:00:23 INFO - https://queue.taskcluster.net/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:00:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:00:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:00:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:00:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:00:25 INFO - Downloaded 22503517 bytes. 08:00:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:00:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:00:26 INFO - Return code: 0 08:00:26 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')]} 08:00:26 INFO - https://queue.taskcluster.net/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:00:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:00:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:00:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:00:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:00:28 INFO - Downloaded 10706572 bytes. 08:00:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:00:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 08:00:28 INFO - Return code: 0 08:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:28 INFO - https://queue.taskcluster.net/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:00:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:00:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:00:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:00:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:00:30 INFO - Downloaded 55980975 bytes. 08:00:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:00:30 INFO - mkdir: /builds/slave/test-pgo/properties 08:00:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:00:30 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:00:30 INFO - Contents: 08:00:30 INFO - build_url:https://queue.taskcluster.net/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:00:30 INFO - Running post-action listener: _resource_record_post_action 08:00:30 INFO - Running post-action listener: set_extra_try_arguments 08:00:30 INFO - ##### 08:00:30 INFO - ##### Running populate-webroot step. 08:00:30 INFO - ##### 08:00:30 INFO - Running pre-action listener: _resource_record_pre_action 08:00:30 INFO - Running main action method: populate_webroot 08:00:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:00:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:00:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:00:30 INFO - '--tppagecycles', 08:00:30 INFO - '7'], 08:00:30 INFO - 'tests': ['tsvgm']}}, 08:00:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:00:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:00:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:00:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:00:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:00:30 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:00:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:00:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:30 INFO - 'talos_options': ['--e10s'], 08:00:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:00:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:30 INFO - 'tests': ['damp', 'tps']}, 08:00:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:30 INFO - 'talos_options': ['--e10s'], 08:00:30 INFO - 'tests': ['damp', 'tps']}, 08:00:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:00:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:00:30 INFO - 'other': {'tests': ['a11yr', 08:00:30 INFO - 'ts_paint', 08:00:30 INFO - 'tpaint', 08:00:30 INFO - 'sessionrestore', 08:00:30 INFO - 'sessionrestore_no_auto_restore']}, 08:00:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:00:30 INFO - 'tests': ['a11yr', 08:00:30 INFO - 'ts_paint', 08:00:30 INFO - 'tpaint', 08:00:30 INFO - 'sessionrestore', 08:00:30 INFO - 'sessionrestore_no_auto_restore']}, 08:00:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:00:30 INFO - 'tests': ['a11yr', 08:00:30 INFO - 'ts_paint', 08:00:30 INFO - 'tpaint', 08:00:30 INFO - 'sessionrestore', 08:00:30 INFO - 'sessionrestore_no_auto_restore']}, 08:00:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:00:30 INFO - 'tests': ['a11yr', 08:00:30 INFO - 'ts_paint', 08:00:30 INFO - 'tpaint', 08:00:30 INFO - 'sessionrestore', 08:00:30 INFO - 'sessionrestore_no_auto_restore']}, 08:00:30 INFO - 'other_l64': {'tests': ['a11yr', 08:00:30 INFO - 'ts_paint', 08:00:30 INFO - 'tpaint', 08:00:30 INFO - 'sessionrestore', 08:00:30 INFO - 'sessionrestore_no_auto_restore']}, 08:00:30 INFO - 'other_nol64': {'tests': ['a11yr', 08:00:30 INFO - 'ts_paint', 08:00:30 INFO - 'tpaint', 08:00:30 INFO - 'sessionrestore', 08:00:30 INFO - 'sessionrestore_no_auto_restore']}, 08:00:30 INFO - 'svgr': {'tests': ['tsvgx', 08:00:30 INFO - 'tsvgr_opacity', 08:00:30 INFO - 'tart', 08:00:30 INFO - 'tscrollx', 08:00:30 INFO - 'cart']}, 08:00:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:00:30 INFO - 'tests': ['tsvgx', 08:00:30 INFO - 'tsvgr_opacity', 08:00:30 INFO - 'tart', 08:00:30 INFO - 'tscrollx', 08:00:30 INFO - 'cart']}, 08:00:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:30 INFO - 'tests': ['tp5o']}, 08:00:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:30 INFO - 'talos_options': ['--e10s'], 08:00:30 INFO - 'tests': ['tp5o']}, 08:00:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:30 INFO - 'talos_options': ['--xperf_path', 08:00:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:00:30 INFO - 'tests': ['tp5n']}, 08:00:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:30 INFO - 'talos_options': ['--e10s', 08:00:30 INFO - '--xperf_path', 08:00:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:00:30 INFO - 'tests': ['tp5n']}}, 08:00:30 INFO - 'talos.zip': {'path': '', 08:00:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:00:30 INFO - Running post-action listener: _resource_record_post_action 08:00:30 INFO - ##### 08:00:30 INFO - ##### Running create-virtualenv step. 08:00:30 INFO - ##### 08:00:30 INFO - Running pre-action listener: _resource_record_pre_action 08:00:30 INFO - Running main action method: create_virtualenv 08:00:30 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:00:30 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 08:00:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:00:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:00:30 INFO - Using real prefix '/usr' 08:00:30 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:00:31 INFO - Installing distribute.............................................................................................................................................................................................done. 08:00:33 INFO - Installing pip.................done. 08:00:33 INFO - Return code: 0 08:00:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:00:33 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')]} 08:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:33 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')]} 08:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f1540346f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cc840>, '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 0x14396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439b60>, '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': '8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202', '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 08:00:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:00:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:00:33 INFO - Using env: {'DISPLAY': ':0', 08:00:33 INFO - 'HOME': '/home/cltbld', 08:00:33 INFO - 'LANG': 'en_US.UTF-8', 08:00:33 INFO - 'LANGUAGE': 'en_US:en', 08:00:33 INFO - 'LOGNAME': 'cltbld', 08:00:33 INFO - 'MAIL': '/var/mail/cltbld', 08:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:33 INFO - 'MOZ_NO_REMOTE': '1', 08:00:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:33 INFO - 'NO_EM_RESTART': '1', 08:00:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:33 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:33 INFO - 'SHELL': '/bin/bash', 08:00:33 INFO - 'SHLVL': '1', 08:00:33 INFO - 'TERM': 'linux', 08:00:33 INFO - 'TMOUT': '86400', 08:00:33 INFO - 'USER': 'cltbld', 08:00:33 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202', 08:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:33 INFO - '_': '/tools/buildbot/bin/python'} 08:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:33 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 08:00:33 INFO - Cleaning up... 08:00:33 INFO - Return code: 0 08:00:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:00:33 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')]} 08:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:33 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')]} 08:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f1540346f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cc840>, '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 0x14396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439b60>, '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': '8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202', '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 08:00:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:00:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:00:33 INFO - Using env: {'DISPLAY': ':0', 08:00:33 INFO - 'HOME': '/home/cltbld', 08:00:33 INFO - 'LANG': 'en_US.UTF-8', 08:00:33 INFO - 'LANGUAGE': 'en_US:en', 08:00:33 INFO - 'LOGNAME': 'cltbld', 08:00:33 INFO - 'MAIL': '/var/mail/cltbld', 08:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:33 INFO - 'MOZ_NO_REMOTE': '1', 08:00:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:33 INFO - 'NO_EM_RESTART': '1', 08:00:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:33 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:33 INFO - 'SHELL': '/bin/bash', 08:00:33 INFO - 'SHLVL': '1', 08:00:33 INFO - 'TERM': 'linux', 08:00:33 INFO - 'TMOUT': '86400', 08:00:33 INFO - 'USER': 'cltbld', 08:00:33 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202', 08:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:33 INFO - '_': '/tools/buildbot/bin/python'} 08:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:33 INFO - Downloading/unpacking psutil>=0.7.1 08:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:00:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:00:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:00:35 INFO - Installing collected packages: psutil 08:00:35 INFO - Running setup.py install for psutil 08:00:35 INFO - building 'psutil._psutil_linux' extension 08:00:35 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 08:00:35 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 08:00:35 INFO - building 'psutil._psutil_posix' extension 08:00:35 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 08:00:36 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 08:00:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:00:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:00:36 INFO - Successfully installed psutil 08:00:36 INFO - Cleaning up... 08:00:36 INFO - Return code: 0 08:00:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:00:36 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')]} 08:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:36 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')]} 08:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f1540346f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cc840>, '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 0x14396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439b60>, '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': '8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202', '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 08:00:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:00:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:00:36 INFO - Using env: {'DISPLAY': ':0', 08:00:36 INFO - 'HOME': '/home/cltbld', 08:00:36 INFO - 'LANG': 'en_US.UTF-8', 08:00:36 INFO - 'LANGUAGE': 'en_US:en', 08:00:36 INFO - 'LOGNAME': 'cltbld', 08:00:36 INFO - 'MAIL': '/var/mail/cltbld', 08:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:36 INFO - 'MOZ_NO_REMOTE': '1', 08:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:36 INFO - 'NO_EM_RESTART': '1', 08:00:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:36 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:36 INFO - 'SHELL': '/bin/bash', 08:00:36 INFO - 'SHLVL': '1', 08:00:36 INFO - 'TERM': 'linux', 08:00:36 INFO - 'TMOUT': '86400', 08:00:36 INFO - 'USER': 'cltbld', 08:00:36 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202', 08:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:36 INFO - '_': '/tools/buildbot/bin/python'} 08:00:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:00:36 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 08:00:36 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 08:00:36 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 08:00:36 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 08:00:36 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 08:00:36 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 08:00:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:00:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:00:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:00:38 INFO - Installing collected packages: mozsystemmonitor 08:00:38 INFO - Running setup.py install for mozsystemmonitor 08:00:38 INFO - Successfully installed mozsystemmonitor 08:00:38 INFO - Cleaning up... 08:00:38 INFO - Return code: 0 08:00:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f1540346f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cc840>, '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 0x14396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439b60>, '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': '8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202', '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 08:00:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:00:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:00:38 INFO - Using env: {'DISPLAY': ':0', 08:00:38 INFO - 'HOME': '/home/cltbld', 08:00:38 INFO - 'LANG': 'en_US.UTF-8', 08:00:38 INFO - 'LANGUAGE': 'en_US:en', 08:00:38 INFO - 'LOGNAME': 'cltbld', 08:00:38 INFO - 'MAIL': '/var/mail/cltbld', 08:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:38 INFO - 'MOZ_NO_REMOTE': '1', 08:00:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:38 INFO - 'NO_EM_RESTART': '1', 08:00:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:38 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:38 INFO - 'SHELL': '/bin/bash', 08:00:38 INFO - 'SHLVL': '1', 08:00:38 INFO - 'TERM': 'linux', 08:00:38 INFO - 'TMOUT': '86400', 08:00:38 INFO - 'USER': 'cltbld', 08:00:38 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202', 08:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:38 INFO - '_': '/tools/buildbot/bin/python'} 08:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:38 INFO - Downloading/unpacking blobuploader==1.2.4 08:00:38 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 08:00:38 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 08:00:38 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 08:00:38 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 08:00:38 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 08:00:38 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 08:00:40 INFO - Downloading blobuploader-1.2.4.tar.gz 08:00:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:00:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:00:40 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 08:00:40 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 08:00:40 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 08:00:40 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 08:00:40 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 08:00:40 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 08:00:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:00:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:00:40 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 08:00:40 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 08:00:40 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 08:00:40 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 08:00:40 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 08:00:40 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 08:00:41 INFO - Downloading docopt-0.6.1.tar.gz 08:00:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:00:41 INFO - Installing collected packages: blobuploader, requests, docopt 08:00:41 INFO - Running setup.py install for blobuploader 08:00:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:00:41 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:00:41 INFO - Running setup.py install for requests 08:00:41 INFO - Running setup.py install for docopt 08:00:41 INFO - Successfully installed blobuploader requests docopt 08:00:41 INFO - Cleaning up... 08:00:41 INFO - Return code: 0 08:00:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:00:41 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')]} 08:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:41 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')]} 08:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f1540346f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cc840>, '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 0x14396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439b60>, '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': '8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202', '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 08:00:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 08:00:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 08:00:41 INFO - Using env: {'DISPLAY': ':0', 08:00:41 INFO - 'HOME': '/home/cltbld', 08:00:41 INFO - 'LANG': 'en_US.UTF-8', 08:00:41 INFO - 'LANGUAGE': 'en_US:en', 08:00:41 INFO - 'LOGNAME': 'cltbld', 08:00:41 INFO - 'MAIL': '/var/mail/cltbld', 08:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:41 INFO - 'MOZ_NO_REMOTE': '1', 08:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:41 INFO - 'NO_EM_RESTART': '1', 08:00:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:41 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:41 INFO - 'SHELL': '/bin/bash', 08:00:41 INFO - 'SHLVL': '1', 08:00:41 INFO - 'TERM': 'linux', 08:00:41 INFO - 'TMOUT': '86400', 08:00:41 INFO - 'USER': 'cltbld', 08:00:41 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202', 08:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:41 INFO - '_': '/tools/buildbot/bin/python'} 08:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:00:41 INFO - Running setup.py (path:/tmp/pip-qTCL5V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:00:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:00:42 INFO - Running setup.py (path:/tmp/pip-NnjEn1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:00:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:00:42 INFO - Running setup.py (path:/tmp/pip-2us0ve-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:00:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:00:42 INFO - Running setup.py (path:/tmp/pip-as2GJn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:00:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:00:42 INFO - Running setup.py (path:/tmp/pip-TZ5rR7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:00:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:00:42 INFO - Running setup.py (path:/tmp/pip-npIGON-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:00:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:00:42 INFO - Running setup.py (path:/tmp/pip-Hyo8yw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:00:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:00:42 INFO - Running setup.py (path:/tmp/pip-nzLLos-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:00:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:00:42 INFO - Running setup.py (path:/tmp/pip-m0xKfN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:00:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:00:42 INFO - Running setup.py (path:/tmp/pip-splwJ2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:00:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:00:42 INFO - Running setup.py (path:/tmp/pip-MosOA_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:00:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:00:42 INFO - Running setup.py (path:/tmp/pip-EzJq6i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:00:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:00:42 INFO - Running setup.py (path:/tmp/pip-yi5z6D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:00:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:00:42 INFO - Running setup.py (path:/tmp/pip-33fOMB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:00:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:00:42 INFO - Running setup.py (path:/tmp/pip-iAqUF8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:00:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:00:43 INFO - Running setup.py (path:/tmp/pip-lNfB5z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:00:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:00:43 INFO - Running setup.py (path:/tmp/pip-Ht66Zv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:00:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:00:43 INFO - Running setup.py install for manifestparser 08:00:43 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:00:43 INFO - Running setup.py install for mozcrash 08:00:43 INFO - Running setup.py install for mozdebug 08:00:43 INFO - Running setup.py install for mozdevice 08:00:43 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:00:43 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:00:43 INFO - Running setup.py install for mozfile 08:00:43 INFO - Running setup.py install for mozhttpd 08:00:43 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:00:43 INFO - Running setup.py install for mozinfo 08:00:43 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:00:43 INFO - Running setup.py install for mozInstall 08:00:43 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:00:43 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:00:43 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:00:43 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:00:43 INFO - Running setup.py install for mozleak 08:00:44 INFO - Running setup.py install for mozlog 08:00:44 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:00:44 INFO - Running setup.py install for moznetwork 08:00:44 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:00:44 INFO - Running setup.py install for mozprocess 08:00:44 INFO - Running setup.py install for mozprofile 08:00:44 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:00:44 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:00:44 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:00:44 INFO - Running setup.py install for mozrunner 08:00:44 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:00:44 INFO - Running setup.py install for mozscreenshot 08:00:44 INFO - Running setup.py install for moztest 08:00:44 INFO - Running setup.py install for mozversion 08:00:44 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:00:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:00:44 INFO - Cleaning up... 08:00:44 INFO - Return code: 0 08:00:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:00:44 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')]} 08:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:44 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')]} 08:00:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f1540346f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cc840>, '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 0x14396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439b60>, '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': '8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202', '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 08:00:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:00:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:00:44 INFO - Using env: {'DISPLAY': ':0', 08:00:44 INFO - 'HOME': '/home/cltbld', 08:00:44 INFO - 'LANG': 'en_US.UTF-8', 08:00:44 INFO - 'LANGUAGE': 'en_US:en', 08:00:44 INFO - 'LOGNAME': 'cltbld', 08:00:44 INFO - 'MAIL': '/var/mail/cltbld', 08:00:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:44 INFO - 'MOZ_NO_REMOTE': '1', 08:00:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:44 INFO - 'NO_EM_RESTART': '1', 08:00:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:44 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:44 INFO - 'SHELL': '/bin/bash', 08:00:44 INFO - 'SHLVL': '1', 08:00:44 INFO - 'TERM': 'linux', 08:00:44 INFO - 'TMOUT': '86400', 08:00:44 INFO - 'USER': 'cltbld', 08:00:44 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202', 08:00:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:44 INFO - '_': '/tools/buildbot/bin/python'} 08:00:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:00:45 INFO - Running setup.py (path:/tmp/pip-M3pFAn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:00:45 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)) 08:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:00:45 INFO - Running setup.py (path:/tmp/pip-NV43ww-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:00:45 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)) 08:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:00:45 INFO - Running setup.py (path:/tmp/pip-eYWCrn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:00:45 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)) 08:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:00:45 INFO - Running setup.py (path:/tmp/pip-01rC9y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:00:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 08:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:00:45 INFO - Running setup.py (path:/tmp/pip-_K0Jbo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:00:45 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)) 08:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:00:45 INFO - Running setup.py (path:/tmp/pip-R95ebF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:00:45 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)) 08:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:00:45 INFO - Running setup.py (path:/tmp/pip-xFVsQn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:00:45 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)) 08:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:00:45 INFO - Running setup.py (path:/tmp/pip-JVU8ne-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:00:45 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)) 08:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:00:45 INFO - Running setup.py (path:/tmp/pip-MDFzyz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:00:45 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)) 08:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:00:45 INFO - Running setup.py (path:/tmp/pip-ibZNh3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:00:45 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)) 08:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:00:45 INFO - Running setup.py (path:/tmp/pip-pCg5Ky-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:00:45 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)) 08:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:00:45 INFO - Running setup.py (path:/tmp/pip-W1GO6k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:00:46 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)) 08:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:00:46 INFO - Running setup.py (path:/tmp/pip-JWgvCd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:00:46 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)) 08:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:00:46 INFO - Running setup.py (path:/tmp/pip-oAKreJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:00:46 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)) 08:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:00:46 INFO - Running setup.py (path:/tmp/pip-h_S2m5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:00:46 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)) 08:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:00:46 INFO - Running setup.py (path:/tmp/pip-VNHNvZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:00:46 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)) 08:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:00:46 INFO - Running setup.py (path:/tmp/pip-_1JF25-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:00:46 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)) 08:00:46 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)) 08:00:46 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)) 08:00:46 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)) 08:00:46 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:00:46 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:00:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:00:46 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 08:00:46 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 08:00:46 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 08:00:46 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 08:00:46 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 08:00:46 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 08:00:48 INFO - Downloading blessings-1.6.tar.gz 08:00:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:00:48 INFO - Installing collected packages: blessings 08:00:48 INFO - Running setup.py install for blessings 08:00:48 INFO - Successfully installed blessings 08:00:48 INFO - Cleaning up... 08:00:48 INFO - Return code: 0 08:00:48 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:00:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:00:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:00:48 INFO - Reading from file tmpfile_stdout 08:00:48 INFO - Current package versions: 08:00:48 INFO - argparse == 1.2.1 08:00:48 INFO - blessings == 1.6 08:00:48 INFO - blobuploader == 1.2.4 08:00:48 INFO - docopt == 0.6.1 08:00:48 INFO - manifestparser == 1.1 08:00:48 INFO - mozInstall == 1.12 08:00:48 INFO - mozcrash == 0.16 08:00:48 INFO - mozdebug == 0.1 08:00:48 INFO - mozdevice == 0.48 08:00:48 INFO - mozfile == 1.2 08:00:48 INFO - mozhttpd == 0.7 08:00:48 INFO - mozinfo == 0.9 08:00:48 INFO - mozleak == 0.1 08:00:48 INFO - mozlog == 3.1 08:00:48 INFO - moznetwork == 0.27 08:00:48 INFO - mozprocess == 0.22 08:00:48 INFO - mozprofile == 0.28 08:00:48 INFO - mozrunner == 6.11 08:00:48 INFO - mozscreenshot == 0.1 08:00:48 INFO - mozsystemmonitor == 0.0 08:00:48 INFO - moztest == 0.7 08:00:48 INFO - mozversion == 1.4 08:00:48 INFO - psutil == 3.1.1 08:00:48 INFO - requests == 1.2.3 08:00:48 INFO - wsgiref == 0.1.2 08:00:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:00:48 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')]} 08:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:48 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')]} 08:00:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f1540346f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cc840>, '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 0x14396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439b60>, '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': '8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202', '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 08:00:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:00:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:00:48 INFO - Using env: {'DISPLAY': ':0', 08:00:48 INFO - 'HOME': '/home/cltbld', 08:00:48 INFO - 'LANG': 'en_US.UTF-8', 08:00:48 INFO - 'LANGUAGE': 'en_US:en', 08:00:48 INFO - 'LOGNAME': 'cltbld', 08:00:48 INFO - 'MAIL': '/var/mail/cltbld', 08:00:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:48 INFO - 'MOZ_NO_REMOTE': '1', 08:00:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:48 INFO - 'NO_EM_RESTART': '1', 08:00:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:48 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:48 INFO - 'SHELL': '/bin/bash', 08:00:48 INFO - 'SHLVL': '1', 08:00:48 INFO - 'TERM': 'linux', 08:00:48 INFO - 'TMOUT': '86400', 08:00:48 INFO - 'USER': 'cltbld', 08:00:48 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202', 08:00:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:48 INFO - '_': '/tools/buildbot/bin/python'} 08:00:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:48 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)) 08:00:48 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)) 08:00:48 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)) 08:00:48 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)) 08:00:48 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)) 08:00:48 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)) 08:00:48 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)) 08:00:48 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)) 08:00:48 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)) 08:00:48 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)) 08:00:48 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)) 08:00:48 INFO - Cleaning up... 08:00:48 INFO - Return code: 0 08:00:48 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:00:48 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')]} 08:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:48 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')]} 08:00:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f1540346f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cc840>, '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 0x14396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439b60>, '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': '8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202', '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 08:00:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:00:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:00:48 INFO - Using env: {'DISPLAY': ':0', 08:00:48 INFO - 'HOME': '/home/cltbld', 08:00:48 INFO - 'LANG': 'en_US.UTF-8', 08:00:48 INFO - 'LANGUAGE': 'en_US:en', 08:00:48 INFO - 'LOGNAME': 'cltbld', 08:00:48 INFO - 'MAIL': '/var/mail/cltbld', 08:00:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:48 INFO - 'MOZ_NO_REMOTE': '1', 08:00:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:48 INFO - 'NO_EM_RESTART': '1', 08:00:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:48 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:48 INFO - 'SHELL': '/bin/bash', 08:00:48 INFO - 'SHLVL': '1', 08:00:48 INFO - 'TERM': 'linux', 08:00:48 INFO - 'TMOUT': '86400', 08:00:48 INFO - 'USER': 'cltbld', 08:00:48 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202', 08:00:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:48 INFO - '_': '/tools/buildbot/bin/python'} 08:00:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:49 INFO - Downloading/unpacking jsonschema 08:00:49 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 08:00:49 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 08:00:49 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 08:00:49 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 08:00:49 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 08:00:49 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 08:00:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:00:50 INFO - Downloading/unpacking functools32 (from jsonschema) 08:00: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 08:00: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 08:00: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 08:00: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 08:00: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 08:00: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 08:00:51 INFO - Downloading functools32-3.2.3-2.tar.gz 08:00:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:00:51 INFO - warning: no files found matching '*.txt' 08:00:51 INFO - no previously-included directories found matching 'build' 08:00:51 INFO - no previously-included directories found matching 'dist' 08:00:51 INFO - no previously-included directories found matching '.git*' 08:00:51 INFO - Installing collected packages: jsonschema, functools32 08:00:51 INFO - Running setup.py install for functools32 08:00:51 INFO - warning: no files found matching '*.txt' 08:00:51 INFO - no previously-included directories found matching 'build' 08:00:51 INFO - no previously-included directories found matching 'dist' 08:00:51 INFO - no previously-included directories found matching '.git*' 08:00:51 INFO - Successfully installed jsonschema functools32 08:00:51 INFO - Cleaning up... 08:00:51 INFO - Return code: 0 08:00:51 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f1540346f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cc840>, '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 0x14396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439b60>, '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': '8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202', '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 08:00:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 08:00:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 08:00:51 INFO - Using env: {'DISPLAY': ':0', 08:00:51 INFO - 'HOME': '/home/cltbld', 08:00:51 INFO - 'LANG': 'en_US.UTF-8', 08:00:51 INFO - 'LANGUAGE': 'en_US:en', 08:00:51 INFO - 'LOGNAME': 'cltbld', 08:00:51 INFO - 'MAIL': '/var/mail/cltbld', 08:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:51 INFO - 'MOZ_NO_REMOTE': '1', 08:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:51 INFO - 'NO_EM_RESTART': '1', 08:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:51 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:51 INFO - 'SHELL': '/bin/bash', 08:00:51 INFO - 'SHLVL': '1', 08:00:51 INFO - 'TERM': 'linux', 08:00:51 INFO - 'TMOUT': '86400', 08:00:51 INFO - 'USER': 'cltbld', 08:00:51 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202', 08:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:51 INFO - '_': '/tools/buildbot/bin/python'} 08:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:51 INFO - Downloading/unpacking flake8 08:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:00:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:00:53 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 08:00:53 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 08:00:53 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 08:00:53 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 08:00:53 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 08:00:53 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 08:00:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:00:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:00:53 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 08:00:53 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 08:00:53 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 08:00:53 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 08:00:53 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 08:00:53 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 08:00:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:00:53 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 08:00:53 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 08:00:53 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 08:00:53 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 08:00:53 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 08:00:53 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 08:00:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:00:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:00:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:00:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:00:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:00:53 INFO - no previously-included directories found matching 'docs/_build' 08:00:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:00:54 INFO - Running setup.py install for pep8 08:00:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:00:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:00:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:00:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:00:54 INFO - no previously-included directories found matching 'docs/_build' 08:00:54 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:00:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:00:54 INFO - Cleaning up... 08:00:54 INFO - Return code: 0 08:00:54 INFO - Running post-action listener: _resource_record_post_action 08:00:54 INFO - Running post-action listener: _start_resource_monitoring 08:00:54 INFO - Starting resource monitoring. 08:00:54 INFO - ##### 08:00:54 INFO - ##### Running install step. 08:00:54 INFO - ##### 08:00:54 INFO - Running pre-action listener: _resource_record_pre_action 08:00:54 INFO - Running main action method: install 08:00:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:00:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:00:54 INFO - Reading from file tmpfile_stdout 08:00:54 INFO - Detecting whether we're running mozinstall >=1.0... 08:00:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:00:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:00:54 INFO - Reading from file tmpfile_stdout 08:00:54 INFO - Output received: 08:00:54 INFO - Usage: mozinstall [options] installer 08:00:54 INFO - Options: 08:00:54 INFO - -h, --help show this help message and exit 08:00:54 INFO - -d DEST, --destination=DEST 08:00:54 INFO - Directory to install application into. [default: 08:00:54 INFO - "/builds/slave/test-pgo"] 08:00:54 INFO - --app=APP Application being installed. [default: firefox] 08:00:54 INFO - mkdir: /builds/slave/test-pgo/build/application 08:00:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 08:00:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 08:01:10 INFO - Reading from file tmpfile_stdout 08:01:10 INFO - Output received: 08:01:10 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:01:10 INFO - Running post-action listener: _resource_record_post_action 08:01:10 INFO - ##### 08:01:10 INFO - ##### Running run-tests step. 08:01:10 INFO - ##### 08:01:10 INFO - Running pre-action listener: _resource_record_pre_action 08:01:10 INFO - Running main action method: run_tests 08:01:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:01:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:01:10 INFO - Python 2.7.3 08:01:10 INFO - Return code: 0 08:01:10 INFO - grabbing minidump binary from tooltool 08:01:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:10 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 0x14cc840>, '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 0x14396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1439b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:01:10 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 08:01:10 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 08:01:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:01:10 INFO - Return code: 0 08:01:10 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:01:10 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:01:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:01:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:01:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:01:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:01:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:01:11 INFO - Return code: 0 08:01:11 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/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 08:01:11 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/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 08:01:11 INFO - Using env: {'DISPLAY': ':0', 08:01:11 INFO - 'HOME': '/home/cltbld', 08:01:11 INFO - 'LANG': 'en_US.UTF-8', 08:01:11 INFO - 'LANGUAGE': 'en_US:en', 08:01:11 INFO - 'LOGNAME': 'cltbld', 08:01:11 INFO - 'MAIL': '/var/mail/cltbld', 08:01:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:01:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:01:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:11 INFO - 'MOZ_NO_REMOTE': '1', 08:01:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:01:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:11 INFO - 'NO_EM_RESTART': '1', 08:01:11 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:01:11 INFO - 'PWD': '/builds/slave/test-pgo', 08:01:11 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:01:11 INFO - 'SHELL': '/bin/bash', 08:01:11 INFO - 'SHLVL': '1', 08:01:11 INFO - 'TERM': 'linux', 08:01:11 INFO - 'TMOUT': '86400', 08:01:11 INFO - 'USER': 'cltbld', 08:01:11 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202', 08:01:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:11 INFO - '_': '/tools/buildbot/bin/python'} 08:01:11 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/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 08:01:11 INFO - mozversion application_buildid: 20160127053017 08:01:11 INFO - mozversion application_changeset: 60c5168a485cb166abd27b8eb0b83b919ac4b166 08:01:11 INFO - mozversion application_display_name: Nightly 08:01:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:01:11 INFO - mozversion application_name: Firefox 08:01:11 INFO - mozversion application_remotingname: firefox 08:01:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:01:11 INFO - mozversion application_vendor: Mozilla 08:01:11 INFO - mozversion application_version: 47.0a1 08:01:11 INFO - mozversion platform_buildid: 20160127053017 08:01:11 INFO - mozversion platform_changeset: 60c5168a485cb166abd27b8eb0b83b919ac4b166 08:01:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:01:11 INFO - mozversion platform_version: 47.0a1 08:01:11 INFO - using testdate: 1453910471 08:01:11 INFO - actual date: 1453910471 08:01:12 INFO - starting webserver on 'localhost:53579' 08:01:12 INFO - SUITE-START | Running 3 tests 08:01:12 INFO - TEST-START | dromaeo_css 08:01:12 INFO - operating with platform_type : linux_ 08:01:12 INFO - Initialising browser for dromaeo_css test... 08:01:12 INFO - TEST-INFO | started process 19638 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMULmrU/profile http://localhost:53579/getInfo.html) 08:01:16 INFO - PROCESS | 19638 | __metrics Screen width/height:1600/1200 08:01:16 INFO - PROCESS | 19638 | colorDepth:24 08:01:16 INFO - PROCESS | 19638 | Browser inner width/height: 1024/697 08:01:16 INFO - PROCESS | 19638 | __metrics 08:01:16 INFO - PROCESS | 19638 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:01:16 INFO - PROCESS | 19638 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:01:17 INFO - TEST-INFO | 19638: exit 0 08:01:17 INFO - Browser initialized. 08:01:17 INFO - Running cycle 1/1 for dromaeo_css test... 08:01:17 INFO - TEST-INFO | started process 19728 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMULmrU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:01:29 INFO - PROCESS | 19728 | RSS: Main: 149118976 08:01:29 INFO - PROCESS | 19728 | 08:02:20 INFO - PROCESS | 19728 | 1453910540741 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] 08:04:28 INFO - PROCESS | 19728 | Cycle 1(1): loaded http://localhost:53579/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53579/tests/dromaeo/cssquery-ext.html) 08:04:29 INFO - PROCESS | 19728 | RSS: Main: 268427264 08:04:29 INFO - PROCESS | 19728 | 08:07:32 INFO - PROCESS | 19728 | Cycle 1(1): loaded http://localhost:53579/tests/dromaeo/cssquery-ext.html (next: http://localhost:53579/tests/dromaeo/cssquery-jquery.html) 08:07:33 INFO - PROCESS | 19728 | RSS: Main: 231223296 08:07:33 INFO - PROCESS | 19728 | 08:10:35 INFO - PROCESS | 19728 | Cycle 1(1): loaded http://localhost:53579/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53579/tests/dromaeo/cssquery-mootools.html) 08:10:35 INFO - PROCESS | 19728 | RSS: Main: 225161216 08:10:35 INFO - PROCESS | 19728 | 08:13:37 INFO - PROCESS | 19728 | Cycle 1(1): loaded http://localhost:53579/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53579/tests/dromaeo/cssquery-prototype.html) 08:13:38 INFO - PROCESS | 19728 | RSS: Main: 211390464 08:13:38 INFO - PROCESS | 19728 | 08:16:40 INFO - PROCESS | 19728 | Cycle 1(1): loaded http://localhost:53579/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53579/tests/dromaeo/cssquery-yui.html) 08:16:41 INFO - PROCESS | 19728 | RSS: Main: 214327296 08:16:41 INFO - PROCESS | 19728 | 08:19:44 INFO - PROCESS | 19728 | Cycle 1(1): loaded http://localhost:53579/tests/dromaeo/cssquery-yui.html (next: http://localhost:53579/tests/dromaeo/cssquery-dojo.html) 08:19:44 INFO - PROCESS | 19728 | RSS: Main: 274059264 08:19:44 INFO - PROCESS | 19728 | 08:19:44 INFO - PROCESS | 19728 | __start_tp_report 08:19:44 INFO - PROCESS | 19728 | _x_x_mozilla_page_load 08:19:44 INFO - PROCESS | 19728 | _x_x_mozilla_page_load_details 08:19:44 INFO - PROCESS | 19728 | |i|pagename|runs| 08:19:44 INFO - PROCESS | 19728 | |0;dojo.html;3097.3650401667655;3128.890488832891;3175.5236714492808;3175.90431301201;3209.8234597097157;5061.24081387792;5098.980203959209;5144.125498665227;5158.871028224287;5165.173572228439;5004.099262132815;5031.42138654054;5082.872928176797;5088.1095808233595;5121.795128194877;4586.908261834761;4598.701084429518;4602.631789456844;4628.583427491525;4659.603933665642;4686.343911852344;4703.976480117612;4751.619870410359;4758.428988521382;4775.235962246042;4631.976840115812;4675.929861052087;4691.741954192518;4693.976530117362;4695.389599352063;4595.678302518825;4629.583337499607;4649.04694537619;4649.418822647169;4656.511066338054;4535.852920272168;4548.636109111296;4560.521145279764;4567.474740404829;4588.082383523275;4806.495317991596;4845.176320025604;4848.22428411456;4854.538818812207;4864.173090574611;5417.322834645669;5451.400345961941;5525.972370138164;5526.364468086182;5546.77812887484;5524.447555244484;5529.502344788988;5542.61201715876;5545.057340252127;5547.916781248285;5014.648974571782;5106.106431374495;5141.15170996785;5147.536721695065;5150;5617.185508101385;5629.408912064175;5653.293338332708;5657.20799088128;5674.574406919498;5285.735713214324;5300.416954135042;5301.708406037705;5306.628536002443;5307.124324486416;5409.55969853236;5412.404635490093;5443.836684899459;5489.094299440548;5530.944690553043;5329.094054010828;5345.438728933484;5350.678959262456;5352.277442545206;5402.459754024645;5293.655912365684;5338.91991620126;5339.199120131933;5354.892902141935;5389.487998640123;4221.451211342506;4222.451081359465;4259.488861336659;4303.569643035671;4377.496587892433;3827.5215598050245;3840.116773142193;3845.192509573021;3856.5564960029956;3879.9718074710227;5141.511556402136;5142.357205349332;5144.7942082316285;5145.176771716508;5158.509941555546;5388.326459192601;5410.91883621746;5462;5481;5524.281843360337;5129.051125541787;5133.794648214104;5135.306733590917;5137.640365174402;5146.845594632167;4735.739534325577;4744.644151688637;4745.430548334153;4768.332433459318;4793.304970779218;5545.057340252167;5549.639273447213;5564.165375193753;5619.662820230717;5634;5407.891842163213;5443.863903402288;5449.34607847045;5454.781808727766;5469.3983661797965;5539.778408863762;5618.578606604439;5628.971855140698;5650.519705825051;5673.177389278614;5233.110371236823;5431.8098866539485;5463.31708536433;5470.343558772973;5508;5445.809396671098;5451.155070963849;5463.399026107205;5467.343918729778;5470.370907345706;5193;5318.388385335736;5349.7860085597695;5360.303160589098;5403.297571315704;5357.089294819968;5362.463753624606;5368.087425137814;5383.434739352469;5418.322709661293;5322.41453440129;5325.893482130413;5326.493983071602;5333.759980800795;5375.032494151091;5238.68567885928;5265.420803711512;5314.707691077027;5428.67427954324;5442.047641662614;5254.42201357858;5283.339582552181;5284.947150528599;5289.550388217045;5296.655717378358 08:19:44 INFO - PROCESS | 19728 | |1;ext.html;527.1749711701185;550.9999351177615;577.4081566394445;594.997025014875;600.1388008208221;27980.440391192165;35831.641683583155;36300.273994520096;36375.818120909425;36393.63606363936;39276.80361598188;39800.60199398005;39847.40228896569;39865;39916.20167596646;8411;8617.267532259733;8618;8618.353623478233;8620.870686939701;8363.790905227388;8457.70398036069;8484.32125429964;8484.66061357545;8702.564871756418;8433.915660843375;8503.404761666687;8503.532305723184;8508.914910850874;8511.787205319886;8583.699570515033;8589.914100858974;8623.913760862406;8658.783530411727;8661.696840610548;8457.66169353225;8604.182602652738;8604.784880377978;8607.18231767981;8607.48355098696;39427;39987.000324991815;40028.19943601112;40031.39952900709;40043.59956400428;3056.724894759482;3276.4921437177277;3378.8648454062054;3491.4064609016527;3828.846846126152;29387.265318366997;29849.850750746326;30112.54831177534;30214.58283337328;30823.229419264473;3722.8510859565586;3725.3480640887738;3751.9437208441896;3755.8497660093562;3842.865499707497;268299;268694;270987;271172.64413678;272671;50339;50671.999999999265;56125.15812262819;56423.79338272787;56566.151507727416;50245;50353;50588;50607.24089138666;50711.98576028532;13451.529196478272;13605.591832245049;13623.86376136226;13643.590692279247;13671.794923076162;9837.835676151235;10075.798484030278;10086.293959422917;10093.142082922886;10976.067034302014;18472.81527184738;18849.434516964513;18861.830889447614;18969.81030189708;19053.237870485304;6976.825579360455;7080.92919070813;7083.079199704005;7133.468932878155;7237.89143162853;890.4034297021011;952.7141857442739;963.8072385522923;1011.7824667696333;1021.0861279155115;24575.01699931983;24982.50034999326;25050.624240636404;25068.24795256145;25232.116875909254;968.331851022792;996.930214884951;1017.3692310767224;1057.9788404231872;1129.8757136714955;13162.14446061003;13324;14561.854381456262;15468.527001806424;15835.208239587975;310764;312823;313475;314940;315435;50950;51103.23345149826;51189.74405128025;51232;51233;1325.4565628092628;1333.986170510419;1353.9526116585873;1354.4108312883927;1370.294298436306;27324.316892077855;28248.152555422548;28269;28300.43399132047;29159.85420072886;41969.79015105027;42290.788546057076;42332.57667423286;42369.576304237795;42445.57554424416;193394;194576;194666;194953;195110;27932.720672793013;28669.28326791847;29464.410711786073;31509.527357089202;31699.20751981219;36450.8177459111;36565.81717091504;36624;37079;37419;31661.525077123402;32028.5195722069;32050.35899282048;32287;32596;25692.614610781227;32366.19084522906;33832.66167338295;34494;34705.30589388148;32168.35663286768;32309;32315.35369292648;34967.475487867196;35037.82481087578;29984.400311994075;31258.531122033644;31760.36479270448;31769.523457147698;31821.681783181873;23949.187557109453;24294.63558046666;24602.261932142064;24649.753502464744;24650.414552654376 08:19:44 INFO - PROCESS | 19728 | |2;jquery.html;354.98225088745556;358.4354641439733;358.5894151196879;358.91206654369677;360.5061066339116;14310.427582896671;14596.927015364909;15539.766903496442;16630.584235394123;18058.367957121485;15861.920690396531;16508.25712842922;17079.316827326893;17136.742948855775;17141.485755427326;5194.55846253068;5346.198070289468;5395.325584301962;5401.729913504329;5409.188621706736;3971.0866500704856;4133.937990930139;5275.261463395128;5362.4637536246455;5656.91514627281;5713.857153571153;5724.656520608777;5802.564807639423;5806.8966896289785;5810.302763668345;5129.410117836459;5292.841214763564;5304.840854774363;5323.307969963918;5331.546818520431;5005.524475174852;5091.61812864033;5192.766325515361;5196.32447781786;5200.479952004807;19366.128524216445;19498.610027799506;19571.90214048935;19843.71015883963;20022;1930.1314408516084;1986.2750096214777;2020.565578400651;2127.563849410867;2278.646809744476;9314.72055838326;9614.663486778;9753.707388778277;10999.285046471954;12772.233665980071;1632.4776071657075;1756.9385071522436;1775.1834156288123;1793.6861049316317;1828.4057681253646;55245.44754552443;55768.16347754787;56245;56709.716451417895;57309.71345143289;9587.424754514752;10017.599296028224;10047.497625118862;10081.344712593806;10158.187345012382;13024.869751302555;13040.347982600832;13094.279814610289;13114.278714670785;13144.0799144059;7326.67029983652;7386.525513952779;7391.519551229153;7521.210272921374;7570.280823321776;7022.297770222936;7056.400205982446;7095.148582170173;7107.8933815992805;7112.679929403189;4329.415528903558;4387.078713470143;4405.449318835145;4416.6025057744955;4428.3800267962515;1694.7203711387483;1725.5341057914293;1780.2967827707982;1795.1921635264184;1850.111946265773;898.6077557221411;906.1572737354323;926.2127191886977;927.5825878354632;984.625842179967;13758.449662013607;15313.693726125415;15459.61350966235;15466.9226653866;15853.128077955824;883.6597909804772;888.657866721304;906.419891269588;917.2478567574525;950.9381890177116;8865.68970086044;9052.41159324655;9058.864117038249;9151.862722059175;9211.677591284408;500789;509355;509620;522167;534032;45105.32342014872;54485.1827222592;56810;71856;76589;1008.606643409071;1047.5487359578622;1127.8928501792316;1173.9413029348668;1175.753091850721;13565.525206617722;14119.364628591533;14187.361568729226;14445.92777036108;14653.853461465675;31815.363692725554;32520.512192316663;32805.67194328122;33540.83229583934;33788;43570.34644480272;44237;45653.54346456626;46737;47805.52194478011;7245.420366370783;7389.224131466119;7402.259774022555;7420.5176663516695;7526.962365188139;10366.185917464263;11315.660530184108;11652.533898644298;11733.237339572901;11797.584289885268;9899.604015839574;9915.603375864885;10138.949305253427;10142.847857282295;10169.389836609827;9986.950065249628;9999;10008.899911001088;10351.896481035094;10481.423521706074;10058.899411005796;10081.89918100839;10125;10332;10408.427536485264;7265;7389.261073892568;7421.3691836192365;7463.626818658937;7475.028246327943;9223.815523689624;9602.423854568748;9629.759256018375;9633.518324083627;9647.228221742384 08:19:44 INFO - PROCESS | 19728 | |3;mootools.html;1343.7312537492503;1495.895287329887;1505.22480922325;1668.4827703411943;1803.981960180398;6990.930090699091;7345.118585769708;7474.962625186873;7479.813004674886;7486.026816513846;7564.508306960044;7741.148473667892;7774.41691873109;7775.688972441096;7778.766637000885;2031.3702752146883;2085.8748475091465;2244.1696572268243;2247.820174386053;2277.81777457803;2294.139697613395;2306.054517647765;2306.331163962449;2309.08791027544;2321.9767802322012;2212.1040978403694;2262.4117729390396;2272.8977196026217;2273.386185729852;2280.2931091361647;2167.8916054197384;2174.1303478608525;2180.008096316172;2185.2460900989136;2190.759016508183;2198.5932602468592;2205.151016858505;2209.779022097777;2216.4126506475795;2305.1586171047447;7777.222277772177;7854.1360450350985;7864.449488535804;7869.881951770728;7883.0934442539265;4691.976540117312;4807.591354734852;4841.2496063110275;4844.2975768513725;4850.6362022848425;2963.496205645024;2991.222282206642;3031.1361262040214;3034.499307614241;3133.482975309071;917.3624331089895;933.1182032978837;954.2985905359556;961.0437614573544;980.8626792249091;10711.143108551298;10738.355698658106;10780.245382823205;10794.352338859615;10827.458627068616;4168.416421700964;4229.048464095554;4283.164782867311;4302.870913872589;4332.306830907103;8755.474671519729;8835.734927952171;8868.8669669955;8898.199162075314;8910.509921954224;4808.807647694053;4811.639127065484;4817.1810792164715;4818.638602104857;4819.638527110411;4402.581754733295;4435.82256709728;4441;4442.5557444255965;4450.132224216247;3270.9018729438153;3405.7275417966503;3497.632748561415;3514.262004978932;3561.9109522261633;1067.4182570499097;1068.417712346773;1080.708208783624;1085.3108276244484;1093.1528065749108;1295.112847699329;1295.7214198947272;1317.571789168524;1317.6244770240435;1320.214472388927;6987.406070483964;7104.573725576379;7123.82190445243;7133.750318738819;7148.785536433916;1088.080571916729;1088.802665723624;1091.9945400272948;1095.238809027734;1137.9943100284445;5567.610267281251;5722.799702010409;5724.542036637059;5733.512651424592;5747.137929310553;9151.725448236564;9409.90590094104;9576.76058098553;9720.659776907774;9742.95128524353;9454.621815127319;9599.280053995979;9629.374090684083;9631.759206019906;9640.228781697448;7310.195878453366;7397.889031664529;7413.4810563261135;7421.2949769771785;7458.70165193397;7073.5402198858965;7102.218755936739;7175.748848790267;7190.388816950618;7193.4604904631315;8189.344852411912;8464.068952415106;8492.915070849212;8513.106123856905;8668.046514883232;8633.438826476258;8829.11708829112;8843.55782210874;8845.601947912488;8895.911040889509;5840.2115714379715;6592.571482853599;6806.18325800907;6810.82972925661;6817.147856517935;6712.664366781739;7191.352778249982;7386.0767404074495;7392.186859445565;7393.852122957618;6827.180738311435;7008.544444611084;7009.684564194726;7081.114860642419;7155.892661610184;6858.862822743417;6866.690998905161;6880;6968.756093536702;6993.335633114846;6811.69347379379;6957.408620267334;7001.684924178322;7017.052697885924;7023.508354415142;6389.073584330153;6433;6436.131122298617;6451.225852897683;6456.418922297016;6100.23747031621;6119.908201376894;6135.294441139326;6146.354632763496;6150.723217455135 08:19:44 INFO - PROCESS | 19728 | |4;prototype.html;334.81752444917515;337.6151187646082;341.38550608903967;345.6422602606302;346.3194822174425;5756.827295181151;5841.240638716966;5842.386549412315;5893.351731309553;5933.288005439354;5639.802606908759;5800.100984347422;5826.184334193205;5843.2695913010875;5856.385079566648;4544.068465964469;4559.566841150086;4561.680682352228;4567.862964111082;4573.634109271267;4351.65186785058;4406.294992801152;4474.284114541674;4509.278515437531;4551.749653769041;4444.666650001247;4468.97765511172;4475.955240447586;4477.082198149388;4525.230710779159;4497.640188784906;4503.369528266046;4510.097980403916;4518.457785065813;4529.320601909707;3997.6402123809;4001.4397984282223;4002.0595160137345;4007.9599204007877;4009.919801603981;5452.563794896439;5580.86047848803;5600.243967064435;5610.074337734269;5613.831585052455;5142.51146141116;5148.768305426227;5149.819756308511;5151.922721159186;5156.845294641167;5911.527077833763;6153.661548614825;6214;6223.284322302902;6224;4236.2586547354085;4251.192273468031;4318.805653745589;4346.1090476452255;4350.456192975878;6430.1319321891415;6484.481241500669;6492.285848556655;6499.54503184782;6516.185476815398;4459.063596644741;4462.884278930267;4465.37484752135;4465.419495465569;4468.151051300242;4441.178381999341;4480.417545719036;4513.1650644630845;4517.073999830027;4537.069900670354;5201.401838788512;5202.53177214045;5211.270422140903;5211.71335576547;5213.869653258699;6269.7178626961895;6286.748530058747;6332.33510481402;6340.4293613575;6348.873022539523;1575.8109026916613;1598.824129345771;1598.9520314390354;1599.5921040134924;1599.720048991445;1066.871975362946;1066.981033113375;1074.693712291993;1076.612419528969;1098.5001824169983;5930.28836539618;5931.258592675916;5931.6441013539325;5932.050871860568;5943.791967281124;6430.903536446864;6433.678316084177;6440.452561532322;6442.194725659293;6443.7744678936015;5862.091375836752;5896.410358964069;5923.911141332884;5924.081767325985;5932.822015339547;3358.059743271888;3460.7058400035776;3473.4442489201606;3475.5134281200653;3476.5132881396626;6697.966510167418;6699.5310328276555;6703.296153903867;6704.96647516769;6767.323267673193;6570.408663220333;6587.50593705474;6589.571677841021;6591.571547849375;6593.604383736991;6511.576747511492;6681.2984636612455;6683.198016237985;6695.665216739241;6703.195616526048;6237.937620623736;6370.140031095928;6414.422701956846;6420.582662126947;6422.3577642235405;6230.719617617308;6305.842353941188;6400.583962042452;6410.102585637921;6435.839104022437;6699.162604674416;6704.128463299739;6719.059331693469;6719.899201512079;6731.158605174353;4341.565843415633;4428.756418397019;4469.396631454712;4471.686981911235;4473.888152796076;6369.0764839099;6420.1974753155855;6425.164728585254;6428.035794630843;6429.32492088324;6269.059641053878;6274.058891166362;6276.74893004293;6284.151639528788;6287.842803929939;6104.4200800923845;6245.812625621239;6249.312575616587;6250.3749625037135;6260.718267677874;6193.597416167935;6203;6207;6209.130721699056;6213.5339849512375;6347;6351.841203969938;6351.96824015877;6353.841153971188;6355.396237357444;6118.816435506942;6200.503959683305;6200.7519699211525;6212.29161980459;6241.282252541016 08:19:44 INFO - PROCESS | 19728 | |5;yui.html;724.4638967164293;726.4987158860388;749.2919191364159;782.1279273609927;813.9226773456521;13090;13227.801582976263;13230.603081907546;13295.268760218196;13299.468021279137;11123.054540364059;11123.833142502848;11137.832932505999;11153.275037122601;11154;650.5088658063156;659.838339606797;791.7387262203473;798.3812545277399;798.8162722573811;790.7430085222297;812.4515951732586;814.5845618734429;814.96740130395;815.0667485728837;835.8662613981764;840.2983508770154;844.8183640517287;845.18439705684;845.8519759042174;678.7488629207176;691.4157536881327;826.3884725303293;829.6805729794013;832.4048305461594;620.872721092175;624.0857144283647;625.2653132569259;629.0312918106112;629.6694235526339;12805.743885122338;12816;12827.551035713705;12849.293288869108;12902.290374029519;11589.884101159048;12474.81287780684;12508.874911250861;12601.74796504074;12934.54729084487;9229.21551668109;9447.480388578626;9518.190953768937;9609.759756006086;9719.56261968213;3482.982585087084;3486.721062315034;3510.592131844219;3541.8229088545468;3580.6777390034763;44683.55316446826;44776.55223447757;44788.05785103314;44876.32685509687;45267.54732452666;9445.480498572508;9582;9786.41281523111;9873.703788886345;9889.505524723734;17599.20803563843;18101.366452174112;18105.63788724218;18115.36596219126;18121.90939045296;7195.424366050704;7251.23861994483;7681.731139410093;7779.4554381192775;7828.960855195687;4051.4125451809323;4169.812358443816;4248.575142485788;4301.91396172081;4377.146456441027;3077.553754705555;3127.0462508934993;3133.2166958260436;3133.5769671094567;3152.763542734304;558.7988324203284;561.7865211219711;566.396787421395;566.9914951275734;572.6792995922297;504.72744717851947;557.6737608499074;607.9968052713059;662.2648859765657;679.7281087565013;7905.209479052049;8035.919640803634;8149.185081491803;8231.34149268057;8552.273056790242;622.1414448061646;649.0491430054992;650.8795872763459;653.2259272761793;658.4699317049821;3827.13889374894;3883.980580097081;3886.514185726784;4025.7383270087353;4307.763073031013;45375.54624453779;45382;45635;52604.73952604785;53392.73303633457;47099.52900470951;48310.75844620755;48317.75841120772;48755.75622121867;49004.509954900706;42470.57529424728;43061.56938430575;43201.78399107984;43301.783491082344;43512.347314790306;8150.633221505165;8283.792905177419;8420.915790842013;8476.957615211884;8520.659173632985;33384.82535207047;33438.83280583582;34010.31979360448;34040.82979585086;34049.82975085109;39505.209895801345;39532.20935581215;40277.79861100676;43842.780786097144;43889.78055109704;11123.27698699582;11267.492962816528;11757.412129393668;11834.408279586158;11943.522259109539;11106.944465277622;11884.46519906589;12166.57416990401;12386.256824590553;12417.44121514516;10236.590536378759;10772.192085593768;10867.402292873969;11096;11428.714282143013;10606;10882.61910833117;11021;11067.612633557786;11526.752699030372;8471.872921906053;10261.333013354108;10668.359898406121;10822.350658960488;11523.193376463567;9180.862287065833;9491.715248542554;9526.571304291185;9656.37233579815;9695.224382049279;9110.908890911007;9734.853977190489;9781.755456113655;9908.702738917844;10072.904555411707 08:19:44 INFO - PROCESS | 19728 | __end_tp_report 08:19:44 INFO - PROCESS | 19728 | __start_cc_report 08:19:44 INFO - PROCESS | 19728 | _x_x_mozilla_cycle_collect,965 08:19:44 INFO - PROCESS | 19728 | __end_cc_report 08:19:44 INFO - PROCESS | 19728 | __startTimestamp1453911584572__endTimestamp 08:19:44 INFO - PROCESS | 19728 | 08:19:44 INFO - PROCESS | 19728 | ------- Summary: start ------- 08:19:44 INFO - PROCESS | 19728 | Number of tests: 6 08:19:44 INFO - PROCESS | 19728 | 08:19:44 INFO - PROCESS | 19728 | [#0] dojo.html Cycles:165 Average:5074.96 Median:5285.74 stddev:537.57 (10.2%) stddev-sans-first:516.35 08:19:44 INFO - PROCESS | 19728 | Values: 3097.4 3128.9 3175.5 3175.9 3209.8 5061.2 5099.0 5144.1 5158.9 5165.2 5004.1 5031.4 5082.9 5088.1 5121.8 4586.9 4598.7 4602.6 4628.6 4659.6 4686.3 4704.0 4751.6 4758.4 4775.2 4632.0 4675.9 4691.7 4694.0 4695.4 4595.7 4629.6 4649.0 4649.4 4656.5 4535.9 4548.6 4560.5 4567.5 4588.1 4806.5 4845.2 4848.2 4854.5 4864.2 5417.3 5451.4 5526.0 5526.4 5546.8 5524.4 5529.5 5542.6 5545.1 5547.9 5014.6 5106.1 5141.2 5147.5 5150.0 5617.2 5629.4 5653.3 5657.2 5674.6 5285.7 5300.4 5301.7 5306.6 5307.1 5409.6 5412.4 5443.8 5489.1 5530.9 5329.1 5345.4 5350.7 5352.3 5402.5 5293.7 5338.9 5339.2 5354.9 5389.5 4221.5 4222.5 4259.5 4303.6 4377.5 3827.5 3840.1 3845.2 3856.6 3880.0 5141.5 5142.4 5144.8 5145.2 5158.5 5388.3 5410.9 5462.0 5481.0 5524.3 5129.1 5133.8 5135.3 5137.6 5146.8 4735.7 4744.6 4745.4 4768.3 4793.3 5545.1 5549.6 5564.2 5619.7 5634.0 5407.9 5443.9 5449.3 5454.8 5469.4 5539.8 5618.6 5629.0 5650.5 5673.2 5233.1 5431.8 5463.3 5470.3 5508.0 5445.8 5451.2 5463.4 5467.3 5470.4 5193.0 5318.4 5349.8 5360.3 5403.3 5357.1 5362.5 5368.1 5383.4 5418.3 5322.4 5325.9 5326.5 5333.8 5375.0 5238.7 5265.4 5314.7 5428.7 5442.0 5254.4 5283.3 5284.9 5289.6 5296.7 08:19:44 INFO - PROCESS | 19728 | 08:19:44 INFO - PROCESS | 19728 | [#1] ext.html Cycles:180 Average:42002.68 Median:19098.36 stddev:69036.33 (361.5%) stddev-sans-first:69159.75 08:19:44 INFO - PROCESS | 19728 | Values: 527.2 551.0 577.4 595.0 600.1 27980.4 35831.6 36300.3 36375.8 36393.6 39276.8 39800.6 39847.4 39865.0 39916.2 8411.0 8617.3 8618.0 8618.4 8620.9 8363.8 8457.7 8484.3 8484.7 8702.6 8433.9 8503.4 8503.5 8508.9 8511.8 8583.7 8589.9 8623.9 8658.8 8661.7 8457.7 8604.2 8604.8 8607.2 8607.5 39427.0 39987.0 40028.2 40031.4 40043.6 3056.7 3276.5 3378.9 3491.4 3828.8 29387.3 29849.9 30112.5 30214.6 30823.2 3722.9 3725.3 3751.9 3755.8 3842.9 268299.0 268694.0 270987.0 271172.6 272671.0 50339.0 50672.0 56125.2 56423.8 56566.2 50245.0 50353.0 50588.0 50607.2 50712.0 13451.5 13605.6 13623.9 13643.6 13671.8 9837.8 10075.8 10086.3 10093.1 10976.1 18472.8 18849.4 18861.8 18969.8 19053.2 6976.8 7080.9 7083.1 7133.5 7237.9 890.4 952.7 963.8 1011.8 1021.1 24575.0 24982.5 25050.6 25068.2 25232.1 968.3 996.9 1017.4 1058.0 1129.9 13162.1 13324.0 14561.9 15468.5 15835.2 310764.0 312823.0 313475.0 314940.0 315435.0 50950.0 51103.2 51189.7 51232.0 51233.0 1325.5 1334.0 1354.0 1354.4 1370.3 27324.3 28248.2 28269.0 28300.4 29159.9 41969.8 42290.8 42332.6 42369.6 42445.6 193394.0 194576.0 194666.0 194953.0 195110.0 27932.7 28669.3 29464.4 31509.5 31699.2 36450.8 36565.8 36624.0 37079.0 37419.0 31661.5 32028.5 32050.4 32287.0 32596.0 25692.6 32366.2 33832.7 34494.0 34705.3 32168.4 32309.0 32315.4 34967.5 35037.8 29984.4 31258.5 31760.4 31769.5 31821.7 23949.2 24294.6 24602.3 24649.8 24650.4 08:19:44 INFO - PROCESS | 19728 | 08:19:44 INFO - PROCESS | 19728 | [#2] jquery.html Cycles:180 Average:26541.55 Median:24766.85 stddev:84084.65 (339.5%) stddev-sans-first:84297.54 08:19:44 INFO - PROCESS | 19728 | Values: 355.0 358.4 358.6 358.9 360.5 14310.4 14596.9 15539.8 16630.6 18058.4 15861.9 16508.3 17079.3 17136.7 17141.5 5194.6 5346.2 5395.3 5401.7 5409.2 3971.1 4133.9 5275.3 5362.5 5656.9 5713.9 5724.7 5802.6 5806.9 5810.3 5129.4 5292.8 5304.8 5323.3 5331.5 5005.5 5091.6 5192.8 5196.3 5200.5 19366.1 19498.6 19571.9 19843.7 20022.0 1930.1 1986.3 2020.6 2127.6 2278.6 9314.7 9614.7 9753.7 10999.3 12772.2 1632.5 1756.9 1775.2 1793.7 1828.4 55245.4 55768.2 56245.0 56709.7 57309.7 9587.4 10017.6 10047.5 10081.3 10158.2 13024.9 13040.3 13094.3 13114.3 13144.1 7326.7 7386.5 7391.5 7521.2 7570.3 7022.3 7056.4 7095.1 7107.9 7112.7 4329.4 4387.1 4405.4 4416.6 4428.4 1694.7 1725.5 1780.3 1795.2 1850.1 898.6 906.2 926.2 927.6 984.6 13758.4 15313.7 15459.6 15466.9 15853.1 883.7 888.7 906.4 917.2 950.9 8865.7 9052.4 9058.9 9151.9 9211.7 500789.0 509355.0 509620.0 522167.0 534032.0 45105.3 54485.2 56810.0 71856.0 76589.0 1008.6 1047.5 1127.9 1173.9 1175.8 13565.5 14119.4 14187.4 14445.9 14653.9 31815.4 32520.5 32805.7 33540.8 33788.0 43570.3 44237.0 45653.5 46737.0 47805.5 7245.4 7389.2 7402.3 7420.5 7527.0 10366.2 11315.7 11652.5 11733.2 11797.6 9899.6 9915.6 10138.9 10142.8 10169.4 9987.0 9999.0 10008.9 10351.9 10481.4 10058.9 10081.9 10125.0 10332.0 10408.4 7265.0 7389.3 7421.4 7463.6 7475.0 9223.8 9602.4 9629.8 9633.5 9647.2 08:19:44 INFO - PROCESS | 19728 | 08:19:44 INFO - PROCESS | 19728 | [#3] mootools.html Cycles:180 Average:5430.20 Median:6269.90 stddev:2829.55 (45.1%) stddev-sans-first:2820.81 08:19:44 INFO - PROCESS | 19728 | Values: 1343.7 1495.9 1505.2 1668.5 1804.0 6990.9 7345.1 7475.0 7479.8 7486.0 7564.5 7741.1 7774.4 7775.7 7778.8 2031.4 2085.9 2244.2 2247.8 2277.8 2294.1 2306.1 2306.3 2309.1 2322.0 2212.1 2262.4 2272.9 2273.4 2280.3 2167.9 2174.1 2180.0 2185.2 2190.8 2198.6 2205.2 2209.8 2216.4 2305.2 7777.2 7854.1 7864.4 7869.9 7883.1 4692.0 4807.6 4841.2 4844.3 4850.6 2963.5 2991.2 3031.1 3034.5 3133.5 917.4 933.1 954.3 961.0 980.9 10711.1 10738.4 10780.2 10794.4 10827.5 4168.4 4229.0 4283.2 4302.9 4332.3 8755.5 8835.7 8868.9 8898.2 8910.5 4808.8 4811.6 4817.2 4818.6 4819.6 4402.6 4435.8 4441.0 4442.6 4450.1 3270.9 3405.7 3497.6 3514.3 3561.9 1067.4 1068.4 1080.7 1085.3 1093.2 1295.1 1295.7 1317.6 1317.6 1320.2 6987.4 7104.6 7123.8 7133.8 7148.8 1088.1 1088.8 1092.0 1095.2 1138.0 5567.6 5722.8 5724.5 5733.5 5747.1 9151.7 9409.9 9576.8 9720.7 9743.0 9454.6 9599.3 9629.4 9631.8 9640.2 7310.2 7397.9 7413.5 7421.3 7458.7 7073.5 7102.2 7175.7 7190.4 7193.5 8189.3 8464.1 8492.9 8513.1 8668.0 8633.4 8829.1 8843.6 8845.6 8895.9 5840.2 6592.6 6806.2 6810.8 6817.1 6712.7 7191.4 7386.1 7392.2 7393.9 6827.2 7008.5 7009.7 7081.1 7155.9 6858.9 6866.7 6880.0 6968.8 6993.3 6811.7 6957.4 7001.7 7017.1 7023.5 6389.1 6433.0 6436.1 6451.2 6456.4 6100.2 6119.9 6135.3 6146.4 6150.7 08:19:44 INFO - PROCESS | 19728 | 08:19:44 INFO - PROCESS | 19728 | [#4] prototype.html Cycles:180 Average:5223.44 Median:5903.97 stddev:1569.28 (26.6%) stddev-sans-first:1530.19 08:19:44 INFO - PROCESS | 19728 | Values: 334.8 337.6 341.4 345.6 346.3 5756.8 5841.2 5842.4 5893.4 5933.3 5639.8 5800.1 5826.2 5843.3 5856.4 4544.1 4559.6 4561.7 4567.9 4573.6 4351.7 4406.3 4474.3 4509.3 4551.7 4444.7 4469.0 4476.0 4477.1 4525.2 4497.6 4503.4 4510.1 4518.5 4529.3 3997.6 4001.4 4002.1 4008.0 4009.9 5452.6 5580.9 5600.2 5610.1 5613.8 5142.5 5148.8 5149.8 5151.9 5156.8 5911.5 6153.7 6214.0 6223.3 6224.0 4236.3 4251.2 4318.8 4346.1 4350.5 6430.1 6484.5 6492.3 6499.5 6516.2 4459.1 4462.9 4465.4 4465.4 4468.2 4441.2 4480.4 4513.2 4517.1 4537.1 5201.4 5202.5 5211.3 5211.7 5213.9 6269.7 6286.7 6332.3 6340.4 6348.9 1575.8 1598.8 1599.0 1599.6 1599.7 1066.9 1067.0 1074.7 1076.6 1098.5 5930.3 5931.3 5931.6 5932.1 5943.8 6430.9 6433.7 6440.5 6442.2 6443.8 5862.1 5896.4 5923.9 5924.1 5932.8 3358.1 3460.7 3473.4 3475.5 3476.5 6698.0 6699.5 6703.3 6705.0 6767.3 6570.4 6587.5 6589.6 6591.6 6593.6 6511.6 6681.3 6683.2 6695.7 6703.2 6237.9 6370.1 6414.4 6420.6 6422.4 6230.7 6305.8 6400.6 6410.1 6435.8 6699.2 6704.1 6719.1 6719.9 6731.2 4341.6 4428.8 4469.4 4471.7 4473.9 6369.1 6420.2 6425.2 6428.0 6429.3 6269.1 6274.1 6276.7 6284.2 6287.8 6104.4 6245.8 6249.3 6250.4 6260.7 6193.6 6203.0 6207.0 6209.1 6213.5 6347.0 6351.8 6352.0 6353.8 6355.4 6118.8 6200.5 6200.8 6212.3 6241.3 08:19:44 INFO - PROCESS | 19728 | 08:19:44 INFO - PROCESS | 19728 | [#5] yui.html Cycles:180 Average:12977.60 Median:45378.77 stddev:14532.53 (32.0%) stddev-sans-first:14544.17 08:19:44 INFO - PROCESS | 19728 | Values: 724.5 726.5 749.3 782.1 813.9 13090.0 13227.8 13230.6 13295.3 13299.5 11123.1 11123.8 11137.8 11153.3 11154.0 650.5 659.8 791.7 798.4 798.8 790.7 812.5 814.6 815.0 815.1 835.9 840.3 844.8 845.2 845.9 678.7 691.4 826.4 829.7 832.4 620.9 624.1 625.3 629.0 629.7 12805.7 12816.0 12827.6 12849.3 12902.3 11589.9 12474.8 12508.9 12601.7 12934.5 9229.2 9447.5 9518.2 9609.8 9719.6 3483.0 3486.7 3510.6 3541.8 3580.7 44683.6 44776.6 44788.1 44876.3 45267.5 9445.5 9582.0 9786.4 9873.7 9889.5 17599.2 18101.4 18105.6 18115.4 18121.9 7195.4 7251.2 7681.7 7779.5 7829.0 4051.4 4169.8 4248.6 4301.9 4377.1 3077.6 3127.0 3133.2 3133.6 3152.8 558.8 561.8 566.4 567.0 572.7 504.7 557.7 608.0 662.3 679.7 7905.2 8035.9 8149.2 8231.3 8552.3 622.1 649.0 650.9 653.2 658.5 3827.1 3884.0 3886.5 4025.7 4307.8 45375.5 45382.0 45635.0 52604.7 53392.7 47099.5 48310.8 48317.8 48755.8 49004.5 42470.6 43061.6 43201.8 43301.8 43512.3 8150.6 8283.8 8420.9 8477.0 8520.7 33384.8 33438.8 34010.3 34040.8 34049.8 39505.2 39532.2 40277.8 43842.8 43889.8 11123.3 11267.5 11757.4 11834.4 11943.5 11106.9 11884.5 12166.6 12386.3 12417.4 10236.6 10772.2 10867.4 11096.0 11428.7 10606.0 10882.6 11021.0 11067.6 11526.8 8471.9 10261.3 10668.4 10822.4 11523.2 9180.9 9491.7 9526.6 9656.4 9695.2 9110.9 9734.9 9781.8 9908.7 10072.9 08:19:44 INFO - PROCESS | 19728 | -------- Summary: end -------- 08:19:44 INFO - PROCESS | 19728 | 08:19:45 INFO - TEST-INFO | 19728: exit 0 08:19:45 INFO - TEST-OK | dromaeo_css | took 1113313ms 08:19:45 INFO - TEST-START | kraken 08:19:45 INFO - operating with platform_type : linux_ 08:19:45 INFO - Initialising browser for kraken test... 08:19:45 INFO - TEST-INFO | started process 19929 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIKZZyT/profile http://localhost:53579/getInfo.html) 08:19:49 INFO - PROCESS | 19929 | __metrics Screen width/height:1600/1200 08:19:49 INFO - PROCESS | 19929 | colorDepth:24 08:19:49 INFO - PROCESS | 19929 | Browser inner width/height: 1024/697 08:19:49 INFO - PROCESS | 19929 | __metrics 08:19:49 INFO - PROCESS | 19929 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:19:49 INFO - PROCESS | 19929 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:19:50 INFO - TEST-INFO | 19929: exit 0 08:19:50 INFO - Browser initialized. 08:19:50 INFO - Running cycle 1/1 for kraken test... 08:19:50 INFO - TEST-INFO | started process 20013 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIKZZyT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:20:02 INFO - PROCESS | 20013 | RSS: Main: 148135936 08:20:02 INFO - PROCESS | 20013 | 08:20:04 INFO - PROCESS | 20013 | Cycle 1(1): loaded http://localhost:53579/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53579/tests/kraken/driver.html?testName=audio-beat-detection) 08:20:05 INFO - PROCESS | 20013 | RSS: Main: 187101184 08:20:05 INFO - PROCESS | 20013 | 08:20:08 INFO - PROCESS | 20013 | Cycle 1(1): loaded http://localhost:53579/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53579/tests/kraken/driver.html?testName=audio-dft) 08:20:08 INFO - PROCESS | 20013 | RSS: Main: 176693248 08:20:08 INFO - PROCESS | 20013 | 08:20:11 INFO - PROCESS | 20013 | Cycle 1(1): loaded http://localhost:53579/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53579/tests/kraken/driver.html?testName=audio-fft) 08:20:12 INFO - PROCESS | 20013 | RSS: Main: 161738752 08:20:12 INFO - PROCESS | 20013 | 08:20:14 INFO - PROCESS | 20013 | Cycle 1(1): loaded http://localhost:53579/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53579/tests/kraken/driver.html?testName=audio-oscillator) 08:20:14 INFO - PROCESS | 20013 | RSS: Main: 166047744 08:20:14 INFO - PROCESS | 20013 | 08:20:17 INFO - PROCESS | 20013 | Cycle 1(1): loaded http://localhost:53579/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53579/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:20:17 INFO - PROCESS | 20013 | RSS: Main: 166404096 08:20:17 INFO - PROCESS | 20013 | 08:20:20 INFO - PROCESS | 20013 | Cycle 1(1): loaded http://localhost:53579/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53579/tests/kraken/driver.html?testName=imaging-darkroom) 08:20:21 INFO - PROCESS | 20013 | RSS: Main: 165945344 08:20:21 INFO - PROCESS | 20013 | 08:20:24 INFO - PROCESS | 20013 | Cycle 1(1): loaded http://localhost:53579/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53579/tests/kraken/driver.html?testName=imaging-desaturate) 08:20:25 INFO - PROCESS | 20013 | RSS: Main: 168394752 08:20:25 INFO - PROCESS | 20013 | 08:20:27 INFO - PROCESS | 20013 | Cycle 1(1): loaded http://localhost:53579/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53579/tests/kraken/driver.html?testName=json-parse-financial) 08:20:28 INFO - PROCESS | 20013 | RSS: Main: 168624128 08:20:28 INFO - PROCESS | 20013 | 08:20:30 INFO - PROCESS | 20013 | Cycle 1(1): loaded http://localhost:53579/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53579/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:20:30 INFO - PROCESS | 20013 | RSS: Main: 178708480 08:20:30 INFO - PROCESS | 20013 | 08:20:32 INFO - PROCESS | 20013 | Cycle 1(1): loaded http://localhost:53579/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53579/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:20:32 INFO - PROCESS | 20013 | RSS: Main: 176726016 08:20:32 INFO - PROCESS | 20013 | 08:20:35 INFO - PROCESS | 20013 | Cycle 1(1): loaded http://localhost:53579/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53579/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:20:35 INFO - PROCESS | 20013 | RSS: Main: 187322368 08:20:35 INFO - PROCESS | 20013 | 08:20:37 INFO - PROCESS | 20013 | Cycle 1(1): loaded http://localhost:53579/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53579/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:20:38 INFO - PROCESS | 20013 | RSS: Main: 194617344 08:20:38 INFO - PROCESS | 20013 | 08:20:41 INFO - PROCESS | 20013 | Cycle 1(1): loaded http://localhost:53579/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53579/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:20:41 INFO - PROCESS | 20013 | RSS: Main: 191614976 08:20:41 INFO - PROCESS | 20013 | 08:20:43 INFO - PROCESS | 20013 | Cycle 1(1): loaded http://localhost:53579/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53579/tests/kraken/driver.html?testName=ai-astar) 08:20:43 INFO - PROCESS | 20013 | RSS: Main: 252846080 08:20:43 INFO - PROCESS | 20013 | 08:20:43 INFO - PROCESS | 20013 | __start_tp_report 08:20:43 INFO - PROCESS | 20013 | _x_x_mozilla_page_load 08:20:43 INFO - PROCESS | 20013 | _x_x_mozilla_page_load_details 08:20:43 INFO - PROCESS | 20013 | |i|pagename|runs| 08:20:43 INFO - PROCESS | 20013 | |0;ai-astar;110;109;106;109;111;112;109;110;103;111 08:20:43 INFO - PROCESS | 20013 | |1;audio-beat-detection;148;134;155;172;128;151;154;128;162;129 08:20:43 INFO - PROCESS | 20013 | |2;audio-dft;161;161;160;166;160;159;160;161;160;163 08:20:43 INFO - PROCESS | 20013 | |3;audio-fft;76;74;100;93;73;76;73;130;90;73 08:20:43 INFO - PROCESS | 20013 | |4;audio-oscillator;101;96;138;95;96;96;145;95;96;140 08:20:43 INFO - PROCESS | 20013 | |5;imaging-gaussian-blur;119;115;114;114;115;114;114;115;115;115 08:20:43 INFO - PROCESS | 20013 | |6;imaging-darkroom;145;145;145;145;145;146;145;147;146;147 08:20:43 INFO - PROCESS | 20013 | |7;imaging-desaturate;95;96;95;95;95;96;96;96;96;96 08:20:43 INFO - PROCESS | 20013 | |8;json-parse-financial;57;58;56;56;55;56;57;59;57;53 08:20:43 INFO - PROCESS | 20013 | |9;json-stringify-tinderbox;65;66;67;67;68;67;67;66;68;67 08:20:43 INFO - PROCESS | 20013 | |10;stanford-crypto-aes;81;83;89;82;83;84;85;84;85;82 08:20:43 INFO - PROCESS | 20013 | |11;stanford-crypto-ccm;120;122;116;116;122;117;118;117;116;121 08:20:43 INFO - PROCESS | 20013 | |12;stanford-crypto-pbkdf2;155;145;155;153;156;143;155;152;158;144 08:20:43 INFO - PROCESS | 20013 | |13;stanford-crypto-sha256-iterative;76;67;70;67;67;66;67;67;68;68 08:20:43 INFO - PROCESS | 20013 | __end_tp_report 08:20:43 INFO - PROCESS | 20013 | __start_cc_report 08:20:43 INFO - PROCESS | 20013 | _x_x_mozilla_cycle_collect,951 08:20:43 INFO - PROCESS | 20013 | __end_cc_report 08:20:43 INFO - PROCESS | 20013 | __startTimestamp1453911643736__endTimestamp 08:20:43 INFO - PROCESS | 20013 | 08:20:43 INFO - PROCESS | 20013 | ------- Summary: start ------- 08:20:43 INFO - PROCESS | 20013 | Number of tests: 14 08:20:43 INFO - PROCESS | 20013 | 08:20:43 INFO - PROCESS | 20013 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:2.67 (2.4%) stddev-sans-first:2.80 08:20:43 INFO - PROCESS | 20013 | Values: 110.0 109.0 106.0 109.0 111.0 112.0 109.0 110.0 103.0 111.0 08:20:43 INFO - PROCESS | 20013 | 08:20:43 INFO - PROCESS | 20013 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:152.50 stddev:15.59 (10.2%) stddev-sans-first:16.52 08:20:43 INFO - PROCESS | 20013 | Values: 148.0 134.0 155.0 172.0 128.0 151.0 154.0 128.0 162.0 129.0 08:20:43 INFO - PROCESS | 20013 | 08:20:43 INFO - PROCESS | 20013 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:2.02 (1.3%) stddev-sans-first:2.15 08:20:43 INFO - PROCESS | 20013 | Values: 161.0 161.0 160.0 166.0 160.0 159.0 160.0 161.0 160.0 163.0 08:20:43 INFO - PROCESS | 20013 | 08:20:43 INFO - PROCESS | 20013 | [#3] audio-fft Cycles:10 Average:85.80 Median:75.00 stddev:18.40 (24.5%) stddev-sans-first:19.17 08:20:43 INFO - PROCESS | 20013 | Values: 76.0 74.0 100.0 93.0 73.0 76.0 73.0 130.0 90.0 73.0 08:20:43 INFO - PROCESS | 20013 | 08:20:43 INFO - PROCESS | 20013 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:95.50 stddev:21.66 (22.7%) stddev-sans-first:22.74 08:20:43 INFO - PROCESS | 20013 | Values: 101.0 96.0 138.0 95.0 96.0 96.0 145.0 95.0 96.0 140.0 08:20:43 INFO - PROCESS | 20013 | 08:20:43 INFO - PROCESS | 20013 | [#5] imaging-gaussian-blur Cycles:10 Average:115.00 Median:115.00 stddev:1.49 (1.3%) stddev-sans-first:0.53 08:20:43 INFO - PROCESS | 20013 | Values: 119.0 115.0 114.0 114.0 115.0 114.0 114.0 115.0 115.0 115.0 08:20:43 INFO - PROCESS | 20013 | 08:20:43 INFO - PROCESS | 20013 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:145.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 08:20:43 INFO - PROCESS | 20013 | Values: 145.0 145.0 145.0 145.0 145.0 146.0 145.0 147.0 146.0 147.0 08:20:43 INFO - PROCESS | 20013 | 08:20:43 INFO - PROCESS | 20013 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 08:20:43 INFO - PROCESS | 20013 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 08:20:43 INFO - PROCESS | 20013 | 08:20:43 INFO - PROCESS | 20013 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:57.00 stddev:1.65 (2.9%) stddev-sans-first:1.73 08:20:43 INFO - PROCESS | 20013 | Values: 57.0 58.0 56.0 56.0 55.0 56.0 57.0 59.0 57.0 53.0 08:20:43 INFO - PROCESS | 20013 | 08:20:43 INFO - PROCESS | 20013 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.71 08:20:43 INFO - PROCESS | 20013 | Values: 65.0 66.0 67.0 67.0 68.0 67.0 67.0 66.0 68.0 67.0 08:20:43 INFO - PROCESS | 20013 | 08:20:43 INFO - PROCESS | 20013 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:2.25 (2.7%) stddev-sans-first:2.15 08:20:43 INFO - PROCESS | 20013 | Values: 81.0 83.0 89.0 82.0 83.0 84.0 85.0 84.0 85.0 82.0 08:20:43 INFO - PROCESS | 20013 | 08:20:43 INFO - PROCESS | 20013 | [#11] stanford-crypto-ccm Cycles:10 Average:118.50 Median:119.00 stddev:2.51 (2.1%) stddev-sans-first:2.60 08:20:43 INFO - PROCESS | 20013 | Values: 120.0 122.0 116.0 116.0 122.0 117.0 118.0 117.0 116.0 121.0 08:20:43 INFO - PROCESS | 20013 | 08:20:43 INFO - PROCESS | 20013 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.60 Median:155.00 stddev:5.50 (3.5%) stddev-sans-first:5.70 08:20:43 INFO - PROCESS | 20013 | Values: 155.0 145.0 155.0 153.0 156.0 143.0 155.0 152.0 158.0 144.0 08:20:43 INFO - PROCESS | 20013 | 08:20:43 INFO - PROCESS | 20013 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:67.50 stddev:2.91 (4.3%) stddev-sans-first:1.13 08:20:43 INFO - PROCESS | 20013 | Values: 76.0 67.0 70.0 67.0 67.0 66.0 67.0 67.0 68.0 68.0 08:20:43 INFO - PROCESS | 20013 | -------- Summary: end -------- 08:20:43 INFO - PROCESS | 20013 | 08:20:44 INFO - TEST-INFO | 20013: exit 0 08:20:44 INFO - TEST-OK | kraken | took 59338ms 08:20:44 INFO - TEST-START | v8_7 08:20:44 INFO - operating with platform_type : linux_ 08:20:44 INFO - Initialising browser for v8_7 test... 08:20:44 INFO - TEST-INFO | started process 20261 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFaEMGM/profile http://localhost:53579/getInfo.html) 08:20:48 INFO - PROCESS | 20261 | __metrics Screen width/height:1600/1200 08:20:48 INFO - PROCESS | 20261 | colorDepth:24 08:20:48 INFO - PROCESS | 20261 | Browser inner width/height: 1024/697 08:20:48 INFO - PROCESS | 20261 | __metrics 08:20:48 INFO - PROCESS | 20261 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:20:48 INFO - PROCESS | 20261 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:20:49 INFO - TEST-INFO | 20261: exit 0 08:20:49 INFO - Browser initialized. 08:20:49 INFO - Running cycle 1/1 for v8_7 test... 08:20:49 INFO - TEST-INFO | started process 20341 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFaEMGM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:21:01 INFO - PROCESS | 20341 | RSS: Main: 148484096 08:21:01 INFO - PROCESS | 20341 | 08:21:24 INFO - PROCESS | 20341 | Cycle 1(1): loaded http://localhost:53579/tests/v8_7/run.html (next: http://localhost:53579/tests/v8_7/run.html) 08:21:24 INFO - PROCESS | 20341 | RSS: Main: 567873536 08:21:24 INFO - PROCESS | 20341 | 08:21:24 INFO - PROCESS | 20341 | __start_tp_report 08:21:24 INFO - PROCESS | 20341 | _x_x_mozilla_page_load 08:21:24 INFO - PROCESS | 20341 | _x_x_mozilla_page_load_details 08:21:24 INFO - PROCESS | 20341 | |i|pagename|runs| 08:21:24 INFO - PROCESS | 20341 | |0;Richards;167.78523489932886 08:21:24 INFO - PROCESS | 20341 | |1;DeltaBlue;188.85741265344666 08:21:24 INFO - PROCESS | 20341 | |2;Encrypt;274.0476842970677 08:21:24 INFO - PROCESS | 20341 | |3;Decrypt;5196.891191709845 08:21:24 INFO - PROCESS | 20341 | |4;RayTrace;1120.9406494960806 08:21:24 INFO - PROCESS | 20341 | |5;Earley;775.1937984496124 08:21:24 INFO - PROCESS | 20341 | |6;Boyer;12382.716049382716 08:21:24 INFO - PROCESS | 20341 | |7;RegExp;42808.51063829787 08:21:24 INFO - PROCESS | 20341 | |8;Splay;595.0266429840142 08:21:24 INFO - PROCESS | 20341 | |9;NavierStokes;4822.115384615385 08:21:24 INFO - PROCESS | 20341 | __end_tp_report 08:21:24 INFO - PROCESS | 20341 | __startTimestamp1453911684314__endTimestamp 08:21:24 INFO - PROCESS | 20341 | 08:21:24 INFO - PROCESS | 20341 | ------- Summary: start ------- 08:21:24 INFO - PROCESS | 20341 | Number of tests: 10 08:21:24 INFO - PROCESS | 20341 | 08:21:24 INFO - PROCESS | 20341 | [#0] Richards Cycles:1 Average:167.79 Median:167.79 stddev:0.00 (0.0%) 08:21:24 INFO - PROCESS | 20341 | Values: 167.8 08:21:24 INFO - PROCESS | 20341 | 08:21:24 INFO - PROCESS | 20341 | [#1] DeltaBlue Cycles:1 Average:188.86 Median:188.86 stddev:0.00 (0.0%) 08:21:24 INFO - PROCESS | 20341 | Values: 188.9 08:21:24 INFO - PROCESS | 20341 | 08:21:24 INFO - PROCESS | 20341 | [#2] Encrypt Cycles:1 Average:274.05 Median:274.05 stddev:0.00 (0.0%) 08:21:24 INFO - PROCESS | 20341 | Values: 274.0 08:21:24 INFO - PROCESS | 20341 | 08:21:24 INFO - PROCESS | 20341 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 08:21:24 INFO - PROCESS | 20341 | Values: 5196.9 08:21:24 INFO - PROCESS | 20341 | 08:21:24 INFO - PROCESS | 20341 | [#4] RayTrace Cycles:1 Average:1120.94 Median:1120.94 stddev:0.00 (0.0%) 08:21:24 INFO - PROCESS | 20341 | Values: 1120.9 08:21:24 INFO - PROCESS | 20341 | 08:21:24 INFO - PROCESS | 20341 | [#5] Earley Cycles:1 Average:775.19 Median:775.19 stddev:0.00 (0.0%) 08:21:24 INFO - PROCESS | 20341 | Values: 775.2 08:21:24 INFO - PROCESS | 20341 | 08:21:24 INFO - PROCESS | 20341 | [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 08:21:24 INFO - PROCESS | 20341 | Values: 12382.7 08:21:24 INFO - PROCESS | 20341 | 08:21:24 INFO - PROCESS | 20341 | [#7] RegExp Cycles:1 Average:42808.51 Median:42808.51 stddev:0.00 (0.0%) 08:21:24 INFO - PROCESS | 20341 | Values: 42808.5 08:21:24 INFO - PROCESS | 20341 | 08:21:24 INFO - PROCESS | 20341 | [#8] Splay Cycles:1 Average:595.03 Median:595.03 stddev:0.00 (0.0%) 08:21:24 INFO - PROCESS | 20341 | Values: 595.0 08:21:24 INFO - PROCESS | 20341 | 08:21:24 INFO - PROCESS | 20341 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 08:21:24 INFO - PROCESS | 20341 | Values: 4822.1 08:21:24 INFO - PROCESS | 20341 | -------- Summary: end -------- 08:21:24 INFO - PROCESS | 20341 | 08:21:25 INFO - TEST-INFO | 20341: exit 0 08:21:25 INFO - TEST-OK | v8_7 | took 40558ms 08:21:25 INFO - SUITE-END | took 1213s 08:21:25 INFO - Completed test suite (00:20:13) 08:21:25 INFO - Working with test: dromaeo_css 08:21:25 INFO - Generating results file: dromaeo_css 08:21:25 INFO - Working with test: kraken 08:21:25 INFO - Generating results file: kraken 08:21:25 INFO - javascript benchmark 08:21:25 INFO - Working with test: v8_7 08:21:25 INFO - Generating results file: v8_7 08:21:25 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:21:25 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 08:21:25 INFO - process_Request line: dromaeo_css 6695.98 graph.html#tests=[[72,64,35]] 08:21:25 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:21:25 INFO - process_Request line: kraken 1513.40 graph.html#tests=[[232,64,35]] 08:21:25 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:21:25 INFO - process_Request line: v8_7 20072.26 graph.html#tests=[[230,64,35]] 08:21:25 INFO - RETURN: dromaeo_css: 6695.98 08:21:25 INFO - RETURN: kraken: 1513.40 08:21:25 INFO - RETURN: v8_7: 20072.26 08:21:25 INFO - javascript benchmark 08:21:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3097.3650401667655, 3128.890488832891, 3175.5236714492808, 3175.90431301201, 3209.8234597097157, 5061.24081387792, 5098.980203959209, 5144.125498665227, 5158.871028224287, 5165.173572228439, 5004.099262132815, 5031.42138654054, 5082.872928176797, 5088.1095808233595, 5121.795128194877, 4586.908261834761, 4598.701084429518, 4602.631789456844, 4628.583427491525, 4659.603933665642, 4686.343911852344, 4703.976480117612, 4751.619870410359, 4758.428988521382, 4775.235962246042, 4631.976840115812, 4675.929861052087, 4691.741954192518, 4693.976530117362, 4695.389599352063, 4595.678302518825, 4629.583337499607, 4649.04694537619, 4649.418822647169, 4656.511066338054, 4535.852920272168, 4548.636109111296, 4560.521145279764, 4567.474740404829, 4588.082383523275, 4806.495317991596, 4845.176320025604, 4848.22428411456, 4854.538818812207, 4864.173090574611, 5417.322834645669, 5451.400345961941, 5525.972370138164, 5526.364468086182, 5546.77812887484, 5524.447555244484, 5529.502344788988, 5542.61201715876, 5545.057340252127, 5547.916781248285, 5014.648974571782, 5106.106431374495, 5141.15170996785, 5147.536721695065, 5150.0, 5617.185508101385, 5629.408912064175, 5653.293338332708, 5657.20799088128, 5674.574406919498, 5285.735713214324, 5300.416954135042, 5301.708406037705, 5306.628536002443, 5307.124324486416, 5409.55969853236, 5412.404635490093, 5443.836684899459, 5489.094299440548, 5530.944690553043, 5329.094054010828, 5345.438728933484, 5350.678959262456, 5352.277442545206, 5402.459754024645, 5293.655912365684, 5338.91991620126, 5339.199120131933, 5354.892902141935, 5389.487998640123, 4221.451211342506, 4222.451081359465, 4259.488861336659, 4303.569643035671, 4377.496587892433, 3827.5215598050245, 3840.116773142193, 3845.192509573021, 3856.5564960029956, 3879.9718074710227, 5141.511556402136, 5142.357205349332, 5144.7942082316285, 5145.176771716508, 5158.509941555546, 5388.326459192601, 5410.91883621746, 5462.0, 5481.0, 5524.281843360337, 5129.051125541787, 5133.794648214104, 5135.306733590917, 5137.640365174402, 5146.845594632167, 4735.739534325577, 4744.644151688637, 4745.430548334153, 4768.332433459318, 4793.304970779218, 5545.057340252167, 5549.639273447213, 5564.165375193753, 5619.662820230717, 5634.0, 5407.891842163213, 5443.863903402288, 5449.34607847045, 5454.781808727766, 5469.3983661797965, 5539.778408863762, 5618.578606604439, 5628.971855140698, 5650.519705825051, 5673.177389278614, 5233.110371236823, 5431.8098866539485, 5463.31708536433, 5470.343558772973, 5508.0, 5445.809396671098, 5451.155070963849, 5463.399026107205, 5467.343918729778, 5470.370907345706, 5193.0, 5318.388385335736, 5349.7860085597695, 5360.303160589098, 5403.297571315704, 5357.089294819968, 5362.463753624606, 5368.087425137814, 5383.434739352469, 5418.322709661293, 5322.41453440129, 5325.893482130413, 5326.493983071602, 5333.759980800795, 5375.032494151091, 5238.68567885928, 5265.420803711512, 5314.707691077027, 5428.67427954324, 5442.047641662614, 5254.42201357858, 5283.339582552181, 5284.947150528599, 5289.550388217045, 5296.655717378358], "unit": "score", "name": "dojo.html", "value": 5042.121077315384}, {"lowerIsBetter": false, "replicates": [527.1749711701185, 550.9999351177615, 577.4081566394445, 594.997025014875, 600.1388008208221, 27980.440391192165, 35831.641683583155, 36300.273994520096, 36375.818120909425, 36393.63606363936, 39276.80361598188, 39800.60199398005, 39847.40228896569, 39865.0, 39916.20167596646, 8411.0, 8617.267532259733, 8618.0, 8618.353623478233, 8620.870686939701, 8363.790905227388, 8457.70398036069, 8484.32125429964, 8484.66061357545, 8702.564871756418, 8433.915660843375, 8503.404761666687, 8503.532305723184, 8508.914910850874, 8511.787205319886, 8583.699570515033, 8589.914100858974, 8623.913760862406, 8658.783530411727, 8661.696840610548, 8457.66169353225, 8604.182602652738, 8604.784880377978, 8607.18231767981, 8607.48355098696, 39427.0, 39987.000324991815, 40028.19943601112, 40031.39952900709, 40043.59956400428, 3056.724894759482, 3276.4921437177277, 3378.8648454062054, 3491.4064609016527, 3828.846846126152, 29387.265318366997, 29849.850750746326, 30112.54831177534, 30214.58283337328, 30823.229419264473, 3722.8510859565586, 3725.3480640887738, 3751.9437208441896, 3755.8497660093562, 3842.865499707497, 268299.0, 268694.0, 270987.0, 271172.64413678, 272671.0, 50339.0, 50671.999999999265, 56125.15812262819, 56423.79338272787, 56566.151507727416, 50245.0, 50353.0, 50588.0, 50607.24089138666, 50711.98576028532, 13451.529196478272, 13605.591832245049, 13623.86376136226, 13643.590692279247, 13671.794923076162, 9837.835676151235, 10075.798484030278, 10086.293959422917, 10093.142082922886, 10976.067034302014, 18472.81527184738, 18849.434516964513, 18861.830889447614, 18969.81030189708, 19053.237870485304, 6976.825579360455, 7080.92919070813, 7083.079199704005, 7133.468932878155, 7237.89143162853, 890.4034297021011, 952.7141857442739, 963.8072385522923, 1011.7824667696333, 1021.0861279155115, 24575.01699931983, 24982.50034999326, 25050.624240636404, 25068.24795256145, 25232.116875909254, 968.331851022792, 996.930214884951, 1017.3692310767224, 1057.9788404231872, 1129.8757136714955, 13162.14446061003, 13324.0, 14561.854381456262, 15468.527001806424, 15835.208239587975, 310764.0, 312823.0, 313475.0, 314940.0, 315435.0, 50950.0, 51103.23345149826, 51189.74405128025, 51232.0, 51233.0, 1325.4565628092628, 1333.986170510419, 1353.9526116585873, 1354.4108312883927, 1370.294298436306, 27324.316892077855, 28248.152555422548, 28269.0, 28300.43399132047, 29159.85420072886, 41969.79015105027, 42290.788546057076, 42332.57667423286, 42369.576304237795, 42445.57554424416, 193394.0, 194576.0, 194666.0, 194953.0, 195110.0, 27932.720672793013, 28669.28326791847, 29464.410711786073, 31509.527357089202, 31699.20751981219, 36450.8177459111, 36565.81717091504, 36624.0, 37079.0, 37419.0, 31661.525077123402, 32028.5195722069, 32050.35899282048, 32287.0, 32596.0, 25692.614610781227, 32366.19084522906, 33832.66167338295, 34494.0, 34705.30589388148, 32168.35663286768, 32309.0, 32315.35369292648, 34967.475487867196, 35037.82481087578, 29984.400311994075, 31258.531122033644, 31760.36479270448, 31769.523457147698, 31821.681783181873, 23949.187557109453, 24294.63558046666, 24602.261932142064, 24649.753502464744, 24650.414552654376], "unit": "score", "name": "ext.html", "value": 17336.86367128845}, {"lowerIsBetter": false, "replicates": [354.98225088745556, 358.4354641439733, 358.5894151196879, 358.91206654369677, 360.5061066339116, 14310.427582896671, 14596.927015364909, 15539.766903496442, 16630.584235394123, 18058.367957121485, 15861.920690396531, 16508.25712842922, 17079.316827326893, 17136.742948855775, 17141.485755427326, 5194.55846253068, 5346.198070289468, 5395.325584301962, 5401.729913504329, 5409.188621706736, 3971.0866500704856, 4133.937990930139, 5275.261463395128, 5362.4637536246455, 5656.91514627281, 5713.857153571153, 5724.656520608777, 5802.564807639423, 5806.8966896289785, 5810.302763668345, 5129.410117836459, 5292.841214763564, 5304.840854774363, 5323.307969963918, 5331.546818520431, 5005.524475174852, 5091.61812864033, 5192.766325515361, 5196.32447781786, 5200.479952004807, 19366.128524216445, 19498.610027799506, 19571.90214048935, 19843.71015883963, 20022.0, 1930.1314408516084, 1986.2750096214777, 2020.565578400651, 2127.563849410867, 2278.646809744476, 9314.72055838326, 9614.663486778, 9753.707388778277, 10999.285046471954, 12772.233665980071, 1632.4776071657075, 1756.9385071522436, 1775.1834156288123, 1793.6861049316317, 1828.4057681253646, 55245.44754552443, 55768.16347754787, 56245.0, 56709.716451417895, 57309.71345143289, 9587.424754514752, 10017.599296028224, 10047.497625118862, 10081.344712593806, 10158.187345012382, 13024.869751302555, 13040.347982600832, 13094.279814610289, 13114.278714670785, 13144.0799144059, 7326.67029983652, 7386.525513952779, 7391.519551229153, 7521.210272921374, 7570.280823321776, 7022.297770222936, 7056.400205982446, 7095.148582170173, 7107.8933815992805, 7112.679929403189, 4329.415528903558, 4387.078713470143, 4405.449318835145, 4416.6025057744955, 4428.3800267962515, 1694.7203711387483, 1725.5341057914293, 1780.2967827707982, 1795.1921635264184, 1850.111946265773, 898.6077557221411, 906.1572737354323, 926.2127191886977, 927.5825878354632, 984.625842179967, 13758.449662013607, 15313.693726125415, 15459.61350966235, 15466.9226653866, 15853.128077955824, 883.6597909804772, 888.657866721304, 906.419891269588, 917.2478567574525, 950.9381890177116, 8865.68970086044, 9052.41159324655, 9058.864117038249, 9151.862722059175, 9211.677591284408, 500789.0, 509355.0, 509620.0, 522167.0, 534032.0, 45105.32342014872, 54485.1827222592, 56810.0, 71856.0, 76589.0, 1008.606643409071, 1047.5487359578622, 1127.8928501792316, 1173.9413029348668, 1175.753091850721, 13565.525206617722, 14119.364628591533, 14187.361568729226, 14445.92777036108, 14653.853461465675, 31815.363692725554, 32520.512192316663, 32805.67194328122, 33540.83229583934, 33788.0, 43570.34644480272, 44237.0, 45653.54346456626, 46737.0, 47805.52194478011, 7245.420366370783, 7389.224131466119, 7402.259774022555, 7420.5176663516695, 7526.962365188139, 10366.185917464263, 11315.660530184108, 11652.533898644298, 11733.237339572901, 11797.584289885268, 9899.604015839574, 9915.603375864885, 10138.949305253427, 10142.847857282295, 10169.389836609827, 9986.950065249628, 9999.0, 10008.899911001088, 10351.896481035094, 10481.423521706074, 10058.899411005796, 10081.89918100839, 10125.0, 10332.0, 10408.427536485264, 7265.0, 7389.261073892568, 7421.3691836192365, 7463.626818658937, 7475.028246327943, 9223.815523689624, 9602.423854568748, 9629.759256018375, 9633.518324083627, 9647.228221742384], "unit": "score", "name": "jquery.html", "value": 8082.139549574431}, {"lowerIsBetter": false, "replicates": [1343.7312537492503, 1495.895287329887, 1505.22480922325, 1668.4827703411943, 1803.981960180398, 6990.930090699091, 7345.118585769708, 7474.962625186873, 7479.813004674886, 7486.026816513846, 7564.508306960044, 7741.148473667892, 7774.41691873109, 7775.688972441096, 7778.766637000885, 2031.3702752146883, 2085.8748475091465, 2244.1696572268243, 2247.820174386053, 2277.81777457803, 2294.139697613395, 2306.054517647765, 2306.331163962449, 2309.08791027544, 2321.9767802322012, 2212.1040978403694, 2262.4117729390396, 2272.8977196026217, 2273.386185729852, 2280.2931091361647, 2167.8916054197384, 2174.1303478608525, 2180.008096316172, 2185.2460900989136, 2190.759016508183, 2198.5932602468592, 2205.151016858505, 2209.779022097777, 2216.4126506475795, 2305.1586171047447, 7777.222277772177, 7854.1360450350985, 7864.449488535804, 7869.881951770728, 7883.0934442539265, 4691.976540117312, 4807.591354734852, 4841.2496063110275, 4844.2975768513725, 4850.6362022848425, 2963.496205645024, 2991.222282206642, 3031.1361262040214, 3034.499307614241, 3133.482975309071, 917.3624331089895, 933.1182032978837, 954.2985905359556, 961.0437614573544, 980.8626792249091, 10711.143108551298, 10738.355698658106, 10780.245382823205, 10794.352338859615, 10827.458627068616, 4168.416421700964, 4229.048464095554, 4283.164782867311, 4302.870913872589, 4332.306830907103, 8755.474671519729, 8835.734927952171, 8868.8669669955, 8898.199162075314, 8910.509921954224, 4808.807647694053, 4811.639127065484, 4817.1810792164715, 4818.638602104857, 4819.638527110411, 4402.581754733295, 4435.82256709728, 4441.0, 4442.5557444255965, 4450.132224216247, 3270.9018729438153, 3405.7275417966503, 3497.632748561415, 3514.262004978932, 3561.9109522261633, 1067.4182570499097, 1068.417712346773, 1080.708208783624, 1085.3108276244484, 1093.1528065749108, 1295.112847699329, 1295.7214198947272, 1317.571789168524, 1317.6244770240435, 1320.214472388927, 6987.406070483964, 7104.573725576379, 7123.82190445243, 7133.750318738819, 7148.785536433916, 1088.080571916729, 1088.802665723624, 1091.9945400272948, 1095.238809027734, 1137.9943100284445, 5567.610267281251, 5722.799702010409, 5724.542036637059, 5733.512651424592, 5747.137929310553, 9151.725448236564, 9409.90590094104, 9576.76058098553, 9720.659776907774, 9742.95128524353, 9454.621815127319, 9599.280053995979, 9629.374090684083, 9631.759206019906, 9640.228781697448, 7310.195878453366, 7397.889031664529, 7413.4810563261135, 7421.2949769771785, 7458.70165193397, 7073.5402198858965, 7102.218755936739, 7175.748848790267, 7190.388816950618, 7193.4604904631315, 8189.344852411912, 8464.068952415106, 8492.915070849212, 8513.106123856905, 8668.046514883232, 8633.438826476258, 8829.11708829112, 8843.55782210874, 8845.601947912488, 8895.911040889509, 5840.2115714379715, 6592.571482853599, 6806.18325800907, 6810.82972925661, 6817.147856517935, 6712.664366781739, 7191.352778249982, 7386.0767404074495, 7392.186859445565, 7393.852122957618, 6827.180738311435, 7008.544444611084, 7009.684564194726, 7081.114860642419, 7155.892661610184, 6858.862822743417, 6866.690998905161, 6880.0, 6968.756093536702, 6993.335633114846, 6811.69347379379, 6957.408620267334, 7001.684924178322, 7017.052697885924, 7023.508354415142, 6389.073584330153, 6433.0, 6436.131122298617, 6451.225852897683, 6456.418922297016, 6100.23747031621, 6119.908201376894, 6135.294441139326, 6146.354632763496, 6150.723217455135], "unit": "score", "name": "mootools.html", "value": 4455.12095870545}, {"lowerIsBetter": false, "replicates": [334.81752444917515, 337.6151187646082, 341.38550608903967, 345.6422602606302, 346.3194822174425, 5756.827295181151, 5841.240638716966, 5842.386549412315, 5893.351731309553, 5933.288005439354, 5639.802606908759, 5800.100984347422, 5826.184334193205, 5843.2695913010875, 5856.385079566648, 4544.068465964469, 4559.566841150086, 4561.680682352228, 4567.862964111082, 4573.634109271267, 4351.65186785058, 4406.294992801152, 4474.284114541674, 4509.278515437531, 4551.749653769041, 4444.666650001247, 4468.97765511172, 4475.955240447586, 4477.082198149388, 4525.230710779159, 4497.640188784906, 4503.369528266046, 4510.097980403916, 4518.457785065813, 4529.320601909707, 3997.6402123809, 4001.4397984282223, 4002.0595160137345, 4007.9599204007877, 4009.919801603981, 5452.563794896439, 5580.86047848803, 5600.243967064435, 5610.074337734269, 5613.831585052455, 5142.51146141116, 5148.768305426227, 5149.819756308511, 5151.922721159186, 5156.845294641167, 5911.527077833763, 6153.661548614825, 6214.0, 6223.284322302902, 6224.0, 4236.2586547354085, 4251.192273468031, 4318.805653745589, 4346.1090476452255, 4350.456192975878, 6430.1319321891415, 6484.481241500669, 6492.285848556655, 6499.54503184782, 6516.185476815398, 4459.063596644741, 4462.884278930267, 4465.37484752135, 4465.419495465569, 4468.151051300242, 4441.178381999341, 4480.417545719036, 4513.1650644630845, 4517.073999830027, 4537.069900670354, 5201.401838788512, 5202.53177214045, 5211.270422140903, 5211.71335576547, 5213.869653258699, 6269.7178626961895, 6286.748530058747, 6332.33510481402, 6340.4293613575, 6348.873022539523, 1575.8109026916613, 1598.824129345771, 1598.9520314390354, 1599.5921040134924, 1599.720048991445, 1066.871975362946, 1066.981033113375, 1074.693712291993, 1076.612419528969, 1098.5001824169983, 5930.28836539618, 5931.258592675916, 5931.6441013539325, 5932.050871860568, 5943.791967281124, 6430.903536446864, 6433.678316084177, 6440.452561532322, 6442.194725659293, 6443.7744678936015, 5862.091375836752, 5896.410358964069, 5923.911141332884, 5924.081767325985, 5932.822015339547, 3358.059743271888, 3460.7058400035776, 3473.4442489201606, 3475.5134281200653, 3476.5132881396626, 6697.966510167418, 6699.5310328276555, 6703.296153903867, 6704.96647516769, 6767.323267673193, 6570.408663220333, 6587.50593705474, 6589.571677841021, 6591.571547849375, 6593.604383736991, 6511.576747511492, 6681.2984636612455, 6683.198016237985, 6695.665216739241, 6703.195616526048, 6237.937620623736, 6370.140031095928, 6414.422701956846, 6420.582662126947, 6422.3577642235405, 6230.719617617308, 6305.842353941188, 6400.583962042452, 6410.102585637921, 6435.839104022437, 6699.162604674416, 6704.128463299739, 6719.059331693469, 6719.899201512079, 6731.158605174353, 4341.565843415633, 4428.756418397019, 4469.396631454712, 4471.686981911235, 4473.888152796076, 6369.0764839099, 6420.1974753155855, 6425.164728585254, 6428.035794630843, 6429.32492088324, 6269.059641053878, 6274.058891166362, 6276.74893004293, 6284.151639528788, 6287.842803929939, 6104.4200800923845, 6245.812625621239, 6249.312575616587, 6250.3749625037135, 6260.718267677874, 6193.597416167935, 6203.0, 6207.0, 6209.130721699056, 6213.5339849512375, 6347.0, 6351.841203969938, 6351.96824015877, 6353.841153971188, 6355.396237357444, 6118.816435506942, 6200.503959683305, 6200.7519699211525, 6212.29161980459, 6241.282252541016], "unit": "score", "name": "prototype.html", "value": 4718.054218510228}, {"lowerIsBetter": false, "replicates": [724.4638967164293, 726.4987158860388, 749.2919191364159, 782.1279273609927, 813.9226773456521, 13090.0, 13227.801582976263, 13230.603081907546, 13295.268760218196, 13299.468021279137, 11123.054540364059, 11123.833142502848, 11137.832932505999, 11153.275037122601, 11154.0, 650.5088658063156, 659.838339606797, 791.7387262203473, 798.3812545277399, 798.8162722573811, 790.7430085222297, 812.4515951732586, 814.5845618734429, 814.96740130395, 815.0667485728837, 835.8662613981764, 840.2983508770154, 844.8183640517287, 845.18439705684, 845.8519759042174, 678.7488629207176, 691.4157536881327, 826.3884725303293, 829.6805729794013, 832.4048305461594, 620.872721092175, 624.0857144283647, 625.2653132569259, 629.0312918106112, 629.6694235526339, 12805.743885122338, 12816.0, 12827.551035713705, 12849.293288869108, 12902.290374029519, 11589.884101159048, 12474.81287780684, 12508.874911250861, 12601.74796504074, 12934.54729084487, 9229.21551668109, 9447.480388578626, 9518.190953768937, 9609.759756006086, 9719.56261968213, 3482.982585087084, 3486.721062315034, 3510.592131844219, 3541.8229088545468, 3580.6777390034763, 44683.55316446826, 44776.55223447757, 44788.05785103314, 44876.32685509687, 45267.54732452666, 9445.480498572508, 9582.0, 9786.41281523111, 9873.703788886345, 9889.505524723734, 17599.20803563843, 18101.366452174112, 18105.63788724218, 18115.36596219126, 18121.90939045296, 7195.424366050704, 7251.23861994483, 7681.731139410093, 7779.4554381192775, 7828.960855195687, 4051.4125451809323, 4169.812358443816, 4248.575142485788, 4301.91396172081, 4377.146456441027, 3077.553754705555, 3127.0462508934993, 3133.2166958260436, 3133.5769671094567, 3152.763542734304, 558.7988324203284, 561.7865211219711, 566.396787421395, 566.9914951275734, 572.6792995922297, 504.72744717851947, 557.6737608499074, 607.9968052713059, 662.2648859765657, 679.7281087565013, 7905.209479052049, 8035.919640803634, 8149.185081491803, 8231.34149268057, 8552.273056790242, 622.1414448061646, 649.0491430054992, 650.8795872763459, 653.2259272761793, 658.4699317049821, 3827.13889374894, 3883.980580097081, 3886.514185726784, 4025.7383270087353, 4307.763073031013, 45375.54624453779, 45382.0, 45635.0, 52604.73952604785, 53392.73303633457, 47099.52900470951, 48310.75844620755, 48317.75841120772, 48755.75622121867, 49004.509954900706, 42470.57529424728, 43061.56938430575, 43201.78399107984, 43301.783491082344, 43512.347314790306, 8150.633221505165, 8283.792905177419, 8420.915790842013, 8476.957615211884, 8520.659173632985, 33384.82535207047, 33438.83280583582, 34010.31979360448, 34040.82979585086, 34049.82975085109, 39505.209895801345, 39532.20935581215, 40277.79861100676, 43842.780786097144, 43889.78055109704, 11123.27698699582, 11267.492962816528, 11757.412129393668, 11834.408279586158, 11943.522259109539, 11106.944465277622, 11884.46519906589, 12166.57416990401, 12386.256824590553, 12417.44121514516, 10236.590536378759, 10772.192085593768, 10867.402292873969, 11096.0, 11428.714282143013, 10606.0, 10882.61910833117, 11021.0, 11067.612633557786, 11526.752699030372, 8471.872921906053, 10261.333013354108, 10668.359898406121, 10822.350658960488, 11523.193376463567, 9180.862287065833, 9491.715248542554, 9526.571304291185, 9656.37233579815, 9695.224382049279, 9110.908890911007, 9734.853977190489, 9781.755456113655, 9908.702738917844, 10072.904555411707], "unit": "score", "name": "yui.html", "value": 6068.999102583731}], "name": "dromaeo_css", "value": 6695.984134288345}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 109.0, 106.0, 109.0, 111.0, 112.0, 109.0, 110.0, 103.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [148.0, 134.0, 155.0, 172.0, 128.0, 151.0, 154.0, 128.0, 162.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 166.0, 160.0, 159.0, 160.0, 161.0, 160.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [76.0, 74.0, 100.0, 93.0, 73.0, 76.0, 73.0, 130.0, 90.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.8}, {"lowerIsBetter": true, "replicates": [101.0, 96.0, 138.0, 95.0, 96.0, 96.0, 145.0, 95.0, 96.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 114.0, 114.0, 115.0, 114.0, 114.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.0}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 56.0, 56.0, 55.0, 56.0, 57.0, 59.0, 57.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 67.0, 67.0, 68.0, 67.0, 67.0, 66.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.8}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 89.0, 82.0, 83.0, 84.0, 85.0, 84.0, 85.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [120.0, 122.0, 116.0, 116.0, 122.0, 117.0, 118.0, 117.0, 116.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.5}, {"lowerIsBetter": true, "replicates": [155.0, 145.0, 155.0, 153.0, 156.0, 143.0, 155.0, 152.0, 158.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.6}, {"lowerIsBetter": true, "replicates": [76.0, 67.0, 70.0, 67.0, 67.0, 66.0, 67.0, 67.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1513.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.78523489932886], "unit": "score", "name": "Richards", "value": 210.39992}, {"lowerIsBetter": false, "replicates": [188.85741265344666], "unit": "score", "name": "DeltaBlue", "value": 350.09481000000017}, {"lowerIsBetter": false, "replicates": [274.0476842970677], "unit": "score", "name": "Encrypt", "value": 971.2944689999996}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1120.9406494960806], "unit": "score", "name": "RayTrace", "value": 660.1500269730271}, {"lowerIsBetter": false, "replicates": [775.1937984496124], "unit": "score", "name": "Earley", "value": 859.7372699999999}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [42808.51063829787], "unit": "score", "name": "RegExp", "value": 21.280464711729604}, {"lowerIsBetter": false, "replicates": [595.0266429840142], "unit": "score", "name": "Splay", "value": 136.9535313432836}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 20072.261799599637}]} 08:21:25 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20072.26"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1513.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6695.98"}}} 08:21:25 INFO - Return code: 0 08:21:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:21:25 INFO - # TBPL SUCCESS # 08:21:25 INFO - Running post-action listener: _resource_record_post_action 08:21:25 INFO - Running post-run listener: _resource_record_post_run 08:21:26 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 0; Write bytes: 567529472; Read time: 0; Write time: 935504 08:21:26 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 237838336; Read time: 0; Write time: 554032 08:21:26 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 0; Write bytes: 313487360; Read time: 0; Write time: 371092 08:21:26 INFO - Running post-run listener: _upload_blobber_files 08:21:26 INFO - Blob upload gear active. 08:21:26 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:21:26 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:21:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 08:21:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 08:21:27 INFO - (blobuploader) - INFO - Open directory for files ... 08:21:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:21:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:21:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:21:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:21:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:21:27 INFO - (blobuploader) - INFO - Done attempting. 08:21:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:21:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:21:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:21:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:21:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:21:28 INFO - (blobuploader) - INFO - Done attempting. 08:21:28 INFO - (blobuploader) - INFO - Iteration through files over. 08:21:28 INFO - Return code: 0 08:21:28 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:21:28 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:21:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6720a8517918fc4876777c66da92b26e53019833a238c9829a164281640c9a3d06931f4e6f8f89ddd652afda5f80e35376e372cc40b11adaa5863b1faef8845b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a43e4145e55c3681ee74c5acff5fb045770ba68263180b4e674db5126c99b6397cbd518f495006ba8922e521316257607b58dff49691e01b54887936ddea4b35"} 08:21:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:21:28 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:21:28 INFO - Contents: 08:21:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6720a8517918fc4876777c66da92b26e53019833a238c9829a164281640c9a3d06931f4e6f8f89ddd652afda5f80e35376e372cc40b11adaa5863b1faef8845b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a43e4145e55c3681ee74c5acff5fb045770ba68263180b4e674db5126c99b6397cbd518f495006ba8922e521316257607b58dff49691e01b54887936ddea4b35"} 08:21:28 INFO - Running post-run listener: copy_logs_to_upload_dir 08:21:28 INFO - Copying logs to upload dir... 08:21:28 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 08:21:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.001586 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-27 08:21:28.399241) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-27 08:21:28.402870) ========= 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=8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202 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/6720a8517918fc4876777c66da92b26e53019833a238c9829a164281640c9a3d06931f4e6f8f89ddd652afda5f80e35376e372cc40b11adaa5863b1faef8845b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a43e4145e55c3681ee74c5acff5fb045770ba68263180b4e674db5126c99b6397cbd518f495006ba8922e521316257607b58dff49691e01b54887936ddea4b35"} build_url:https://queue.taskcluster.net/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011496 build_url: 'https://queue.taskcluster.net/v1/task/LsJWkVY6RpmlsoyQCPyYrw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6720a8517918fc4876777c66da92b26e53019833a238c9829a164281640c9a3d06931f4e6f8f89ddd652afda5f80e35376e372cc40b11adaa5863b1faef8845b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a43e4145e55c3681ee74c5acff5fb045770ba68263180b4e674db5126c99b6397cbd518f495006ba8922e521316257607b58dff49691e01b54887936ddea4b35"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-27 08:21:28.429535) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:21:28.430199) ========= 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=8783db0840cc980e80bb0bd400000236-1453910167.936644-1094362202 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 08:21:28.512186) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-27 08:21:28.512504) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-27 08:21:28.512780) ========= ========= Total master_lag: 0.28 =========