builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1453252514.44 results: success (0) buildid: 20160119143009 builduid: cae9caf2646b46c29bde4ac7768cac5f revision: 48e077b052981e34081e4b8158678fee4f52e88c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:14.440990) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:14.441455) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:14.441785) ========= 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-1453252003.933676-862171949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006388 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.08 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:14.523386) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:14.523710) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:14.724145) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:14.724522) ========= 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-1453252003.933676-862171949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.031362 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:14.805196) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:14.805589) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:14.809084) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:14.809473) ========= 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-1453252003.933676-862171949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-19 17:15:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2016-01-19 17:15:15 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177410 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:15.008507) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:15.008959) ========= 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-1453252003.933676-862171949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.153507 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:15.211718) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:15.212085) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 48e077b052981e34081e4b8158678fee4f52e88c --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 48e077b052981e34081e4b8158678fee4f52e88c --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-1453252003.933676-862171949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-19 17:15:15,289 truncating revision to first 12 chars 2016-01-19 17:15:15,289 Setting DEBUG logging. 2016-01-19 17:15:15,289 attempt 1/10 2016-01-19 17:15:15,289 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/48e077b05298?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-19 17:15:15,540 unpacking tar archive at: fx-team-48e077b05298/testing/mozharness/ program finished with exit code 0 elapsedTime=0.532638 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:15.761022) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:15.761331) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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-1453252003.933676-862171949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.003914 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:15.811478) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:15.811777) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:15.826470) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:15.826828) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 17:15:15.827270) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-19 17:15:15.827546) ========= /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-1453252003.933676-862171949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:15:15 INFO - MultiFileLogger online at 20160119 17:15:15 in /builds/slave/test-pgo 17:15:15 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 17:15:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:15:16 INFO - {'append_to_log': False, 17:15:16 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:15:16 INFO - 'blob_upload_branch': 'Fx-Team', 17:15:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:15:16 INFO - 'branch': 'Fx-Team', 17:15:16 INFO - 'buildbot_json_path': 'buildprops.json', 17:15:16 INFO - 'config_files': ('talos/linux_config.py',), 17:15:16 INFO - 'default_actions': ('clobber', 17:15:16 INFO - 'read-buildbot-config', 17:15:16 INFO - 'download-and-extract', 17:15:16 INFO - 'populate-webroot', 17:15:16 INFO - 'create-virtualenv', 17:15:16 INFO - 'install', 17:15:16 INFO - 'run-tests'), 17:15:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:15:16 INFO - 'download_minidump_stackwalk': True, 17:15:16 INFO - 'download_symbols': 'ondemand', 17:15:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:15:16 INFO - 'tooltool.py': '/tools/tooltool.py', 17:15:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:15:16 INFO - '/tools/misc-python/virtualenv.py')}, 17:15:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:15:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:15:16 INFO - 'installer_path': 'installer.exe', 17:15:16 INFO - 'log_level': 'info', 17:15:16 INFO - 'log_name': 'talos', 17:15:16 INFO - 'log_to_console': True, 17:15:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:15:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:15:16 INFO - 'opt_config_files': (), 17:15:16 INFO - 'pip_index': False, 17:15:16 INFO - 'sps_profile': False, 17:15:16 INFO - 'sps_profile_interval': 0, 17:15:16 INFO - 'suite': 'dromaeojs', 17:15:16 INFO - 'system_bits': '32', 17:15:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:15:16 INFO - 'title': 'talos-linux64-ix-038', 17:15:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:15:16 INFO - 'use_talos_json': True, 17:15:16 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:15:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:15:16 INFO - 'work_dir': 'build'} 17:15:16 INFO - ##### 17:15:16 INFO - ##### Running clobber step. 17:15:16 INFO - ##### 17:15:16 INFO - Running pre-action listener: _resource_record_pre_action 17:15:16 INFO - Running main action method: clobber 17:15:16 INFO - rmtree: /builds/slave/test-pgo/build 17:15:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:15:17 INFO - Running post-action listener: _resource_record_post_action 17:15:17 INFO - ##### 17:15:17 INFO - ##### Running read-buildbot-config step. 17:15:17 INFO - ##### 17:15:17 INFO - Running pre-action listener: _resource_record_pre_action 17:15:17 INFO - Running main action method: read_buildbot_config 17:15:17 INFO - Using buildbot properties: 17:15:17 INFO - { 17:15:17 INFO - "project": "", 17:15:17 INFO - "product": "firefox", 17:15:17 INFO - "script_repo_revision": "production", 17:15:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:15:17 INFO - "repository": "", 17:15:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:15:17 INFO - "buildid": "20160119143009", 17:15:17 INFO - "pgo_build": "True", 17:15:17 INFO - "basedir": "/builds/slave/test-pgo", 17:15:17 INFO - "buildnumber": 430, 17:15:17 INFO - "slavename": "talos-linux64-ix-038", 17:15:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:15:17 INFO - "platform": "ubuntu64_hw", 17:15:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:15:17 INFO - "branch": "fx-team", 17:15:17 INFO - "repo_path": "integration/fx-team", 17:15:17 INFO - "revision": "48e077b052981e34081e4b8158678fee4f52e88c", 17:15:17 INFO - "stage_platform": "linux64-pgo", 17:15:17 INFO - "builduid": "cae9caf2646b46c29bde4ac7768cac5f", 17:15:17 INFO - "slavebuilddir": "test" 17:15:17 INFO - } 17:15:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 17:15:17 INFO - Running post-action listener: _resource_record_post_action 17:15:17 INFO - ##### 17:15:17 INFO - ##### Running download-and-extract step. 17:15:17 INFO - ##### 17:15:17 INFO - Running pre-action listener: _resource_record_pre_action 17:15:17 INFO - Running main action method: download_and_extract 17:15:17 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:15: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')]} 17:15:17 INFO - https://queue.taskcluster.net/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:15:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/test_packages.json 17:15:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/test_packages.json 17:15:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 17:15:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 17:15:24 INFO - Downloaded 1448 bytes. 17:15:24 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 17:15:24 INFO - Using the following test package requirements: 17:15:24 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:15:24 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:15:24 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:15:24 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:24 INFO - u'jsshell-linux-x86_64.zip'], 17:15:24 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:15:24 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:15:24 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:15:24 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:15:24 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:15:24 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:15:24 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:15:24 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:15:24 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:24 INFO - https://queue.taskcluster.net/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:15:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:15:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:15:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:15:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:15:27 INFO - Downloaded 22485690 bytes. 17:15:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:15:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 17:15:28 INFO - Return code: 0 17:15:28 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:15: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')]} 17:15:28 INFO - https://queue.taskcluster.net/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:15:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:15:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:15:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:15:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:15:33 INFO - Downloaded 22485690 bytes. 17:15:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:15:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 17:15:34 INFO - Return code: 0 17:15:34 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')]} 17:15:34 INFO - https://queue.taskcluster.net/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:15:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:15:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:15:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:15:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:15:36 INFO - Downloaded 11132144 bytes. 17:15:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 17:15:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 17:15:36 INFO - Return code: 0 17:15: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')]} 17:15:36 INFO - https://queue.taskcluster.net/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:15:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:15:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:15:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:15:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:15:37 INFO - Downloaded 55965789 bytes. 17:15:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:15:37 INFO - mkdir: /builds/slave/test-pgo/properties 17:15:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:15:37 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:15:37 INFO - Contents: 17:15:37 INFO - build_url:https://queue.taskcluster.net/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:15:37 INFO - Running post-action listener: _resource_record_post_action 17:15:37 INFO - Running post-action listener: set_extra_try_arguments 17:15:37 INFO - ##### 17:15:37 INFO - ##### Running populate-webroot step. 17:15:37 INFO - ##### 17:15:37 INFO - Running pre-action listener: _resource_record_pre_action 17:15:37 INFO - Running main action method: populate_webroot 17:15:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:15:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:15:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:15:37 INFO - '--tppagecycles', 17:15:37 INFO - '7'], 17:15:37 INFO - 'tests': ['tsvgm']}}, 17:15:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:15:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:15:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:15:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:15:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:15:37 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:15:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:37 INFO - 'talos_options': ['--e10s'], 17:15:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:37 INFO - 'tests': ['damp', 'tps']}, 17:15:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:37 INFO - 'talos_options': ['--e10s'], 17:15:37 INFO - 'tests': ['damp', 'tps']}, 17:15:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:15:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:15:37 INFO - 'other': {'tests': ['a11yr', 17:15:37 INFO - 'ts_paint', 17:15:37 INFO - 'tpaint', 17:15:37 INFO - 'sessionrestore', 17:15:37 INFO - 'sessionrestore_no_auto_restore']}, 17:15:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:15:37 INFO - 'tests': ['a11yr', 17:15:37 INFO - 'ts_paint', 17:15:37 INFO - 'tpaint', 17:15:37 INFO - 'sessionrestore', 17:15:37 INFO - 'sessionrestore_no_auto_restore']}, 17:15:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:15:37 INFO - 'tests': ['a11yr', 17:15:37 INFO - 'ts_paint', 17:15:37 INFO - 'tpaint', 17:15:37 INFO - 'sessionrestore', 17:15:37 INFO - 'sessionrestore_no_auto_restore']}, 17:15:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:15:37 INFO - 'tests': ['a11yr', 17:15:37 INFO - 'ts_paint', 17:15:37 INFO - 'tpaint', 17:15:37 INFO - 'sessionrestore', 17:15:37 INFO - 'sessionrestore_no_auto_restore']}, 17:15:37 INFO - 'other_l64': {'tests': ['a11yr', 17:15:37 INFO - 'ts_paint', 17:15:37 INFO - 'tpaint', 17:15:37 INFO - 'sessionrestore', 17:15:37 INFO - 'sessionrestore_no_auto_restore']}, 17:15:37 INFO - 'other_nol64': {'tests': ['a11yr', 17:15:37 INFO - 'ts_paint', 17:15:37 INFO - 'tpaint', 17:15:37 INFO - 'sessionrestore', 17:15:37 INFO - 'sessionrestore_no_auto_restore']}, 17:15:37 INFO - 'svgr': {'tests': ['tsvgx', 17:15:37 INFO - 'tsvgr_opacity', 17:15:37 INFO - 'tart', 17:15:37 INFO - 'tscrollx', 17:15:37 INFO - 'cart']}, 17:15:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:15:37 INFO - 'tests': ['tsvgx', 17:15:37 INFO - 'tsvgr_opacity', 17:15:37 INFO - 'tart', 17:15:37 INFO - 'tscrollx', 17:15:37 INFO - 'cart']}, 17:15:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:37 INFO - 'tests': ['tp5o']}, 17:15:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:37 INFO - 'talos_options': ['--e10s'], 17:15:37 INFO - 'tests': ['tp5o']}, 17:15:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:37 INFO - 'talos_options': ['--xperf_path', 17:15:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:37 INFO - 'tests': ['tp5n']}, 17:15:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:15:37 INFO - 'talos_options': ['--e10s', 17:15:37 INFO - '--xperf_path', 17:15:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:37 INFO - 'tests': ['tp5n']}}, 17:15:37 INFO - 'talos.zip': {'path': '', 17:15:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:15:37 INFO - Running post-action listener: _resource_record_post_action 17:15:37 INFO - ##### 17:15:37 INFO - ##### Running create-virtualenv step. 17:15:37 INFO - ##### 17:15:37 INFO - Running pre-action listener: _resource_record_pre_action 17:15:37 INFO - Running main action method: create_virtualenv 17:15:37 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:15:37 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 17:15:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:15:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:15:37 INFO - Using real prefix '/usr' 17:15:37 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:15:38 INFO - Installing distribute.............................................................................................................................................................................................done. 17:15:40 INFO - Installing pip.................done. 17:15:40 INFO - Return code: 0 17:15:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc27e56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a840>, '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 0x18e76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e7b60>, '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-1453252003.933676-862171949', '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 17:15:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 17:15:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:15:40 INFO - Using env: {'DISPLAY': ':0', 17:15:40 INFO - 'HOME': '/home/cltbld', 17:15:40 INFO - 'LANG': 'en_US.UTF-8', 17:15:40 INFO - 'LANGUAGE': 'en_US:en', 17:15:40 INFO - 'LOGNAME': 'cltbld', 17:15:40 INFO - 'MAIL': '/var/mail/cltbld', 17:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:40 INFO - 'MOZ_NO_REMOTE': '1', 17:15:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:40 INFO - 'NO_EM_RESTART': '1', 17:15:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:40 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:40 INFO - 'SHELL': '/bin/bash', 17:15:40 INFO - 'SHLVL': '1', 17:15:40 INFO - 'TERM': 'linux', 17:15:40 INFO - 'TMOUT': '86400', 17:15:40 INFO - 'USER': 'cltbld', 17:15:40 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453252003.933676-862171949', 17:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:40 INFO - '_': '/tools/buildbot/bin/python'} 17:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:40 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 17:15:40 INFO - Cleaning up... 17:15:40 INFO - Return code: 0 17:15:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc27e56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a840>, '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 0x18e76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e7b60>, '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-1453252003.933676-862171949', '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 17:15:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 17:15:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:15:40 INFO - Using env: {'DISPLAY': ':0', 17:15:40 INFO - 'HOME': '/home/cltbld', 17:15:40 INFO - 'LANG': 'en_US.UTF-8', 17:15:40 INFO - 'LANGUAGE': 'en_US:en', 17:15:40 INFO - 'LOGNAME': 'cltbld', 17:15:40 INFO - 'MAIL': '/var/mail/cltbld', 17:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:40 INFO - 'MOZ_NO_REMOTE': '1', 17:15:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:40 INFO - 'NO_EM_RESTART': '1', 17:15:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:40 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:40 INFO - 'SHELL': '/bin/bash', 17:15:40 INFO - 'SHLVL': '1', 17:15:40 INFO - 'TERM': 'linux', 17:15:40 INFO - 'TMOUT': '86400', 17:15:40 INFO - 'USER': 'cltbld', 17:15:40 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453252003.933676-862171949', 17:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:40 INFO - '_': '/tools/buildbot/bin/python'} 17:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:40 INFO - Downloading/unpacking psutil>=0.7.1 17:15: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 17:15: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 17:15: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 17:15: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 17:15: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 17:15: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 17:15:42 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 17:15:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:15:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:15:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:15:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:15:42 INFO - Installing collected packages: psutil 17:15:42 INFO - Running setup.py install for psutil 17:15:42 INFO - building 'psutil._psutil_linux' extension 17:15:42 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 17:15:42 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 17:15:42 INFO - building 'psutil._psutil_posix' extension 17:15:42 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 17:15:43 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 17:15:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:15:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:15:43 INFO - Successfully installed psutil 17:15:43 INFO - Cleaning up... 17:15:43 INFO - Return code: 0 17:15:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc27e56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a840>, '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 0x18e76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e7b60>, '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-1453252003.933676-862171949', '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 17:15:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 17:15:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:15:43 INFO - Using env: {'DISPLAY': ':0', 17:15:43 INFO - 'HOME': '/home/cltbld', 17:15:43 INFO - 'LANG': 'en_US.UTF-8', 17:15:43 INFO - 'LANGUAGE': 'en_US:en', 17:15:43 INFO - 'LOGNAME': 'cltbld', 17:15:43 INFO - 'MAIL': '/var/mail/cltbld', 17:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:43 INFO - 'MOZ_NO_REMOTE': '1', 17:15:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:43 INFO - 'NO_EM_RESTART': '1', 17:15:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:43 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:43 INFO - 'SHELL': '/bin/bash', 17:15:43 INFO - 'SHLVL': '1', 17:15:43 INFO - 'TERM': 'linux', 17:15:43 INFO - 'TMOUT': '86400', 17:15:43 INFO - 'USER': 'cltbld', 17:15:43 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453252003.933676-862171949', 17:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:43 INFO - '_': '/tools/buildbot/bin/python'} 17:15:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:15:43 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 17:15:43 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 17:15:43 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 17:15:43 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 17:15:43 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 17:15:43 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 17:15:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:15:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:15:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:15:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:15:45 INFO - Installing collected packages: mozsystemmonitor 17:15:45 INFO - Running setup.py install for mozsystemmonitor 17:15:45 INFO - Successfully installed mozsystemmonitor 17:15:45 INFO - Cleaning up... 17:15:45 INFO - Return code: 0 17:15:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc27e56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a840>, '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 0x18e76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e7b60>, '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-1453252003.933676-862171949', '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 17:15:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 17:15:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:15:45 INFO - Using env: {'DISPLAY': ':0', 17:15:45 INFO - 'HOME': '/home/cltbld', 17:15:45 INFO - 'LANG': 'en_US.UTF-8', 17:15:45 INFO - 'LANGUAGE': 'en_US:en', 17:15:45 INFO - 'LOGNAME': 'cltbld', 17:15:45 INFO - 'MAIL': '/var/mail/cltbld', 17:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:45 INFO - 'MOZ_NO_REMOTE': '1', 17:15:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:45 INFO - 'NO_EM_RESTART': '1', 17:15:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:45 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:45 INFO - 'SHELL': '/bin/bash', 17:15:45 INFO - 'SHLVL': '1', 17:15:45 INFO - 'TERM': 'linux', 17:15:45 INFO - 'TMOUT': '86400', 17:15:45 INFO - 'USER': 'cltbld', 17:15:45 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453252003.933676-862171949', 17:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:45 INFO - '_': '/tools/buildbot/bin/python'} 17:15:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:45 INFO - Downloading/unpacking blobuploader==1.2.4 17:15:45 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 17:15:45 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 17:15:45 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 17:15:45 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 17:15:45 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 17:15:45 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 17:15:47 INFO - Downloading blobuploader-1.2.4.tar.gz 17:15:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:15:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:15:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:15:47 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 17:15:47 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 17:15:47 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 17:15:47 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 17:15:47 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 17:15:47 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 17:15:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:15:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:15:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:15:47 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 17:15:47 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 17:15:47 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 17:15:47 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 17:15:47 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 17:15:47 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 17:15:47 INFO - Downloading docopt-0.6.1.tar.gz 17:15:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:15:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:15:47 INFO - Installing collected packages: blobuploader, requests, docopt 17:15:47 INFO - Running setup.py install for blobuploader 17:15:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:15:47 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:15:47 INFO - Running setup.py install for requests 17:15:48 INFO - Running setup.py install for docopt 17:15:48 INFO - Successfully installed blobuploader requests docopt 17:15:48 INFO - Cleaning up... 17:15:48 INFO - Return code: 0 17:15:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:15: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')]} 17:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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')]} 17:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc27e56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a840>, '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 0x18e76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e7b60>, '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-1453252003.933676-862171949', '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 17:15:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 17:15:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:15:48 INFO - Using env: {'DISPLAY': ':0', 17:15:48 INFO - 'HOME': '/home/cltbld', 17:15:48 INFO - 'LANG': 'en_US.UTF-8', 17:15:48 INFO - 'LANGUAGE': 'en_US:en', 17:15:48 INFO - 'LOGNAME': 'cltbld', 17:15:48 INFO - 'MAIL': '/var/mail/cltbld', 17:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:48 INFO - 'MOZ_NO_REMOTE': '1', 17:15:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:48 INFO - 'NO_EM_RESTART': '1', 17:15:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:48 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:48 INFO - 'SHELL': '/bin/bash', 17:15:48 INFO - 'SHLVL': '1', 17:15:48 INFO - 'TERM': 'linux', 17:15:48 INFO - 'TMOUT': '86400', 17:15:48 INFO - 'USER': 'cltbld', 17:15:48 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453252003.933676-862171949', 17:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:48 INFO - '_': '/tools/buildbot/bin/python'} 17:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:15:48 INFO - Running setup.py (path:/tmp/pip-t3W5VA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:15:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:15:48 INFO - Running setup.py (path:/tmp/pip-Olpqhk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:15:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:15:48 INFO - Running setup.py (path:/tmp/pip-TzUZRg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:15:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:15:48 INFO - Running setup.py (path:/tmp/pip-b_BZ0Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:15:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:15:48 INFO - Running setup.py (path:/tmp/pip-K5tV16-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:15:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:15:49 INFO - Running setup.py (path:/tmp/pip-_oRJ1c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:15:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:15:49 INFO - Running setup.py (path:/tmp/pip-y7X4ti-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:15:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:15:49 INFO - Running setup.py (path:/tmp/pip-tHTiMx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:15:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:15:49 INFO - Running setup.py (path:/tmp/pip-M6qHqx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:15:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:15:49 INFO - Running setup.py (path:/tmp/pip-0myq7B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:15:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:15:49 INFO - Running setup.py (path:/tmp/pip-xCDTCu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:15:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:15:49 INFO - Running setup.py (path:/tmp/pip-DBWVjQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:15:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:15:49 INFO - Running setup.py (path:/tmp/pip-9BORuW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:15:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:15:49 INFO - Running setup.py (path:/tmp/pip-8udt1n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:15:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:15:49 INFO - Running setup.py (path:/tmp/pip-5V4rBF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:15:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:15:49 INFO - Running setup.py (path:/tmp/pip-DxXskC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:15:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:15:49 INFO - Running setup.py (path:/tmp/pip-MxfLBY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:15:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:15:49 INFO - Running setup.py install for manifestparser 17:15:49 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:15:50 INFO - Running setup.py install for mozcrash 17:15:50 INFO - Running setup.py install for mozdebug 17:15:50 INFO - Running setup.py install for mozdevice 17:15:50 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:15:50 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:15:50 INFO - Running setup.py install for mozfile 17:15:50 INFO - Running setup.py install for mozhttpd 17:15:50 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:15:50 INFO - Running setup.py install for mozinfo 17:15:50 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:15:50 INFO - Running setup.py install for mozInstall 17:15:50 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:15:50 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:15:50 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:15:50 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:15:50 INFO - Running setup.py install for mozleak 17:15:50 INFO - Running setup.py install for mozlog 17:15:50 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:15:50 INFO - Running setup.py install for moznetwork 17:15:51 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:15:51 INFO - Running setup.py install for mozprocess 17:15:51 INFO - Running setup.py install for mozprofile 17:15:51 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:15:51 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:15:51 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:15:51 INFO - Running setup.py install for mozrunner 17:15:51 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:15:51 INFO - Running setup.py install for mozscreenshot 17:15:51 INFO - Running setup.py install for moztest 17:15:51 INFO - Running setup.py install for mozversion 17:15:51 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:15:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:15:51 INFO - Cleaning up... 17:15:51 INFO - Return code: 0 17:15:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:15: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')]} 17:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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')]} 17:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fdc27e56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a840>, '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 0x18e76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e7b60>, '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-1453252003.933676-862171949', '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 17:15:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 17:15:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:15:51 INFO - Using env: {'DISPLAY': ':0', 17:15:51 INFO - 'HOME': '/home/cltbld', 17:15:51 INFO - 'LANG': 'en_US.UTF-8', 17:15:51 INFO - 'LANGUAGE': 'en_US:en', 17:15:51 INFO - 'LOGNAME': 'cltbld', 17:15:51 INFO - 'MAIL': '/var/mail/cltbld', 17:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:51 INFO - 'MOZ_NO_REMOTE': '1', 17:15:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:51 INFO - 'NO_EM_RESTART': '1', 17:15:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:51 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:51 INFO - 'SHELL': '/bin/bash', 17:15:51 INFO - 'SHLVL': '1', 17:15:51 INFO - 'TERM': 'linux', 17:15:51 INFO - 'TMOUT': '86400', 17:15:51 INFO - 'USER': 'cltbld', 17:15:51 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453252003.933676-862171949', 17:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:51 INFO - '_': '/tools/buildbot/bin/python'} 17:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:15:51 INFO - Running setup.py (path:/tmp/pip-PujUEZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:15:51 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)) 17:15:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:15:51 INFO - Running setup.py (path:/tmp/pip-V_UErk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:15:52 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)) 17:15:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:15:52 INFO - Running setup.py (path:/tmp/pip-scJcXx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:15:52 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)) 17:15:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:15:52 INFO - Running setup.py (path:/tmp/pip-qZb7d2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:15:52 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)) 17:15:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:15:52 INFO - Running setup.py (path:/tmp/pip-3osSKe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:15:52 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)) 17:15:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:15:52 INFO - Running setup.py (path:/tmp/pip-7yZE9k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:15:52 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)) 17:15:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:15:52 INFO - Running setup.py (path:/tmp/pip-Floc91-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:15:52 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)) 17:15:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:15:52 INFO - Running setup.py (path:/tmp/pip-UUYSO7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:15:52 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)) 17:15:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:15:52 INFO - Running setup.py (path:/tmp/pip-x0nw0h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:15:52 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)) 17:15:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:15:52 INFO - Running setup.py (path:/tmp/pip-t2G0vL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:15:52 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)) 17:15:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:15:52 INFO - Running setup.py (path:/tmp/pip-mjn7FR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:15:52 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)) 17:15:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:15:52 INFO - Running setup.py (path:/tmp/pip-doUmpp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:15:52 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)) 17:15:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:15:52 INFO - Running setup.py (path:/tmp/pip-oAZoaa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:15:52 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)) 17:15:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:15:52 INFO - Running setup.py (path:/tmp/pip-k8adOM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:15:52 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)) 17:15:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:15:52 INFO - Running setup.py (path:/tmp/pip-WnbgDh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:15:52 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)) 17:15:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:15:52 INFO - Running setup.py (path:/tmp/pip-od5vb4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:15:53 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)) 17:15:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:15:53 INFO - Running setup.py (path:/tmp/pip-HFEHDj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:15:53 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)) 17:15:53 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)) 17:15:53 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)) 17:15:53 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)) 17:15:53 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)) 17:15:53 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)) 17:15:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:15: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 17:15: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 17:15: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 17:15: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 17:15: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 17:15: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 17:15:54 INFO - Downloading blessings-1.5.1.tar.gz 17:15:54 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 17:15:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:15:54 INFO - Installing collected packages: blessings 17:15:54 INFO - Running setup.py install for blessings 17:15:55 INFO - Successfully installed blessings 17:15:55 INFO - Cleaning up... 17:15:55 INFO - Return code: 0 17:15:55 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:15:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:15:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:15:55 INFO - Reading from file tmpfile_stdout 17:15:55 INFO - Current package versions: 17:15:55 INFO - argparse == 1.2.1 17:15:55 INFO - blessings == 1.5.1 17:15:55 INFO - blobuploader == 1.2.4 17:15:55 INFO - docopt == 0.6.1 17:15:55 INFO - manifestparser == 1.1 17:15:55 INFO - mozInstall == 1.12 17:15:55 INFO - mozcrash == 0.16 17:15:55 INFO - mozdebug == 0.1 17:15:55 INFO - mozdevice == 0.48 17:15:55 INFO - mozfile == 1.2 17:15:55 INFO - mozhttpd == 0.7 17:15:55 INFO - mozinfo == 0.9 17:15:55 INFO - mozleak == 0.1 17:15:55 INFO - mozlog == 3.1 17:15:55 INFO - moznetwork == 0.27 17:15:55 INFO - mozprocess == 0.22 17:15:55 INFO - mozprofile == 0.28 17:15:55 INFO - mozrunner == 6.11 17:15:55 INFO - mozscreenshot == 0.1 17:15:55 INFO - mozsystemmonitor == 0.0 17:15:55 INFO - moztest == 0.7 17:15:55 INFO - mozversion == 1.4 17:15:55 INFO - psutil == 3.1.1 17:15:55 INFO - requests == 1.2.3 17:15:55 INFO - wsgiref == 0.1.2 17:15:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:15:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fdc27e56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a840>, '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 0x18e76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e7b60>, '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-1453252003.933676-862171949', '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 17:15:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 17:15:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:15:55 INFO - Using env: {'DISPLAY': ':0', 17:15:55 INFO - 'HOME': '/home/cltbld', 17:15:55 INFO - 'LANG': 'en_US.UTF-8', 17:15:55 INFO - 'LANGUAGE': 'en_US:en', 17:15:55 INFO - 'LOGNAME': 'cltbld', 17:15:55 INFO - 'MAIL': '/var/mail/cltbld', 17:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:55 INFO - 'MOZ_NO_REMOTE': '1', 17:15:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:55 INFO - 'NO_EM_RESTART': '1', 17:15:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:55 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:55 INFO - 'SHELL': '/bin/bash', 17:15:55 INFO - 'SHLVL': '1', 17:15:55 INFO - 'TERM': 'linux', 17:15:55 INFO - 'TMOUT': '86400', 17:15:55 INFO - 'USER': 'cltbld', 17:15:55 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453252003.933676-862171949', 17:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:55 INFO - '_': '/tools/buildbot/bin/python'} 17:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:55 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)) 17:15:55 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)) 17:15:55 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)) 17:15:55 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)) 17:15:55 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)) 17:15:55 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)) 17:15:55 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)) 17:15:55 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)) 17:15:55 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)) 17:15:55 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)) 17:15:55 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)) 17:15:55 INFO - Cleaning up... 17:15:55 INFO - Return code: 0 17:15:55 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:15:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc27e56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a840>, '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 0x18e76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e7b60>, '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-1453252003.933676-862171949', '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 17:15:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 17:15:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:15:55 INFO - Using env: {'DISPLAY': ':0', 17:15:55 INFO - 'HOME': '/home/cltbld', 17:15:55 INFO - 'LANG': 'en_US.UTF-8', 17:15:55 INFO - 'LANGUAGE': 'en_US:en', 17:15:55 INFO - 'LOGNAME': 'cltbld', 17:15:55 INFO - 'MAIL': '/var/mail/cltbld', 17:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:55 INFO - 'MOZ_NO_REMOTE': '1', 17:15:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:55 INFO - 'NO_EM_RESTART': '1', 17:15:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:55 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:55 INFO - 'SHELL': '/bin/bash', 17:15:55 INFO - 'SHLVL': '1', 17:15:55 INFO - 'TERM': 'linux', 17:15:55 INFO - 'TMOUT': '86400', 17:15:55 INFO - 'USER': 'cltbld', 17:15:55 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453252003.933676-862171949', 17:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:55 INFO - '_': '/tools/buildbot/bin/python'} 17:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:55 INFO - Downloading/unpacking jsonschema 17:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:15:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 17:15:57 INFO - Downloading/unpacking functools32 (from jsonschema) 17:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:57 INFO - Downloading functools32-3.2.3-2.tar.gz 17:15:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 17:15:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:15:57 INFO - warning: no files found matching '*.txt' 17:15:57 INFO - no previously-included directories found matching 'build' 17:15:57 INFO - no previously-included directories found matching 'dist' 17:15:57 INFO - no previously-included directories found matching '.git*' 17:15:57 INFO - Installing collected packages: jsonschema, functools32 17:15:57 INFO - Running setup.py install for functools32 17:15:57 INFO - warning: no files found matching '*.txt' 17:15:57 INFO - no previously-included directories found matching 'build' 17:15:57 INFO - no previously-included directories found matching 'dist' 17:15:57 INFO - no previously-included directories found matching '.git*' 17:15:57 INFO - Successfully installed jsonschema functools32 17:15:57 INFO - Cleaning up... 17:15:57 INFO - Return code: 0 17:15:57 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc27e56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e9630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197a840>, '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 0x18e76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e7b60>, '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-1453252003.933676-862171949', '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 17:15:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 17:15:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:15:57 INFO - Using env: {'DISPLAY': ':0', 17:15:57 INFO - 'HOME': '/home/cltbld', 17:15:57 INFO - 'LANG': 'en_US.UTF-8', 17:15:57 INFO - 'LANGUAGE': 'en_US:en', 17:15:57 INFO - 'LOGNAME': 'cltbld', 17:15:57 INFO - 'MAIL': '/var/mail/cltbld', 17:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:57 INFO - 'MOZ_NO_REMOTE': '1', 17:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:57 INFO - 'NO_EM_RESTART': '1', 17:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:15:57 INFO - 'PWD': '/builds/slave/test-pgo', 17:15:57 INFO - 'SHELL': '/bin/bash', 17:15:57 INFO - 'SHLVL': '1', 17:15:57 INFO - 'TERM': 'linux', 17:15:57 INFO - 'TMOUT': '86400', 17:15:57 INFO - 'USER': 'cltbld', 17:15:57 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453252003.933676-862171949', 17:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:57 INFO - '_': '/tools/buildbot/bin/python'} 17:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:58 INFO - Downloading/unpacking flake8 17:15:58 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 17:15:58 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 17:15:58 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 17:15:58 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 17:15:58 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 17:15:58 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 17:15:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:15:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 17:15:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:15:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 17:16:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 17:16:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:16:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:16:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:16:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:16:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:16:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:16:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:16:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:16:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:16:00 INFO - no previously-included directories found matching 'docs/_build' 17:16:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:16:00 INFO - Running setup.py install for pep8 17:16:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:16:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:16:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:16:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:16:00 INFO - no previously-included directories found matching 'docs/_build' 17:16:00 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:16:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:16:00 INFO - Cleaning up... 17:16:00 INFO - Return code: 0 17:16:00 INFO - Running post-action listener: _resource_record_post_action 17:16:00 INFO - Running post-action listener: _start_resource_monitoring 17:16:00 INFO - Starting resource monitoring. 17:16:00 INFO - ##### 17:16:00 INFO - ##### Running install step. 17:16:00 INFO - ##### 17:16:00 INFO - Running pre-action listener: _resource_record_pre_action 17:16:00 INFO - Running main action method: install 17:16:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:16:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:16:00 INFO - Reading from file tmpfile_stdout 17:16:00 INFO - Detecting whether we're running mozinstall >=1.0... 17:16:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:16:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:16:01 INFO - Reading from file tmpfile_stdout 17:16:01 INFO - Output received: 17:16:01 INFO - Usage: mozinstall [options] installer 17:16:01 INFO - Options: 17:16:01 INFO - -h, --help show this help message and exit 17:16:01 INFO - -d DEST, --destination=DEST 17:16:01 INFO - Directory to install application into. [default: 17:16:01 INFO - "/builds/slave/test-pgo"] 17:16:01 INFO - --app=APP Application being installed. [default: firefox] 17:16:01 INFO - mkdir: /builds/slave/test-pgo/build/application 17:16:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 17:16:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 17:16:17 INFO - Reading from file tmpfile_stdout 17:16:17 INFO - Output received: 17:16:17 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:16:17 INFO - Running post-action listener: _resource_record_post_action 17:16:17 INFO - ##### 17:16:17 INFO - ##### Running run-tests step. 17:16:17 INFO - ##### 17:16:17 INFO - Running pre-action listener: _resource_record_pre_action 17:16:17 INFO - Running main action method: run_tests 17:16:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:16:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:16:17 INFO - Python 2.7.3 17:16:17 INFO - Return code: 0 17:16:17 INFO - grabbing minidump binary from tooltool 17:16: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')]} 17:16:17 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 0x197a840>, '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 0x18e76b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e7b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:16:17 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 17:16:17 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 17:16:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:16:17 INFO - Return code: 0 17:16:17 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:16:17 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:16:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:16:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:16:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:16:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:16:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:16:18 INFO - Return code: 0 17:16:18 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/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.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 17:16:18 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/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.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 17:16:18 INFO - Using env: {'DISPLAY': ':0', 17:16:18 INFO - 'HOME': '/home/cltbld', 17:16:18 INFO - 'LANG': 'en_US.UTF-8', 17:16:18 INFO - 'LANGUAGE': 'en_US:en', 17:16:18 INFO - 'LOGNAME': 'cltbld', 17:16:18 INFO - 'MAIL': '/var/mail/cltbld', 17:16:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:16:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:16:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:18 INFO - 'MOZ_NO_REMOTE': '1', 17:16:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:16:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:18 INFO - 'NO_EM_RESTART': '1', 17:16:18 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:16:18 INFO - 'PWD': '/builds/slave/test-pgo', 17:16:18 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:16:18 INFO - 'SHELL': '/bin/bash', 17:16:18 INFO - 'SHLVL': '1', 17:16:18 INFO - 'TERM': 'linux', 17:16:18 INFO - 'TMOUT': '86400', 17:16:18 INFO - 'USER': 'cltbld', 17:16:18 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1453252003.933676-862171949', 17:16:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:18 INFO - '_': '/tools/buildbot/bin/python'} 17:16:18 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/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.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 17:16:18 INFO - mozversion application_buildid: 20160119143009 17:16:18 INFO - mozversion application_changeset: 48e077b052981e34081e4b8158678fee4f52e88c 17:16:18 INFO - mozversion application_display_name: Nightly 17:16:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:16:18 INFO - mozversion application_name: Firefox 17:16:18 INFO - mozversion application_remotingname: firefox 17:16:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:16:18 INFO - mozversion application_vendor: Mozilla 17:16:18 INFO - mozversion application_version: 46.0a1 17:16:18 INFO - mozversion platform_buildid: 20160119143009 17:16:18 INFO - mozversion platform_changeset: 48e077b052981e34081e4b8158678fee4f52e88c 17:16:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:16:18 INFO - mozversion platform_version: 46.0a1 17:16:18 INFO - using testdate: 1453252578 17:16:18 INFO - actual date: 1453252578 17:16:18 INFO - starting webserver on 'localhost:46225' 17:16:18 INFO - SUITE-START | Running 3 tests 17:16:18 INFO - TEST-START | dromaeo_css 17:16:18 INFO - operating with platform_type : linux_ 17:16:18 INFO - Initialising browser for dromaeo_css test... 17:16:18 INFO - TEST-INFO | started process 3678 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfIyPKb/profile http://localhost:46225/getInfo.html) 17:16:22 INFO - PROCESS | 3678 | __metrics Screen width/height:1600/1200 17:16:22 INFO - PROCESS | 3678 | colorDepth:24 17:16:22 INFO - PROCESS | 3678 | Browser inner width/height: 1024/697 17:16:22 INFO - PROCESS | 3678 | __metrics 17:16:22 INFO - PROCESS | 3678 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:16:22 INFO - PROCESS | 3678 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:16:23 INFO - TEST-INFO | 3678: exit 0 17:16:23 INFO - Browser initialized. 17:16:23 INFO - Running cycle 1/1 for dromaeo_css test... 17:16:23 INFO - TEST-INFO | started process 3768 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfIyPKb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:16:35 INFO - PROCESS | 3768 | RSS: Main: 149348352 17:16:35 INFO - PROCESS | 3768 | 17:17:27 INFO - PROCESS | 3768 | 1453252647259 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] 17:19:35 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:46225/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46225/tests/dromaeo/cssquery-ext.html) 17:19:36 INFO - PROCESS | 3768 | RSS: Main: 233111552 17:19:36 INFO - PROCESS | 3768 | 17:22:38 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:46225/tests/dromaeo/cssquery-ext.html (next: http://localhost:46225/tests/dromaeo/cssquery-jquery.html) 17:22:39 INFO - PROCESS | 3768 | RSS: Main: 222408704 17:22:39 INFO - PROCESS | 3768 | 17:25:41 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:46225/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46225/tests/dromaeo/cssquery-mootools.html) 17:25:42 INFO - PROCESS | 3768 | RSS: Main: 234340352 17:25:42 INFO - PROCESS | 3768 | 17:28:43 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:46225/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46225/tests/dromaeo/cssquery-prototype.html) 17:28:44 INFO - PROCESS | 3768 | RSS: Main: 213811200 17:28:44 INFO - PROCESS | 3768 | 17:31:47 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:46225/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46225/tests/dromaeo/cssquery-yui.html) 17:31:47 INFO - PROCESS | 3768 | RSS: Main: 215879680 17:31:47 INFO - PROCESS | 3768 | 17:34:50 INFO - PROCESS | 3768 | Cycle 1(1): loaded http://localhost:46225/tests/dromaeo/cssquery-yui.html (next: http://localhost:46225/tests/dromaeo/cssquery-dojo.html) 17:34:50 INFO - PROCESS | 3768 | RSS: Main: 292782080 17:34:50 INFO - PROCESS | 3768 | 17:34:50 INFO - PROCESS | 3768 | __start_tp_report 17:34:50 INFO - PROCESS | 3768 | _x_x_mozilla_page_load 17:34:50 INFO - PROCESS | 3768 | _x_x_mozilla_page_load_details 17:34:50 INFO - PROCESS | 3768 | |i|pagename|runs| 17:34:50 INFO - PROCESS | 3768 | |0;dojo.html;3153.795003324784;3174.142981395022;3222.258880457495;3224.484082546793;3250.1874531367166;5020.9246861297015;5112.514311140445;5187.818426355078;5213.47865213479;5236.764345604447;5163;5194.792208311673;5215.817446389377;5231.267622532849;5234.79060837567;4496.9550304497025;4615.515370886059;4703.318018887259;4777.06847164803;4809.326694262806;4635.327877457767;4706.482286948433;4712.646551508634;4730.787114579852;4851.151048566504;4654.8370807021765;4671.299305104228;4679.60223381013;4695.3661255730385;4731.787069581843;4693.48371679115;4708.905821883577;4732.43210814701;4743.525647435264;4783.856484305476;4621.376114224604;4689.226277664181;4752.881177970544;4759.595434388047;4796.688215265996;5022.121128802445;5082.79668813247;5094.668846525001;5104.387473503203;5117.667351622133;5516.91724624131;5532.474414930615;5536.031194540939;5539.584531160139;5591.07747221712;5451.48210919962;5508.394076651565;5541.362743284533;5563.054280772238;5574.777008919679;5169.095408303532;5181.974090129525;5184.377874655028;5189.065968125736;5230.476952304777;5626.127950167731;5627.127795191752;5628.155776633538;5630.8029218977135;5631.915521267184;5350.197470379474;5414.6209765316835;5415.972920135374;5426.9185962210595;5517.944820551743;5486.890262194734;5504.972475137599;5521.337439507204;5538.612297139242;5545.584081193927;5453.754581043783;5458.8908221835345;5465.754041068161;5467.644603100865;5482.342118945752;5412.648177868505;5443.020256353815;5478.506934375925;5518.724063796794;5534.695591742493;4322.265214913472;4363.345498175236;4367.410399596078;4386.956130438719;4404.405405270248;3839.040239940015;3863.2466668999277;3868.6711629511806;3875.833479010019;3898.8830335089992;4986.700797952062;5073.568746656501;5114.923276150861;5115.2071428928575;5159.148740457783;5486.204500347428;5521.972390138104;5547.472990065938;5548.944510554843;5588.441155884379;5088.287639730367;5101.515356041245;5111.948880511221;5114.43741188469;5157.716325602128;4581.610563102174;4637.281221410687;4691.272852707836;4746.976265118721;4748.406449193851;5739.794643124907;5762.654240745569;5780.88438231233;5794.130880367894;5796.246487956539;5578.581606379456;5587.497125258747;5588.497035266845;5590.972045139748;5593.440655934374;5556.416576259596;5649.604527683023;5664.37691853904;5732.05421105513;5773.509251713652;5470.288862447856;5476.835694929158;5478.178273259043;5482.39693633692;5485.040117979258;5479.043701186405;5518.089515230103;5528.861778455571;5537.2524709163745;5586.581006424616;5295.549878260391;5387.2727181831515;5425.294711687456;5436.864078398072;5544.972275138599;5385.40760516335;5393.056215162409;5399.136138217867;5399.433059528693;5402.297701298806;5188.584913206859;5278.656887302313;5281.102212623787;5288.81489147878;5312.282841816305;5370.03339398912;5378.892422151614;5467.20725494809;5514.062609356339;5517.420670829505;5278.287431196739;5282.656627319212;5286.207068939536;5287.233351164136;5290.312259406252 17:34:50 INFO - PROCESS | 3768 | |1;ext.html;511.9001794650044;523.6020624325514;533.6531254684454;537.2505355029737;561.87357844485;28772.712272877267;30064.84967575162;30777.23056923578;30786.69213307866;30878.228044298903;32725.509117363257;33043;33088.33823323532;33122.66877331226;33155.50266745995;8471.661133554666;8663.090375510576;8665.523396213206;8674.86987695185;8678.783030424227;8400.83198336033;8543.14568543147;8544.273736732384;8550.871736923951;8756.474611523328;8682.826343473127;8786.472811631322;8798.340124490656;8809.603567839431;8813.911860881406;8625.784355391133;8680.262177714902;8684.305255579538;8712.782180445476;8712.999999999969;8525.914740852637;8661.263792577638;8677.522736249504;8679.218870301704;8682.348823838238;36767.264654707025;37096;37097;37110.25779484395;37153.25693486115;2838.077624771937;2887.8556072196307;2964.110766769982;3054.941350282097;3148.988959186205;29502.262443439085;29720.40559188826;30095;30526.69473305261;31062;3865.7873816940055;3919.8040097994985;3968.86108986187;4020.557738648746;4084.9387259191135;252450;252737;252964;254011;254790.72604637043;51823.74088129535;53704.46295536995;58331.41668583345;58444.70777646085;58490.41509584935;48738;64389.678051609444;65618.34381656218;65620.73465224745;65663;12460.937695311466;12474.81287780684;12522.81215781764;12523.937380313222;12558;9431.245500359955;9719.076687714656;10079.647212347532;10132.594696212069;10149.188064954786;17302.913485432746;20364.490887727927;20863.791362086184;20928.895355523124;20943.47641308949;7597.240275972358;7828.334591559781;7888.14482889385;7892.447528672938;8125.75622731319;904.4799240436644;923.06309096266;942.6276620734772;943.4999450291357;967.6148294454064;28270.575941360898;28495.857520712678;29223.415531689247;29243.56134657982;29275.85362073176;949.8670186173941;995.9900400996042;1030.6341248856697;1050.469512895998;1059.3114475590928;13234.338283086;15302.540923772305;15677;15685.215739212994;15957;314788;321496;321574;321790;321940;51104.74447627738;51379;51425.228621570706;51480;51493.227601586004;1106.5131342209402;1117.6144230240716;1121.5345631562973;1126.2285334546027;1260.4076084240392;28460.288492787848;29273.414531708822;29426.85286573639;29601;29921.70078299189;45714.77142614266;45960;45965.310520341554;46036.53963460323;46050.769746151054;227115;227926;228160;299913;301352;28399;28567.317377332725;28991;31337.8433107833;31706.19525656936;32586;32648;32968.34063318768;33131;33191;30925;33937.32125357528;35151.47272790859;35264.823675882486;35497;35197.47203791894;36061.0984725384;36375.272494549434;36433;37462.8126859364;32889.50665739968;33249.16877077996;33290.833545832116;34766;35387.29225415426;28192;28520.42959140764;30370.392592148477;30414.239644009078;30501.694983049885;24550.877245613658;25195.370115747253;25351.353240438304;25358.873205633852;25774.87112564425 17:34:50 INFO - PROCESS | 3768 | |2;jquery.html;363.1900861079792;366.9156094098358;368.7621484142728;370.8498058286393;376.81347732872234;13734.45062197511;13840.723185536308;15605.765913511292;16621.252043658034;17457.912710436445;14109;14119.647008824759;14290;14483.637909052279;15019.624509387244;5292.735363231843;5488.780448782044;5493.093639549469;5497.257870187534;5497.945020549803;4002.5397079335958;4109.835606575733;5380.435054319299;5463.426340234278;5719.885602287973;5693.975084484791;5802;5844.678542680151;5845.941540584604;5853.297604287492;5840.06558950568;5941.465268125889;5955.047192449209;5957.523398128139;5961.628825370168;4977.925331120036;5105.489451054865;5137.511936366077;5255.632105752599;5257.526822585985;13055;13146.474141034347;17565.473035808947;20592.897035514725;20603.89698051515;1940.223910435837;1943.640426521098;1943.9416817495498;1967.527793329605;2020.05057622917;9092.8636070459;9223.815523689556;9294.163525282756;9541.761455963657;9553.331266811327;1758.3494107180297;1802.1980218802637;1822.9908850455795;1833.9449816505526;1885.5286178455385;53711;53941.46058539404;54460.72769636127;55033.516967498035;56573.717131414494;9814.214862810957;10103.09072183507;10174.4912754362;10232.488375581192;10268.127209187303;13521.32393380327;13576.321183940763;13681.452741890213;13683.24742139172;13703.657408564666;7142.071530700976;7170.96414517924;7214.350708436161;7252.818679532948;7339.926600734031;6754.797356079325;6803.48973826965;6873.381395674413;6927.480438967098;6938.5836849789175;4395.362672412546;4529.071540334224;4539.636829053734;4541.909161816745;4586.6789324747615;1713.820048894848;1737.8957262564033;1786.8213178682029;1805.4764118405515;1816.1282584359317;832.7626626411444;896.2426749396749;911.9133682300171;964.1611797735875;978.1490103609905;15699.136547489768;15993.36026558948;16984.660306793794;17379.78341516082;17636.559086022695;880.3441436130124;893.4683863101444;924.778053267211;943.7829299261208;971.3686104032295;9287.674931377369;9655.372400793925;9759.12167904892;9837.557309920927;9933.155681766986;544965;546466;555042;565664;567494;44631.330530042076;45802.77098614552;70425.2957470429;70763;74125.14687132757;1136.3409222650844;1142.2632402100764;1147.1109889835445;1156.2542160306723;1159.681087700889;15077.321520531821;15117.697646046798;15307.081575105529;15321.540353789404;15538.223088845738;33891.830540847135;33959.66040339565;34245.65754342425;34456.65543344535;35160;42918.78540607277;44581.331280031474;45041.54958450505;45430.68408501187;48071.75964120157;7236.746713864989;7278.96360518194;7326;7402.666879990521;7438.5536867788105;7552.845332497728;10343;10966.701451475306;10990.615328463466;11219.55121795119;9520.285978551776;9556.808863822824;9681.128698417177;9864.112229899343;10048.246381521269;9380.765480863032;9519.333646644669;9532.332736708364;9873.456959867277;9912.950435247778;9576.808463830825;9890.505474726378;9984.151347135576;10045.447500387549;10054.849177262493;7191.748288809867;7196.568205907663;7215.134183897966;7267.854642907218;7351;7943.682252709827;9939.900600993897;10050.547725352522;10185.796284074426;10321.587136514756 17:34:50 INFO - PROCESS | 3768 | |3;mootools.html;1382.2881216173666;1505.3526983397135;1508.057464084947;1696.8557672597829;1845.796962334144;6929.307069293068;7821.765347039591;7976.162502937195;7976.880346794803;7983.32141767949;7777.22227777222;7981;7981.201879812031;7982.600869956508;7983.960080199591;2059.2072052259837;2103.221807931068;2105.5788842231536;2374.6438034294865;2410.529946660402;2077.698733683615;2368.644703294511;2409.204962362416;2417.576924038295;2424.2969538833718;2300.4018955071633;2346.694929659142;2352.8588284702887;2359.9764002360016;2363.7990770784418;2298.7816157465013;2307.930762077132;2317.5017371265176;2320.9767902320928;2321.4080409495555;2314.4676724353494;2319.5360927814336;2319.7100362454694;2321.3500219938446;2332.976670233293;8046.758597242092;8121.553314567696;8123.5532045738055;8134.267915887599;8135.959320203361;4869;5010.774515146827;5033.345665063518;5033.723145227011;5037.118504261776;3113.1750086227166;3114.9221269468217;3210.036988903343;3220.372027454647;3234.757393195496;956.9569369378326;979.4661909259471;979.6179489998906;993.5876611206413;1003.2074661017787;11406.201565890391;11420.428978551123;11422;11430.657080287521;11432.542698292058;4520.977395113004;4545.977270113694;4588.839390621312;4624.375709279204;4631.143238500821;9546;9552.42685438876;9559.235261179088;9563.760905977406;9568.95215523918;4888.364512613338;4897.240927656219;4901.09329773993;4903.26451032348;4904.43598986114;4455.799489023002;4459.397981272552;4461.04087621163;4461.576150265784;4462.977685111554;3534.3638145134123;3601.3697602919383;3900.9804950975063;3968.6031396860085;4002.9799851000557;1235.9567415140427;1256.824044633752;1271.0467149637773;1277.6550331410467;1284.5953524639708;1280.7118398360294;1287.6394609509352;1298.1237664576374;1307.8822905938512;1336.4186578838237;7078.646067696594;7144.499885008104;7193.100862392201;7197.604131772698;7198.388137008308;1118.9216754827085;1124.1400328748514;1132.2866594045863;1139.7492551638627;1160.6750109969223;5450.345958484928;5535.418781028015;5538.446155384429;5542.778288868481;5550.555955523549;9737.853932190881;9855.950720246496;10013.599456021822;10131.696049118538;10140.239482038876;9917.305788594873;9980.750481238027;10008.599656013823;10018.74953126163;10030.849537256947;7318.817029574197;7511.474196806171;7515.549067055994;7559.1684914659345;7559.979402780664;7272.582562714908;7281.745138920112;7351.485396022441;7362.4478164136835;7370.557766534025;8812.60343284541;8852.778680532781;9019.32355073359;9033.50315732641;9047.276217902421;8601.784955376166;9153.63385464574;9218.400803947721;9258.675946341846;9270.119338662817;7318;7405.555666660018;7406.296401841816;7431;7434.702611895464;6595;6733.595984240961;7286.307800758919;7340.743073992385;7422.925770742223;7092.113485814273;7164.677589508589;7199.496035277481;7300.853982920205;7316.085489313836;6829.556078854858;6951.8609627806145;7084.504084714021;7191.460640451883;7223.638818059181;6880.31196880328;6928.16861976566;6941.618210998444;6942.201646810479;6948.270431604608;6275.058741188675;6293.181886354744;6301.96849015752;6327.3988971047675;6509.251436084911;6593.736250549924;6651.102101216467;6652.268250492539;6653.467722582085;6660.234073081464 17:34:50 INFO - PROCESS | 3768 | |4;prototype.html;336.17972147958994;339.11998364244783;341.1964822842207;341.6412766595076;350.6090708859621;5718.485336319731;5845.240118784557;5858.2677165354335;5883.646981181127;5903.055511118211;5627.859303517414;5777.624454410471;5784.623999440044;5807.651540907548;5815.883682326351;4528.230200865861;4558.72647641141;4576.885577860547;4589.35748995141;4593.150267200579;4356.063446359032;4447.310666846644;4450.532694067125;4535.886602834922;4568.200564901129;4477.194105061104;4512.435945506812;4517.570830771071;4535.410396648431;4537.931931021021;4516.593506584407;4525.072360166158;4526;4530.478994915594;4541;4010.979945100256;4012.057166565884;4013.7993100344866;4015.4779878615886;4020.597940205985;5520.66875987442;5608.635438696471;5633.183188437653;5674;5679.574031947621;5156.922646160273;5162.92255616166;5166.457521960216;5169.689818610896;5173.793048278064;5907.320658124328;6257.155284036688;6262.405071518244;6268.310485846553;6268.717907694165;4207.621314081747;4246.044639956016;4249.171411574714;4249.957500424987;4260.595243451867;6343.682815859189;6438.7102580384;6458.354164583504;6462.4183823456115;6466.870662586722;4369.825206991684;4389.714668546534;4391.363252328394;4396.868093957187;4398.120375924827;4336.674749393808;4431.578999994996;4435.334699795057;4446;4523.457185137804;5179.48205179479;5183.118869792144;5194.870128246824;5195.6622819516615;5199.7920083197005;6269.7178626961895;6282.340354262828;6315.5894866833505;6331.841703957438;6332.905006424908;1562.6718389138182;1587.8253392126858;1588.7458006718869;1590.19695053997;1591.037422359479;1049.380865289483;1050.0759331787979;1050.5010120193;1061.8407238914224;1079.2660990526517;5796.0436527972415;5807.564432667482;5808.912866307009;5810.4189581041555;5815.73829177688;6400.743970241138;6403.903941440882;6407.615543067431;6408.9745640697265;6421.775237866652;5876.1773351729935;5883.17635531026;5883.382244864228;5885.293764748172;5890.882182356415;3322.235885746292;3452.602950660706;3456.8962931112105;3459.550258466383;3472.0625431133453;6645.468362530986;6649.601023938482;6651.501137414616;6655.001749737481;6660;6525.249596296487;6531.640759758259;6534.346565343522;6539;6543.901841472381;6492.772752953624;6639.86720265592;6651.600903945779;6732.528722989442;6739.460843132636;6184.81445556634;6302.243730752339;6459.515536334699;6460.580062295936;6466.06242094903;6212.534059945612;6358.618482891041;6372.044193371032;6381.776637817654;6394.680265986589;6680.164979377578;6699.464042876656;6702.765403210864;6703.061571379913;6758.628275444898;4336.804843781974;4337.371081193146;4347.65218782503;4349.521552629271;4451.510333863337;6372.522060845363;6390.52071094679;6393.4885209184085;6432;6434;6238.750449982132;6255.593386429868;6257.311695713377;6270.028145637433;6310.7475700971445;6128.264608247039;6238.220222472191;6245.437910588069;6246.094316324198;6259.655718935503;6166.414190651881;6167.290761562478;6194.132821405097;6229.2524897012645;6229.56393052482;6350.206224221973;6355.5551111421755;6359.523035772429;6361.681915904093;6366.586171898812;6093.725782339717;6202.34875338083;6203.31763506005;6204.286507051746;6206.565540412128 17:34:50 INFO - PROCESS | 3768 | |5;yui.html;714.7712731925784;802.1817745899183;856.4005196362548;856.837200931823;868.9131086891311;13087.738245235114;13103.34483275836;13114.213147211174;13225.801612975813;13287.667808304797;10896.673099807018;10951.233413661046;11032.22774405792;11034.834477482824;11067.612633557826;654.4175683641563;673.124937581145;791.0586402181415;796.1401686178942;800.1638287989036;812.5327936436543;813.9023317201915;814.9307308878753;820.3191351178508;821.7822277096574;859.2824991132412;862.2024627219828;862.607513581319;862.779991102268;863.5768473447997;683.9794806155824;707.7770502291762;825.8843761873372;855.3670283989865;855.8587833007547;628.940250676185;629.9937000629981;632.8322994406486;634.0520921222756;637.1494055435999;12672.746545069047;12734.108612397136;12750.87249127506;12758.744825103538;12773.361331933365;11767.293962362286;12328.938355308255;12492;12573.057020723483;12646.367681615882;10166.390016599027;10191.439470829102;10231.948840255825;10388.676342786399;10563.154947604173;3544.6809787119023;3592.7844329340323;3652.2695460907926;3694.3350196964534;3730.235301763132;48566.757166214295;48635.51364486345;48870.75564622154;49000.754996224794;49505.50494495045;9979.251556133175;10053.79892402148;10293.125084367912;10315.1747860171;10318.484075796181;18783.530411739543;18817.059147042593;18825.34111306125;18849;18862.245510179713;7612;7751.496152750054;7844.333231675258;7879.724209652634;7919.485233459806;4136.8138433770555;4174.791260437027;4232.6190642841675;4287.549807270254;4298;3044.2693753499443;3087.768417368706;3095.8142511448937;3096.8296743679316;3100.255938574771;571.9227904232959;582.5572564850744;583.9620424672382;590.6515156057947;602.7950496831098;452.60623257765957;477.29122253453596;478.85394954538503;586.3257254157753;597.1311741416316;7974.242446967529;8464.068952415353;8575.785605359792;8625.137486251324;8667.783305417415;527.0513076462353;555.963862348946;561.0531455848201;659.983500412484;731.5574077682925;3679.264147170523;3695.8843545863456;3781.6596506314013;3783.5838057813617;4041.959580404217;58515;59447.40552594419;59492.405075948685;59679;59994;51604.22593661023;52107.2183917234;52234.21648675273;52322;52524;44934.32598511025;45991.54008459939;46517;48206;48414.27378589324;7667.808304792425;7684.500507466997;7707.383409327353;7732.922670773445;7744.380449564134;33317.666823331456;34148.65851341554;34155.14612134716;34497.65502344944;34920.82539587286;42535.57464425316;44200;46530.767346163055;46592.53407465882;47436.7628161857;9733.659321923698;9792.608295668379;10008.749781255527;10350.223733219887;10465.319754215952;11312.15158863105;11590.362530060927;11604.593839215588;11910.761784764429;11933.880661193623;10226.744331391776;10519.631812886511;10582.4708764563;11012.944935275273;11019.063379612822;9743.842315518368;10006.09945104915;10090.899091008996;10432.113270372103;10434.165266778487;9603.135717785433;10003.099721025143;10018.248631352824;10135.454676695734;10212.744681383025;7851.658843185697;7861.646225919733;8065.395095367753;8129.8374032520205;8146.633401496828;8513.574321283788;8569.785755355917;8627.085820137832;8791.604377802887;8800.515971621622 17:34:50 INFO - PROCESS | 3768 | __end_tp_report 17:34:50 INFO - PROCESS | 3768 | __start_cc_report 17:34:50 INFO - PROCESS | 3768 | _x_x_mozilla_cycle_collect,689 17:34:50 INFO - PROCESS | 3768 | __end_cc_report 17:34:50 INFO - PROCESS | 3768 | __startTimestamp1453253690600__endTimestamp 17:34:50 INFO - PROCESS | 3768 | 17:34:50 INFO - PROCESS | 3768 | ------- Summary: start ------- 17:34:50 INFO - PROCESS | 3768 | Number of tests: 6 17:34:50 INFO - PROCESS | 3768 | 17:34:50 INFO - PROCESS | 3768 | [#0] dojo.html Cycles:165 Average:5136.60 Median:5288.81 stddev:545.61 (10.3%) stddev-sans-first:524.65 17:34:50 INFO - PROCESS | 3768 | Values: 3153.8 3174.1 3222.3 3224.5 3250.2 5020.9 5112.5 5187.8 5213.5 5236.8 5163.0 5194.8 5215.8 5231.3 5234.8 4497.0 4615.5 4703.3 4777.1 4809.3 4635.3 4706.5 4712.6 4730.8 4851.2 4654.8 4671.3 4679.6 4695.4 4731.8 4693.5 4708.9 4732.4 4743.5 4783.9 4621.4 4689.2 4752.9 4759.6 4796.7 5022.1 5082.8 5094.7 5104.4 5117.7 5516.9 5532.5 5536.0 5539.6 5591.1 5451.5 5508.4 5541.4 5563.1 5574.8 5169.1 5182.0 5184.4 5189.1 5230.5 5626.1 5627.1 5628.2 5630.8 5631.9 5350.2 5414.6 5416.0 5426.9 5517.9 5486.9 5505.0 5521.3 5538.6 5545.6 5453.8 5458.9 5465.8 5467.6 5482.3 5412.6 5443.0 5478.5 5518.7 5534.7 4322.3 4363.3 4367.4 4387.0 4404.4 3839.0 3863.2 3868.7 3875.8 3898.9 4986.7 5073.6 5114.9 5115.2 5159.1 5486.2 5522.0 5547.5 5548.9 5588.4 5088.3 5101.5 5111.9 5114.4 5157.7 4581.6 4637.3 4691.3 4747.0 4748.4 5739.8 5762.7 5780.9 5794.1 5796.2 5578.6 5587.5 5588.5 5591.0 5593.4 5556.4 5649.6 5664.4 5732.1 5773.5 5470.3 5476.8 5478.2 5482.4 5485.0 5479.0 5518.1 5528.9 5537.3 5586.6 5295.5 5387.3 5425.3 5436.9 5545.0 5385.4 5393.1 5399.1 5399.4 5402.3 5188.6 5278.7 5281.1 5288.8 5312.3 5370.0 5378.9 5467.2 5514.1 5517.4 5278.3 5282.7 5286.2 5287.2 5290.3 17:34:50 INFO - PROCESS | 3768 | 17:34:50 INFO - PROCESS | 3768 | [#1] ext.html Cycles:180 Average:43782.62 Median:33143.25 stddev:73109.44 (220.6%) stddev-sans-first:73242.34 17:34:50 INFO - PROCESS | 3768 | Values: 511.9 523.6 533.7 537.3 561.9 28772.7 30064.8 30777.2 30786.7 30878.2 32725.5 33043.0 33088.3 33122.7 33155.5 8471.7 8663.1 8665.5 8674.9 8678.8 8400.8 8543.1 8544.3 8550.9 8756.5 8682.8 8786.5 8798.3 8809.6 8813.9 8625.8 8680.3 8684.3 8712.8 8713.0 8525.9 8661.3 8677.5 8679.2 8682.3 36767.3 37096.0 37097.0 37110.3 37153.3 2838.1 2887.9 2964.1 3054.9 3149.0 29502.3 29720.4 30095.0 30526.7 31062.0 3865.8 3919.8 3968.9 4020.6 4084.9 252450.0 252737.0 252964.0 254011.0 254790.7 51823.7 53704.5 58331.4 58444.7 58490.4 48738.0 64389.7 65618.3 65620.7 65663.0 12460.9 12474.8 12522.8 12523.9 12558.0 9431.2 9719.1 10079.6 10132.6 10149.2 17302.9 20364.5 20863.8 20928.9 20943.5 7597.2 7828.3 7888.1 7892.4 8125.8 904.5 923.1 942.6 943.5 967.6 28270.6 28495.9 29223.4 29243.6 29275.9 949.9 996.0 1030.6 1050.5 1059.3 13234.3 15302.5 15677.0 15685.2 15957.0 314788.0 321496.0 321574.0 321790.0 321940.0 51104.7 51379.0 51425.2 51480.0 51493.2 1106.5 1117.6 1121.5 1126.2 1260.4 28460.3 29273.4 29426.9 29601.0 29921.7 45714.8 45960.0 45965.3 46036.5 46050.8 227115.0 227926.0 228160.0 299913.0 301352.0 28399.0 28567.3 28991.0 31337.8 31706.2 32586.0 32648.0 32968.3 33131.0 33191.0 30925.0 33937.3 35151.5 35264.8 35497.0 35197.5 36061.1 36375.3 36433.0 37462.8 32889.5 33249.2 33290.8 34766.0 35387.3 28192.0 28520.4 30370.4 30414.2 30501.7 24550.9 25195.4 25351.4 25358.9 25774.9 17:34:50 INFO - PROCESS | 3768 | 17:34:50 INFO - PROCESS | 3768 | [#2] jquery.html Cycles:180 Average:27543.92 Median:5196.57 stddev:90709.95 (1745.6%) stddev-sans-first:90941.45 17:34:50 INFO - PROCESS | 3768 | Values: 363.2 366.9 368.8 370.8 376.8 13734.5 13840.7 15605.8 16621.3 17457.9 14109.0 14119.6 14290.0 14483.6 15019.6 5292.7 5488.8 5493.1 5497.3 5497.9 4002.5 4109.8 5380.4 5463.4 5719.9 5694.0 5802.0 5844.7 5845.9 5853.3 5840.1 5941.5 5955.0 5957.5 5961.6 4977.9 5105.5 5137.5 5255.6 5257.5 13055.0 13146.5 17565.5 20592.9 20603.9 1940.2 1943.6 1943.9 1967.5 2020.1 9092.9 9223.8 9294.2 9541.8 9553.3 1758.3 1802.2 1823.0 1833.9 1885.5 53711.0 53941.5 54460.7 55033.5 56573.7 9814.2 10103.1 10174.5 10232.5 10268.1 13521.3 13576.3 13681.5 13683.2 13703.7 7142.1 7171.0 7214.4 7252.8 7339.9 6754.8 6803.5 6873.4 6927.5 6938.6 4395.4 4529.1 4539.6 4541.9 4586.7 1713.8 1737.9 1786.8 1805.5 1816.1 832.8 896.2 911.9 964.2 978.1 15699.1 15993.4 16984.7 17379.8 17636.6 880.3 893.5 924.8 943.8 971.4 9287.7 9655.4 9759.1 9837.6 9933.2 544965.0 546466.0 555042.0 565664.0 567494.0 44631.3 45802.8 70425.3 70763.0 74125.1 1136.3 1142.3 1147.1 1156.3 1159.7 15077.3 15117.7 15307.1 15321.5 15538.2 33891.8 33959.7 34245.7 34456.7 35160.0 42918.8 44581.3 45041.5 45430.7 48071.8 7236.7 7279.0 7326.0 7402.7 7438.6 7552.8 10343.0 10966.7 10990.6 11219.6 9520.3 9556.8 9681.1 9864.1 10048.2 9380.8 9519.3 9532.3 9873.5 9913.0 9576.8 9890.5 9984.2 10045.4 10054.8 7191.7 7196.6 7215.1 7267.9 7351.0 7943.7 9939.9 10050.5 10185.8 10321.6 17:34:50 INFO - PROCESS | 3768 | 17:34:50 INFO - PROCESS | 3768 | [#3] mootools.html Cycles:180 Average:5629.92 Median:5546.67 stddev:2952.66 (53.2%) stddev-sans-first:2943.68 17:34:50 INFO - PROCESS | 3768 | Values: 1382.3 1505.4 1508.1 1696.9 1845.8 6929.3 7821.8 7976.2 7976.9 7983.3 7777.2 7981.0 7981.2 7982.6 7984.0 2059.2 2103.2 2105.6 2374.6 2410.5 2077.7 2368.6 2409.2 2417.6 2424.3 2300.4 2346.7 2352.9 2360.0 2363.8 2298.8 2307.9 2317.5 2321.0 2321.4 2314.5 2319.5 2319.7 2321.4 2333.0 8046.8 8121.6 8123.6 8134.3 8136.0 4869.0 5010.8 5033.3 5033.7 5037.1 3113.2 3114.9 3210.0 3220.4 3234.8 957.0 979.5 979.6 993.6 1003.2 11406.2 11420.4 11422.0 11430.7 11432.5 4521.0 4546.0 4588.8 4624.4 4631.1 9546.0 9552.4 9559.2 9563.8 9569.0 4888.4 4897.2 4901.1 4903.3 4904.4 4455.8 4459.4 4461.0 4461.6 4463.0 3534.4 3601.4 3901.0 3968.6 4003.0 1236.0 1256.8 1271.0 1277.7 1284.6 1280.7 1287.6 1298.1 1307.9 1336.4 7078.6 7144.5 7193.1 7197.6 7198.4 1118.9 1124.1 1132.3 1139.7 1160.7 5450.3 5535.4 5538.4 5542.8 5550.6 9737.9 9856.0 10013.6 10131.7 10140.2 9917.3 9980.8 10008.6 10018.7 10030.8 7318.8 7511.5 7515.5 7559.2 7560.0 7272.6 7281.7 7351.5 7362.4 7370.6 8812.6 8852.8 9019.3 9033.5 9047.3 8601.8 9153.6 9218.4 9258.7 9270.1 7318.0 7405.6 7406.3 7431.0 7434.7 6595.0 6733.6 7286.3 7340.7 7422.9 7092.1 7164.7 7199.5 7300.9 7316.1 6829.6 6951.9 7084.5 7191.5 7223.6 6880.3 6928.2 6941.6 6942.2 6948.3 6275.1 6293.2 6302.0 6327.4 6509.3 6593.7 6651.1 6652.3 6653.5 6660.2 17:34:50 INFO - PROCESS | 3768 | 17:34:50 INFO - PROCESS | 3768 | [#4] prototype.html Cycles:180 Average:5207.31 Median:5830.56 stddev:1567.71 (26.9%) stddev-sans-first:1528.88 17:34:50 INFO - PROCESS | 3768 | Values: 336.2 339.1 341.2 341.6 350.6 5718.5 5845.2 5858.3 5883.6 5903.1 5627.9 5777.6 5784.6 5807.7 5815.9 4528.2 4558.7 4576.9 4589.4 4593.2 4356.1 4447.3 4450.5 4535.9 4568.2 4477.2 4512.4 4517.6 4535.4 4537.9 4516.6 4525.1 4526.0 4530.5 4541.0 4011.0 4012.1 4013.8 4015.5 4020.6 5520.7 5608.6 5633.2 5674.0 5679.6 5156.9 5162.9 5166.5 5169.7 5173.8 5907.3 6257.2 6262.4 6268.3 6268.7 4207.6 4246.0 4249.2 4250.0 4260.6 6343.7 6438.7 6458.4 6462.4 6466.9 4369.8 4389.7 4391.4 4396.9 4398.1 4336.7 4431.6 4435.3 4446.0 4523.5 5179.5 5183.1 5194.9 5195.7 5199.8 6269.7 6282.3 6315.6 6331.8 6332.9 1562.7 1587.8 1588.7 1590.2 1591.0 1049.4 1050.1 1050.5 1061.8 1079.3 5796.0 5807.6 5808.9 5810.4 5815.7 6400.7 6403.9 6407.6 6409.0 6421.8 5876.2 5883.2 5883.4 5885.3 5890.9 3322.2 3452.6 3456.9 3459.6 3472.1 6645.5 6649.6 6651.5 6655.0 6660.0 6525.2 6531.6 6534.3 6539.0 6543.9 6492.8 6639.9 6651.6 6732.5 6739.5 6184.8 6302.2 6459.5 6460.6 6466.1 6212.5 6358.6 6372.0 6381.8 6394.7 6680.2 6699.5 6702.8 6703.1 6758.6 4336.8 4337.4 4347.7 4349.5 4451.5 6372.5 6390.5 6393.5 6432.0 6434.0 6238.8 6255.6 6257.3 6270.0 6310.7 6128.3 6238.2 6245.4 6246.1 6259.7 6166.4 6167.3 6194.1 6229.3 6229.6 6350.2 6355.6 6359.5 6361.7 6366.6 6093.7 6202.3 6203.3 6204.3 6206.6 17:34:50 INFO - PROCESS | 3768 | 17:34:50 INFO - PROCESS | 3768 | [#5] yui.html Cycles:180 Average:13607.76 Median:24342.43 stddev:16317.32 (67.0%) stddev-sans-first:16334.37 17:34:50 INFO - PROCESS | 3768 | Values: 714.8 802.2 856.4 856.8 868.9 13087.7 13103.3 13114.2 13225.8 13287.7 10896.7 10951.2 11032.2 11034.8 11067.6 654.4 673.1 791.1 796.1 800.2 812.5 813.9 814.9 820.3 821.8 859.3 862.2 862.6 862.8 863.6 684.0 707.8 825.9 855.4 855.9 628.9 630.0 632.8 634.1 637.1 12672.7 12734.1 12750.9 12758.7 12773.4 11767.3 12328.9 12492.0 12573.1 12646.4 10166.4 10191.4 10231.9 10388.7 10563.2 3544.7 3592.8 3652.3 3694.3 3730.2 48566.8 48635.5 48870.8 49000.8 49505.5 9979.3 10053.8 10293.1 10315.2 10318.5 18783.5 18817.1 18825.3 18849.0 18862.2 7612.0 7751.5 7844.3 7879.7 7919.5 4136.8 4174.8 4232.6 4287.5 4298.0 3044.3 3087.8 3095.8 3096.8 3100.3 571.9 582.6 584.0 590.7 602.8 452.6 477.3 478.9 586.3 597.1 7974.2 8464.1 8575.8 8625.1 8667.8 527.1 556.0 561.1 660.0 731.6 3679.3 3695.9 3781.7 3783.6 4042.0 58515.0 59447.4 59492.4 59679.0 59994.0 51604.2 52107.2 52234.2 52322.0 52524.0 44934.3 45991.5 46517.0 48206.0 48414.3 7667.8 7684.5 7707.4 7732.9 7744.4 33317.7 34148.7 34155.1 34497.7 34920.8 42535.6 44200.0 46530.8 46592.5 47436.8 9733.7 9792.6 10008.7 10350.2 10465.3 11312.2 11590.4 11604.6 11910.8 11933.9 10226.7 10519.6 10582.5 11012.9 11019.1 9743.8 10006.1 10090.9 10432.1 10434.2 9603.1 10003.1 10018.2 10135.5 10212.7 7851.7 7861.6 8065.4 8129.8 8146.6 8513.6 8569.8 8627.1 8791.6 8800.5 17:34:50 INFO - PROCESS | 3768 | -------- Summary: end -------- 17:34:50 INFO - PROCESS | 3768 | 17:34:51 INFO - TEST-INFO | 3768: exit 0 17:34:51 INFO - TEST-OK | dromaeo_css | took 1112916ms 17:34:51 INFO - TEST-START | kraken 17:34:51 INFO - operating with platform_type : linux_ 17:34:51 INFO - Initialising browser for kraken test... 17:34:51 INFO - TEST-INFO | started process 3971 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkLkuds/profile http://localhost:46225/getInfo.html) 17:34:55 INFO - PROCESS | 3971 | __metrics Screen width/height:1600/1200 17:34:55 INFO - PROCESS | 3971 | colorDepth:24 17:34:55 INFO - PROCESS | 3971 | Browser inner width/height: 1024/697 17:34:55 INFO - PROCESS | 3971 | __metrics 17:34:56 INFO - PROCESS | 3971 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:34:56 INFO - PROCESS | 3971 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:34:56 INFO - TEST-INFO | 3971: exit 0 17:34:56 INFO - Browser initialized. 17:34:56 INFO - Running cycle 1/1 for kraken test... 17:34:56 INFO - TEST-INFO | started process 4054 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkLkuds/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:35:08 INFO - PROCESS | 4054 | RSS: Main: 149553152 17:35:08 INFO - PROCESS | 4054 | 17:35:11 INFO - PROCESS | 4054 | Cycle 1(1): loaded http://localhost:46225/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46225/tests/kraken/driver.html?testName=audio-beat-detection) 17:35:11 INFO - PROCESS | 4054 | RSS: Main: 187998208 17:35:11 INFO - PROCESS | 4054 | 17:35:14 INFO - PROCESS | 4054 | Cycle 1(1): loaded http://localhost:46225/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46225/tests/kraken/driver.html?testName=audio-dft) 17:35:14 INFO - PROCESS | 4054 | RSS: Main: 176599040 17:35:14 INFO - PROCESS | 4054 | 17:35:17 INFO - PROCESS | 4054 | Cycle 1(1): loaded http://localhost:46225/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46225/tests/kraken/driver.html?testName=audio-fft) 17:35:18 INFO - PROCESS | 4054 | RSS: Main: 164077568 17:35:18 INFO - PROCESS | 4054 | 17:35:20 INFO - PROCESS | 4054 | Cycle 1(1): loaded http://localhost:46225/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46225/tests/kraken/driver.html?testName=audio-oscillator) 17:35:20 INFO - PROCESS | 4054 | RSS: Main: 166256640 17:35:20 INFO - PROCESS | 4054 | 17:35:23 INFO - PROCESS | 4054 | Cycle 1(1): loaded http://localhost:46225/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46225/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:35:23 INFO - PROCESS | 4054 | RSS: Main: 164925440 17:35:23 INFO - PROCESS | 4054 | 17:35:26 INFO - PROCESS | 4054 | Cycle 1(1): loaded http://localhost:46225/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46225/tests/kraken/driver.html?testName=imaging-darkroom) 17:35:27 INFO - PROCESS | 4054 | RSS: Main: 164651008 17:35:27 INFO - PROCESS | 4054 | 17:35:30 INFO - PROCESS | 4054 | Cycle 1(1): loaded http://localhost:46225/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46225/tests/kraken/driver.html?testName=imaging-desaturate) 17:35:31 INFO - PROCESS | 4054 | RSS: Main: 165691392 17:35:31 INFO - PROCESS | 4054 | 17:35:33 INFO - PROCESS | 4054 | Cycle 1(1): loaded http://localhost:46225/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46225/tests/kraken/driver.html?testName=json-parse-financial) 17:35:34 INFO - PROCESS | 4054 | RSS: Main: 164773888 17:35:34 INFO - PROCESS | 4054 | 17:35:35 INFO - PROCESS | 4054 | Cycle 1(1): loaded http://localhost:46225/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46225/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:35:36 INFO - PROCESS | 4054 | RSS: Main: 180953088 17:35:36 INFO - PROCESS | 4054 | 17:35:38 INFO - PROCESS | 4054 | Cycle 1(1): loaded http://localhost:46225/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46225/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:35:38 INFO - PROCESS | 4054 | RSS: Main: 178118656 17:35:38 INFO - PROCESS | 4054 | 17:35:41 INFO - PROCESS | 4054 | Cycle 1(1): loaded http://localhost:46225/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46225/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:35:41 INFO - PROCESS | 4054 | RSS: Main: 187691008 17:35:41 INFO - PROCESS | 4054 | 17:35:43 INFO - PROCESS | 4054 | Cycle 1(1): loaded http://localhost:46225/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46225/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:35:44 INFO - PROCESS | 4054 | RSS: Main: 196427776 17:35:44 INFO - PROCESS | 4054 | 17:35:47 INFO - PROCESS | 4054 | Cycle 1(1): loaded http://localhost:46225/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46225/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:35:47 INFO - PROCESS | 4054 | RSS: Main: 192528384 17:35:47 INFO - PROCESS | 4054 | 17:35:49 INFO - PROCESS | 4054 | Cycle 1(1): loaded http://localhost:46225/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46225/tests/kraken/driver.html?testName=ai-astar) 17:35:49 INFO - PROCESS | 4054 | RSS: Main: 251764736 17:35:49 INFO - PROCESS | 4054 | 17:35:49 INFO - PROCESS | 4054 | __start_tp_report 17:35:49 INFO - PROCESS | 4054 | _x_x_mozilla_page_load 17:35:49 INFO - PROCESS | 4054 | _x_x_mozilla_page_load_details 17:35:49 INFO - PROCESS | 4054 | |i|pagename|runs| 17:35:49 INFO - PROCESS | 4054 | |0;ai-astar;113;112;107;110;110;110;110;111;103;109 17:35:49 INFO - PROCESS | 4054 | |1;audio-beat-detection;149;131;154;165;127;146;154;125;168;126 17:35:49 INFO - PROCESS | 4054 | |2;audio-dft;160;161;159;160;162;161;158;162;162;162 17:35:49 INFO - PROCESS | 4054 | |3;audio-fft;96;74;73;148;73;73;75;73;153;73 17:35:49 INFO - PROCESS | 4054 | |4;audio-oscillator;97;97;154;96;96;96;151;96;96;136 17:35:49 INFO - PROCESS | 4054 | |5;imaging-gaussian-blur;109;109;109;110;109;110;109;110;110;109 17:35:49 INFO - PROCESS | 4054 | |6;imaging-darkroom;145;145;145;145;145;146;145;145;146;144 17:35:49 INFO - PROCESS | 4054 | |7;imaging-desaturate;96;96;95;96;96;96;96;96;96;96 17:35:49 INFO - PROCESS | 4054 | |8;json-parse-financial;57;54;54;56;54;55;55;55;60;52 17:35:49 INFO - PROCESS | 4054 | |9;json-stringify-tinderbox;66;68;67;67;67;72;67;67;67;68 17:35:49 INFO - PROCESS | 4054 | |10;stanford-crypto-aes;83;82;81;82;83;82;81;82;89;90 17:35:49 INFO - PROCESS | 4054 | |11;stanford-crypto-ccm;117;115;123;114;119;114;115;118;114;122 17:35:49 INFO - PROCESS | 4054 | |12;stanford-crypto-pbkdf2;145;148;141;142;142;130;144;135;147;141 17:35:49 INFO - PROCESS | 4054 | |13;stanford-crypto-sha256-iterative;68;66;64;68;66;64;67;67;66;65 17:35:49 INFO - PROCESS | 4054 | __end_tp_report 17:35:49 INFO - PROCESS | 4054 | __start_cc_report 17:35:49 INFO - PROCESS | 4054 | _x_x_mozilla_cycle_collect,927 17:35:49 INFO - PROCESS | 4054 | __end_cc_report 17:35:49 INFO - PROCESS | 4054 | __startTimestamp1453253749532__endTimestamp 17:35:49 INFO - PROCESS | 4054 | 17:35:49 INFO - PROCESS | 4054 | ------- Summary: start ------- 17:35:49 INFO - PROCESS | 4054 | Number of tests: 14 17:35:49 INFO - PROCESS | 4054 | 17:35:49 INFO - PROCESS | 4054 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:2.80 (2.5%) stddev-sans-first:2.67 17:35:49 INFO - PROCESS | 4054 | Values: 113.0 112.0 107.0 110.0 110.0 110.0 110.0 111.0 103.0 109.0 17:35:49 INFO - PROCESS | 4054 | 17:35:49 INFO - PROCESS | 4054 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:151.50 stddev:16.28 (10.7%) stddev-sans-first:17.19 17:35:49 INFO - PROCESS | 4054 | Values: 149.0 131.0 154.0 165.0 127.0 146.0 154.0 125.0 168.0 126.0 17:35:49 INFO - PROCESS | 4054 | 17:35:49 INFO - PROCESS | 4054 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.50 stddev:1.42 (0.9%) stddev-sans-first:1.48 17:35:49 INFO - PROCESS | 4054 | Values: 160.0 161.0 159.0 160.0 162.0 161.0 158.0 162.0 162.0 162.0 17:35:49 INFO - PROCESS | 4054 | 17:35:49 INFO - PROCESS | 4054 | [#3] audio-fft Cycles:10 Average:91.10 Median:73.00 stddev:32.12 (44.0%) stddev-sans-first:34.02 17:35:49 INFO - PROCESS | 4054 | Values: 96.0 74.0 73.0 148.0 73.0 73.0 75.0 73.0 153.0 73.0 17:35:49 INFO - PROCESS | 4054 | 17:35:49 INFO - PROCESS | 4054 | [#4] audio-oscillator Cycles:10 Average:111.50 Median:96.00 stddev:24.92 (26.0%) stddev-sans-first:25.87 17:35:49 INFO - PROCESS | 4054 | Values: 97.0 97.0 154.0 96.0 96.0 96.0 151.0 96.0 96.0 136.0 17:35:49 INFO - PROCESS | 4054 | 17:35:49 INFO - PROCESS | 4054 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:35:49 INFO - PROCESS | 4054 | Values: 109.0 109.0 109.0 110.0 109.0 110.0 109.0 110.0 110.0 109.0 17:35:49 INFO - PROCESS | 4054 | 17:35:49 INFO - PROCESS | 4054 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 17:35:49 INFO - PROCESS | 4054 | Values: 145.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 146.0 144.0 17:35:49 INFO - PROCESS | 4054 | 17:35:49 INFO - PROCESS | 4054 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:35:49 INFO - PROCESS | 4054 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 17:35:49 INFO - PROCESS | 4054 | 17:35:49 INFO - PROCESS | 4054 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:2.15 (3.9%) stddev-sans-first:2.18 17:35:49 INFO - PROCESS | 4054 | Values: 57.0 54.0 54.0 56.0 54.0 55.0 55.0 55.0 60.0 52.0 17:35:49 INFO - PROCESS | 4054 | 17:35:49 INFO - PROCESS | 4054 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:67.00 stddev:1.65 (2.5%) stddev-sans-first:1.64 17:35:49 INFO - PROCESS | 4054 | Values: 66.0 68.0 67.0 67.0 67.0 72.0 67.0 67.0 67.0 68.0 17:35:49 INFO - PROCESS | 4054 | 17:35:49 INFO - PROCESS | 4054 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:82.50 stddev:3.24 (3.9%) stddev-sans-first:3.43 17:35:49 INFO - PROCESS | 4054 | Values: 83.0 82.0 81.0 82.0 83.0 82.0 81.0 82.0 89.0 90.0 17:35:49 INFO - PROCESS | 4054 | 17:35:49 INFO - PROCESS | 4054 | [#11] stanford-crypto-ccm Cycles:10 Average:117.10 Median:117.50 stddev:3.35 (2.8%) stddev-sans-first:3.55 17:35:49 INFO - PROCESS | 4054 | Values: 117.0 115.0 123.0 114.0 119.0 114.0 115.0 118.0 114.0 122.0 17:35:49 INFO - PROCESS | 4054 | 17:35:49 INFO - PROCESS | 4054 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.50 Median:143.00 stddev:5.44 (3.8%) stddev-sans-first:5.62 17:35:49 INFO - PROCESS | 4054 | Values: 145.0 148.0 141.0 142.0 142.0 130.0 144.0 135.0 147.0 141.0 17:35:49 INFO - PROCESS | 4054 | 17:35:49 INFO - PROCESS | 4054 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:1.45 (2.2%) stddev-sans-first:1.36 17:35:49 INFO - PROCESS | 4054 | Values: 68.0 66.0 64.0 68.0 66.0 64.0 67.0 67.0 66.0 65.0 17:35:49 INFO - PROCESS | 4054 | -------- Summary: end -------- 17:35:49 INFO - PROCESS | 4054 | 17:35:50 INFO - TEST-INFO | 4054: exit 0 17:35:50 INFO - TEST-OK | kraken | took 59277ms 17:35:50 INFO - TEST-START | v8_7 17:35:50 INFO - operating with platform_type : linux_ 17:35:50 INFO - Initialising browser for v8_7 test... 17:35:50 INFO - TEST-INFO | started process 4301 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpItyTlG/profile http://localhost:46225/getInfo.html) 17:35:54 INFO - PROCESS | 4301 | __metrics Screen width/height:1600/1200 17:35:54 INFO - PROCESS | 4301 | colorDepth:24 17:35:54 INFO - PROCESS | 4301 | Browser inner width/height: 1024/697 17:35:54 INFO - PROCESS | 4301 | __metrics 17:35:54 INFO - PROCESS | 4301 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:35:54 INFO - PROCESS | 4301 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:35:55 INFO - TEST-INFO | 4301: exit 0 17:35:55 INFO - Browser initialized. 17:35:55 INFO - Running cycle 1/1 for v8_7 test... 17:35:55 INFO - TEST-INFO | started process 4384 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpItyTlG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:36:07 INFO - PROCESS | 4384 | RSS: Main: 148770816 17:36:07 INFO - PROCESS | 4384 | 17:36:30 INFO - PROCESS | 4384 | Cycle 1(1): loaded http://localhost:46225/tests/v8_7/run.html (next: http://localhost:46225/tests/v8_7/run.html) 17:36:30 INFO - PROCESS | 4384 | RSS: Main: 588677120 17:36:30 INFO - PROCESS | 4384 | 17:36:30 INFO - PROCESS | 4384 | __start_tp_report 17:36:30 INFO - PROCESS | 4384 | _x_x_mozilla_page_load 17:36:30 INFO - PROCESS | 4384 | _x_x_mozilla_page_load_details 17:36:30 INFO - PROCESS | 4384 | |i|pagename|runs| 17:36:30 INFO - PROCESS | 4384 | |0;Richards;170.2127659574468 17:36:30 INFO - PROCESS | 4384 | |1;DeltaBlue;188.71485185884129 17:36:30 INFO - PROCESS | 4384 | |2;Encrypt;279.9552071668533 17:36:30 INFO - PROCESS | 4384 | |3;Decrypt;5268.421052631579 17:36:30 INFO - PROCESS | 4384 | |4;RayTrace;1939.922480620155 17:36:30 INFO - PROCESS | 4384 | |5;Earley;788.6435331230284 17:36:30 INFO - PROCESS | 4384 | |6;Boyer;12345.67901234568 17:36:30 INFO - PROCESS | 4384 | |7;RegExp;41755.102040816324 17:36:30 INFO - PROCESS | 4384 | |8;Splay;629.7229219143577 17:36:30 INFO - PROCESS | 4384 | |9;NavierStokes;4822.115384615385 17:36:30 INFO - PROCESS | 4384 | __end_tp_report 17:36:30 INFO - PROCESS | 4384 | __startTimestamp1453253790497__endTimestamp 17:36:30 INFO - PROCESS | 4384 | 17:36:30 INFO - PROCESS | 4384 | ------- Summary: start ------- 17:36:30 INFO - PROCESS | 4384 | Number of tests: 10 17:36:30 INFO - PROCESS | 4384 | 17:36:30 INFO - PROCESS | 4384 | [#0] Richards Cycles:1 Average:170.21 Median:170.21 stddev:0.00 (0.0%) 17:36:30 INFO - PROCESS | 4384 | Values: 170.2 17:36:30 INFO - PROCESS | 4384 | 17:36:30 INFO - PROCESS | 4384 | [#1] DeltaBlue Cycles:1 Average:188.71 Median:188.71 stddev:0.00 (0.0%) 17:36:30 INFO - PROCESS | 4384 | Values: 188.7 17:36:30 INFO - PROCESS | 4384 | 17:36:30 INFO - PROCESS | 4384 | [#2] Encrypt Cycles:1 Average:279.96 Median:279.96 stddev:0.00 (0.0%) 17:36:30 INFO - PROCESS | 4384 | Values: 280.0 17:36:30 INFO - PROCESS | 4384 | 17:36:30 INFO - PROCESS | 4384 | [#3] Decrypt Cycles:1 Average:5268.42 Median:5268.42 stddev:0.00 (0.0%) 17:36:30 INFO - PROCESS | 4384 | Values: 5268.4 17:36:30 INFO - PROCESS | 4384 | 17:36:30 INFO - PROCESS | 4384 | [#4] RayTrace Cycles:1 Average:1939.92 Median:1939.92 stddev:0.00 (0.0%) 17:36:30 INFO - PROCESS | 4384 | Values: 1939.9 17:36:30 INFO - PROCESS | 4384 | 17:36:30 INFO - PROCESS | 4384 | [#5] Earley Cycles:1 Average:788.64 Median:788.64 stddev:0.00 (0.0%) 17:36:30 INFO - PROCESS | 4384 | Values: 788.6 17:36:30 INFO - PROCESS | 4384 | 17:36:30 INFO - PROCESS | 4384 | [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 17:36:30 INFO - PROCESS | 4384 | Values: 12345.7 17:36:30 INFO - PROCESS | 4384 | 17:36:30 INFO - PROCESS | 4384 | [#7] RegExp Cycles:1 Average:41755.10 Median:41755.10 stddev:0.00 (0.0%) 17:36:30 INFO - PROCESS | 4384 | Values: 41755.1 17:36:30 INFO - PROCESS | 4384 | 17:36:30 INFO - PROCESS | 4384 | [#8] Splay Cycles:1 Average:629.72 Median:629.72 stddev:0.00 (0.0%) 17:36:30 INFO - PROCESS | 4384 | Values: 629.7 17:36:30 INFO - PROCESS | 4384 | 17:36:30 INFO - PROCESS | 4384 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 17:36:30 INFO - PROCESS | 4384 | Values: 4822.1 17:36:30 INFO - PROCESS | 4384 | -------- Summary: end -------- 17:36:30 INFO - PROCESS | 4384 | 17:36:31 INFO - TEST-INFO | 4384: exit 0 17:36:31 INFO - TEST-OK | v8_7 | took 40869ms 17:36:31 INFO - SUITE-END | took 1213s 17:36:31 INFO - Completed test suite (00:20:13) 17:36:31 INFO - Working with test: dromaeo_css 17:36:31 INFO - Generating results file: dromaeo_css 17:36:31 INFO - Working with test: kraken 17:36:31 INFO - Generating results file: kraken 17:36:31 INFO - javascript benchmark 17:36:31 INFO - Working with test: v8_7 17:36:31 INFO - Generating results file: v8_7 17:36:31 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:36:31 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 17:36:31 INFO - process_Request line: dromaeo_css 6751.01 graph.html#tests=[[72,64,35]] 17:36:31 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:36:32 INFO - process_Request line: kraken 1498.70 graph.html#tests=[[232,64,35]] 17:36:32 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:36:32 INFO - process_Request line: v8_7 18817.31 graph.html#tests=[[230,64,35]] 17:36:32 INFO - RETURN: dromaeo_css: 6751.01 17:36:32 INFO - RETURN: kraken: 1498.70 17:36:32 INFO - RETURN: v8_7: 18817.31 17:36:32 INFO - javascript benchmark 17:36:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3153.795003324784, 3174.142981395022, 3222.258880457495, 3224.484082546793, 3250.1874531367166, 5020.9246861297015, 5112.514311140445, 5187.818426355078, 5213.47865213479, 5236.764345604447, 5163.0, 5194.792208311673, 5215.817446389377, 5231.267622532849, 5234.79060837567, 4496.9550304497025, 4615.515370886059, 4703.318018887259, 4777.06847164803, 4809.326694262806, 4635.327877457767, 4706.482286948433, 4712.646551508634, 4730.787114579852, 4851.151048566504, 4654.8370807021765, 4671.299305104228, 4679.60223381013, 4695.3661255730385, 4731.787069581843, 4693.48371679115, 4708.905821883577, 4732.43210814701, 4743.525647435264, 4783.856484305476, 4621.376114224604, 4689.226277664181, 4752.881177970544, 4759.595434388047, 4796.688215265996, 5022.121128802445, 5082.79668813247, 5094.668846525001, 5104.387473503203, 5117.667351622133, 5516.91724624131, 5532.474414930615, 5536.031194540939, 5539.584531160139, 5591.07747221712, 5451.48210919962, 5508.394076651565, 5541.362743284533, 5563.054280772238, 5574.777008919679, 5169.095408303532, 5181.974090129525, 5184.377874655028, 5189.065968125736, 5230.476952304777, 5626.127950167731, 5627.127795191752, 5628.155776633538, 5630.8029218977135, 5631.915521267184, 5350.197470379474, 5414.6209765316835, 5415.972920135374, 5426.9185962210595, 5517.944820551743, 5486.890262194734, 5504.972475137599, 5521.337439507204, 5538.612297139242, 5545.584081193927, 5453.754581043783, 5458.8908221835345, 5465.754041068161, 5467.644603100865, 5482.342118945752, 5412.648177868505, 5443.020256353815, 5478.506934375925, 5518.724063796794, 5534.695591742493, 4322.265214913472, 4363.345498175236, 4367.410399596078, 4386.956130438719, 4404.405405270248, 3839.040239940015, 3863.2466668999277, 3868.6711629511806, 3875.833479010019, 3898.8830335089992, 4986.700797952062, 5073.568746656501, 5114.923276150861, 5115.2071428928575, 5159.148740457783, 5486.204500347428, 5521.972390138104, 5547.472990065938, 5548.944510554843, 5588.441155884379, 5088.287639730367, 5101.515356041245, 5111.948880511221, 5114.43741188469, 5157.716325602128, 4581.610563102174, 4637.281221410687, 4691.272852707836, 4746.976265118721, 4748.406449193851, 5739.794643124907, 5762.654240745569, 5780.88438231233, 5794.130880367894, 5796.246487956539, 5578.581606379456, 5587.497125258747, 5588.497035266845, 5590.972045139748, 5593.440655934374, 5556.416576259596, 5649.604527683023, 5664.37691853904, 5732.05421105513, 5773.509251713652, 5470.288862447856, 5476.835694929158, 5478.178273259043, 5482.39693633692, 5485.040117979258, 5479.043701186405, 5518.089515230103, 5528.861778455571, 5537.2524709163745, 5586.581006424616, 5295.549878260391, 5387.2727181831515, 5425.294711687456, 5436.864078398072, 5544.972275138599, 5385.40760516335, 5393.056215162409, 5399.136138217867, 5399.433059528693, 5402.297701298806, 5188.584913206859, 5278.656887302313, 5281.102212623787, 5288.81489147878, 5312.282841816305, 5370.03339398912, 5378.892422151614, 5467.20725494809, 5514.062609356339, 5517.420670829505, 5278.287431196739, 5282.656627319212, 5286.207068939536, 5287.233351164136, 5290.312259406252], "unit": "score", "name": "dojo.html", "value": 5103.301566647457}, {"lowerIsBetter": false, "replicates": [511.9001794650044, 523.6020624325514, 533.6531254684454, 537.2505355029737, 561.87357844485, 28772.712272877267, 30064.84967575162, 30777.23056923578, 30786.69213307866, 30878.228044298903, 32725.509117363257, 33043.0, 33088.33823323532, 33122.66877331226, 33155.50266745995, 8471.661133554666, 8663.090375510576, 8665.523396213206, 8674.86987695185, 8678.783030424227, 8400.83198336033, 8543.14568543147, 8544.273736732384, 8550.871736923951, 8756.474611523328, 8682.826343473127, 8786.472811631322, 8798.340124490656, 8809.603567839431, 8813.911860881406, 8625.784355391133, 8680.262177714902, 8684.305255579538, 8712.782180445476, 8712.999999999969, 8525.914740852637, 8661.263792577638, 8677.522736249504, 8679.218870301704, 8682.348823838238, 36767.264654707025, 37096.0, 37097.0, 37110.25779484395, 37153.25693486115, 2838.077624771937, 2887.8556072196307, 2964.110766769982, 3054.941350282097, 3148.988959186205, 29502.262443439085, 29720.40559188826, 30095.0, 30526.69473305261, 31062.0, 3865.7873816940055, 3919.8040097994985, 3968.86108986187, 4020.557738648746, 4084.9387259191135, 252450.0, 252737.0, 252964.0, 254011.0, 254790.72604637043, 51823.74088129535, 53704.46295536995, 58331.41668583345, 58444.70777646085, 58490.41509584935, 48738.0, 64389.678051609444, 65618.34381656218, 65620.73465224745, 65663.0, 12460.937695311466, 12474.81287780684, 12522.81215781764, 12523.937380313222, 12558.0, 9431.245500359955, 9719.076687714656, 10079.647212347532, 10132.594696212069, 10149.188064954786, 17302.913485432746, 20364.490887727927, 20863.791362086184, 20928.895355523124, 20943.47641308949, 7597.240275972358, 7828.334591559781, 7888.14482889385, 7892.447528672938, 8125.75622731319, 904.4799240436644, 923.06309096266, 942.6276620734772, 943.4999450291357, 967.6148294454064, 28270.575941360898, 28495.857520712678, 29223.415531689247, 29243.56134657982, 29275.85362073176, 949.8670186173941, 995.9900400996042, 1030.6341248856697, 1050.469512895998, 1059.3114475590928, 13234.338283086, 15302.540923772305, 15677.0, 15685.215739212994, 15957.0, 314788.0, 321496.0, 321574.0, 321790.0, 321940.0, 51104.74447627738, 51379.0, 51425.228621570706, 51480.0, 51493.227601586004, 1106.5131342209402, 1117.6144230240716, 1121.5345631562973, 1126.2285334546027, 1260.4076084240392, 28460.288492787848, 29273.414531708822, 29426.85286573639, 29601.0, 29921.70078299189, 45714.77142614266, 45960.0, 45965.310520341554, 46036.53963460323, 46050.769746151054, 227115.0, 227926.0, 228160.0, 299913.0, 301352.0, 28399.0, 28567.317377332725, 28991.0, 31337.8433107833, 31706.19525656936, 32586.0, 32648.0, 32968.34063318768, 33131.0, 33191.0, 30925.0, 33937.32125357528, 35151.47272790859, 35264.823675882486, 35497.0, 35197.47203791894, 36061.0984725384, 36375.272494549434, 36433.0, 37462.8126859364, 32889.50665739968, 33249.16877077996, 33290.833545832116, 34766.0, 35387.29225415426, 28192.0, 28520.42959140764, 30370.392592148477, 30414.239644009078, 30501.694983049885, 24550.877245613658, 25195.370115747253, 25351.353240438304, 25358.873205633852, 25774.87112564425], "unit": "score", "name": "ext.html", "value": 17444.504690215286}, {"lowerIsBetter": false, "replicates": [363.1900861079792, 366.9156094098358, 368.7621484142728, 370.8498058286393, 376.81347732872234, 13734.45062197511, 13840.723185536308, 15605.765913511292, 16621.252043658034, 17457.912710436445, 14109.0, 14119.647008824759, 14290.0, 14483.637909052279, 15019.624509387244, 5292.735363231843, 5488.780448782044, 5493.093639549469, 5497.257870187534, 5497.945020549803, 4002.5397079335958, 4109.835606575733, 5380.435054319299, 5463.426340234278, 5719.885602287973, 5693.975084484791, 5802.0, 5844.678542680151, 5845.941540584604, 5853.297604287492, 5840.06558950568, 5941.465268125889, 5955.047192449209, 5957.523398128139, 5961.628825370168, 4977.925331120036, 5105.489451054865, 5137.511936366077, 5255.632105752599, 5257.526822585985, 13055.0, 13146.474141034347, 17565.473035808947, 20592.897035514725, 20603.89698051515, 1940.223910435837, 1943.640426521098, 1943.9416817495498, 1967.527793329605, 2020.05057622917, 9092.8636070459, 9223.815523689556, 9294.163525282756, 9541.761455963657, 9553.331266811327, 1758.3494107180297, 1802.1980218802637, 1822.9908850455795, 1833.9449816505526, 1885.5286178455385, 53711.0, 53941.46058539404, 54460.72769636127, 55033.516967498035, 56573.717131414494, 9814.214862810957, 10103.09072183507, 10174.4912754362, 10232.488375581192, 10268.127209187303, 13521.32393380327, 13576.321183940763, 13681.452741890213, 13683.24742139172, 13703.657408564666, 7142.071530700976, 7170.96414517924, 7214.350708436161, 7252.818679532948, 7339.926600734031, 6754.797356079325, 6803.48973826965, 6873.381395674413, 6927.480438967098, 6938.5836849789175, 4395.362672412546, 4529.071540334224, 4539.636829053734, 4541.909161816745, 4586.6789324747615, 1713.820048894848, 1737.8957262564033, 1786.8213178682029, 1805.4764118405515, 1816.1282584359317, 832.7626626411444, 896.2426749396749, 911.9133682300171, 964.1611797735875, 978.1490103609905, 15699.136547489768, 15993.36026558948, 16984.660306793794, 17379.78341516082, 17636.559086022695, 880.3441436130124, 893.4683863101444, 924.778053267211, 943.7829299261208, 971.3686104032295, 9287.674931377369, 9655.372400793925, 9759.12167904892, 9837.557309920927, 9933.155681766986, 544965.0, 546466.0, 555042.0, 565664.0, 567494.0, 44631.330530042076, 45802.77098614552, 70425.2957470429, 70763.0, 74125.14687132757, 1136.3409222650844, 1142.2632402100764, 1147.1109889835445, 1156.2542160306723, 1159.681087700889, 15077.321520531821, 15117.697646046798, 15307.081575105529, 15321.540353789404, 15538.223088845738, 33891.830540847135, 33959.66040339565, 34245.65754342425, 34456.65543344535, 35160.0, 42918.78540607277, 44581.331280031474, 45041.54958450505, 45430.68408501187, 48071.75964120157, 7236.746713864989, 7278.96360518194, 7326.0, 7402.666879990521, 7438.5536867788105, 7552.845332497728, 10343.0, 10966.701451475306, 10990.615328463466, 11219.55121795119, 9520.285978551776, 9556.808863822824, 9681.128698417177, 9864.112229899343, 10048.246381521269, 9380.765480863032, 9519.333646644669, 9532.332736708364, 9873.456959867277, 9912.950435247778, 9576.808463830825, 9890.505474726378, 9984.151347135576, 10045.447500387549, 10054.849177262493, 7191.748288809867, 7196.568205907663, 7215.134183897966, 7267.854642907218, 7351.0, 7943.682252709827, 9939.900600993897, 10050.547725352522, 10185.796284074426, 10321.587136514756], "unit": "score", "name": "jquery.html", "value": 8055.916100034559}, {"lowerIsBetter": false, "replicates": [1382.2881216173666, 1505.3526983397135, 1508.057464084947, 1696.8557672597829, 1845.796962334144, 6929.307069293068, 7821.765347039591, 7976.162502937195, 7976.880346794803, 7983.32141767949, 7777.22227777222, 7981.0, 7981.201879812031, 7982.600869956508, 7983.960080199591, 2059.2072052259837, 2103.221807931068, 2105.5788842231536, 2374.6438034294865, 2410.529946660402, 2077.698733683615, 2368.644703294511, 2409.204962362416, 2417.576924038295, 2424.2969538833718, 2300.4018955071633, 2346.694929659142, 2352.8588284702887, 2359.9764002360016, 2363.7990770784418, 2298.7816157465013, 2307.930762077132, 2317.5017371265176, 2320.9767902320928, 2321.4080409495555, 2314.4676724353494, 2319.5360927814336, 2319.7100362454694, 2321.3500219938446, 2332.976670233293, 8046.758597242092, 8121.553314567696, 8123.5532045738055, 8134.267915887599, 8135.959320203361, 4869.0, 5010.774515146827, 5033.345665063518, 5033.723145227011, 5037.118504261776, 3113.1750086227166, 3114.9221269468217, 3210.036988903343, 3220.372027454647, 3234.757393195496, 956.9569369378326, 979.4661909259471, 979.6179489998906, 993.5876611206413, 1003.2074661017787, 11406.201565890391, 11420.428978551123, 11422.0, 11430.657080287521, 11432.542698292058, 4520.977395113004, 4545.977270113694, 4588.839390621312, 4624.375709279204, 4631.143238500821, 9546.0, 9552.42685438876, 9559.235261179088, 9563.760905977406, 9568.95215523918, 4888.364512613338, 4897.240927656219, 4901.09329773993, 4903.26451032348, 4904.43598986114, 4455.799489023002, 4459.397981272552, 4461.04087621163, 4461.576150265784, 4462.977685111554, 3534.3638145134123, 3601.3697602919383, 3900.9804950975063, 3968.6031396860085, 4002.9799851000557, 1235.9567415140427, 1256.824044633752, 1271.0467149637773, 1277.6550331410467, 1284.5953524639708, 1280.7118398360294, 1287.6394609509352, 1298.1237664576374, 1307.8822905938512, 1336.4186578838237, 7078.646067696594, 7144.499885008104, 7193.100862392201, 7197.604131772698, 7198.388137008308, 1118.9216754827085, 1124.1400328748514, 1132.2866594045863, 1139.7492551638627, 1160.6750109969223, 5450.345958484928, 5535.418781028015, 5538.446155384429, 5542.778288868481, 5550.555955523549, 9737.853932190881, 9855.950720246496, 10013.599456021822, 10131.696049118538, 10140.239482038876, 9917.305788594873, 9980.750481238027, 10008.599656013823, 10018.74953126163, 10030.849537256947, 7318.817029574197, 7511.474196806171, 7515.549067055994, 7559.1684914659345, 7559.979402780664, 7272.582562714908, 7281.745138920112, 7351.485396022441, 7362.4478164136835, 7370.557766534025, 8812.60343284541, 8852.778680532781, 9019.32355073359, 9033.50315732641, 9047.276217902421, 8601.784955376166, 9153.63385464574, 9218.400803947721, 9258.675946341846, 9270.119338662817, 7318.0, 7405.555666660018, 7406.296401841816, 7431.0, 7434.702611895464, 6595.0, 6733.595984240961, 7286.307800758919, 7340.743073992385, 7422.925770742223, 7092.113485814273, 7164.677589508589, 7199.496035277481, 7300.853982920205, 7316.085489313836, 6829.556078854858, 6951.8609627806145, 7084.504084714021, 7191.460640451883, 7223.638818059181, 6880.31196880328, 6928.16861976566, 6941.618210998444, 6942.201646810479, 6948.270431604608, 6275.058741188675, 6293.181886354744, 6301.96849015752, 6327.3988971047675, 6509.251436084911, 6593.736250549924, 6651.102101216467, 6652.268250492539, 6653.467722582085, 6660.234073081464], "unit": "score", "name": "mootools.html", "value": 4622.153128964902}, {"lowerIsBetter": false, "replicates": [336.17972147958994, 339.11998364244783, 341.1964822842207, 341.6412766595076, 350.6090708859621, 5718.485336319731, 5845.240118784557, 5858.2677165354335, 5883.646981181127, 5903.055511118211, 5627.859303517414, 5777.624454410471, 5784.623999440044, 5807.651540907548, 5815.883682326351, 4528.230200865861, 4558.72647641141, 4576.885577860547, 4589.35748995141, 4593.150267200579, 4356.063446359032, 4447.310666846644, 4450.532694067125, 4535.886602834922, 4568.200564901129, 4477.194105061104, 4512.435945506812, 4517.570830771071, 4535.410396648431, 4537.931931021021, 4516.593506584407, 4525.072360166158, 4526.0, 4530.478994915594, 4541.0, 4010.979945100256, 4012.057166565884, 4013.7993100344866, 4015.4779878615886, 4020.597940205985, 5520.66875987442, 5608.635438696471, 5633.183188437653, 5674.0, 5679.574031947621, 5156.922646160273, 5162.92255616166, 5166.457521960216, 5169.689818610896, 5173.793048278064, 5907.320658124328, 6257.155284036688, 6262.405071518244, 6268.310485846553, 6268.717907694165, 4207.621314081747, 4246.044639956016, 4249.171411574714, 4249.957500424987, 4260.595243451867, 6343.682815859189, 6438.7102580384, 6458.354164583504, 6462.4183823456115, 6466.870662586722, 4369.825206991684, 4389.714668546534, 4391.363252328394, 4396.868093957187, 4398.120375924827, 4336.674749393808, 4431.578999994996, 4435.334699795057, 4446.0, 4523.457185137804, 5179.48205179479, 5183.118869792144, 5194.870128246824, 5195.6622819516615, 5199.7920083197005, 6269.7178626961895, 6282.340354262828, 6315.5894866833505, 6331.841703957438, 6332.905006424908, 1562.6718389138182, 1587.8253392126858, 1588.7458006718869, 1590.19695053997, 1591.037422359479, 1049.380865289483, 1050.0759331787979, 1050.5010120193, 1061.8407238914224, 1079.2660990526517, 5796.0436527972415, 5807.564432667482, 5808.912866307009, 5810.4189581041555, 5815.73829177688, 6400.743970241138, 6403.903941440882, 6407.615543067431, 6408.9745640697265, 6421.775237866652, 5876.1773351729935, 5883.17635531026, 5883.382244864228, 5885.293764748172, 5890.882182356415, 3322.235885746292, 3452.602950660706, 3456.8962931112105, 3459.550258466383, 3472.0625431133453, 6645.468362530986, 6649.601023938482, 6651.501137414616, 6655.001749737481, 6660.0, 6525.249596296487, 6531.640759758259, 6534.346565343522, 6539.0, 6543.901841472381, 6492.772752953624, 6639.86720265592, 6651.600903945779, 6732.528722989442, 6739.460843132636, 6184.81445556634, 6302.243730752339, 6459.515536334699, 6460.580062295936, 6466.06242094903, 6212.534059945612, 6358.618482891041, 6372.044193371032, 6381.776637817654, 6394.680265986589, 6680.164979377578, 6699.464042876656, 6702.765403210864, 6703.061571379913, 6758.628275444898, 4336.804843781974, 4337.371081193146, 4347.65218782503, 4349.521552629271, 4451.510333863337, 6372.522060845363, 6390.52071094679, 6393.4885209184085, 6432.0, 6434.0, 6238.750449982132, 6255.593386429868, 6257.311695713377, 6270.028145637433, 6310.7475700971445, 6128.264608247039, 6238.220222472191, 6245.437910588069, 6246.094316324198, 6259.655718935503, 6166.414190651881, 6167.290761562478, 6194.132821405097, 6229.2524897012645, 6229.56393052482, 6350.206224221973, 6355.5551111421755, 6359.523035772429, 6361.681915904093, 6366.586171898812, 6093.725782339717, 6202.34875338083, 6203.31763506005, 6204.286507051746, 6206.565540412128], "unit": "score", "name": "prototype.html", "value": 4701.743665820999}, {"lowerIsBetter": false, "replicates": [714.7712731925784, 802.1817745899183, 856.4005196362548, 856.837200931823, 868.9131086891311, 13087.738245235114, 13103.34483275836, 13114.213147211174, 13225.801612975813, 13287.667808304797, 10896.673099807018, 10951.233413661046, 11032.22774405792, 11034.834477482824, 11067.612633557826, 654.4175683641563, 673.124937581145, 791.0586402181415, 796.1401686178942, 800.1638287989036, 812.5327936436543, 813.9023317201915, 814.9307308878753, 820.3191351178508, 821.7822277096574, 859.2824991132412, 862.2024627219828, 862.607513581319, 862.779991102268, 863.5768473447997, 683.9794806155824, 707.7770502291762, 825.8843761873372, 855.3670283989865, 855.8587833007547, 628.940250676185, 629.9937000629981, 632.8322994406486, 634.0520921222756, 637.1494055435999, 12672.746545069047, 12734.108612397136, 12750.87249127506, 12758.744825103538, 12773.361331933365, 11767.293962362286, 12328.938355308255, 12492.0, 12573.057020723483, 12646.367681615882, 10166.390016599027, 10191.439470829102, 10231.948840255825, 10388.676342786399, 10563.154947604173, 3544.6809787119023, 3592.7844329340323, 3652.2695460907926, 3694.3350196964534, 3730.235301763132, 48566.757166214295, 48635.51364486345, 48870.75564622154, 49000.754996224794, 49505.50494495045, 9979.251556133175, 10053.79892402148, 10293.125084367912, 10315.1747860171, 10318.484075796181, 18783.530411739543, 18817.059147042593, 18825.34111306125, 18849.0, 18862.245510179713, 7612.0, 7751.496152750054, 7844.333231675258, 7879.724209652634, 7919.485233459806, 4136.8138433770555, 4174.791260437027, 4232.6190642841675, 4287.549807270254, 4298.0, 3044.2693753499443, 3087.768417368706, 3095.8142511448937, 3096.8296743679316, 3100.255938574771, 571.9227904232959, 582.5572564850744, 583.9620424672382, 590.6515156057947, 602.7950496831098, 452.60623257765957, 477.29122253453596, 478.85394954538503, 586.3257254157753, 597.1311741416316, 7974.242446967529, 8464.068952415353, 8575.785605359792, 8625.137486251324, 8667.783305417415, 527.0513076462353, 555.963862348946, 561.0531455848201, 659.983500412484, 731.5574077682925, 3679.264147170523, 3695.8843545863456, 3781.6596506314013, 3783.5838057813617, 4041.959580404217, 58515.0, 59447.40552594419, 59492.405075948685, 59679.0, 59994.0, 51604.22593661023, 52107.2183917234, 52234.21648675273, 52322.0, 52524.0, 44934.32598511025, 45991.54008459939, 46517.0, 48206.0, 48414.27378589324, 7667.808304792425, 7684.500507466997, 7707.383409327353, 7732.922670773445, 7744.380449564134, 33317.666823331456, 34148.65851341554, 34155.14612134716, 34497.65502344944, 34920.82539587286, 42535.57464425316, 44200.0, 46530.767346163055, 46592.53407465882, 47436.7628161857, 9733.659321923698, 9792.608295668379, 10008.749781255527, 10350.223733219887, 10465.319754215952, 11312.15158863105, 11590.362530060927, 11604.593839215588, 11910.761784764429, 11933.880661193623, 10226.744331391776, 10519.631812886511, 10582.4708764563, 11012.944935275273, 11019.063379612822, 9743.842315518368, 10006.09945104915, 10090.899091008996, 10432.113270372103, 10434.165266778487, 9603.135717785433, 10003.099721025143, 10018.248631352824, 10135.454676695734, 10212.744681383025, 7851.658843185697, 7861.646225919733, 8065.395095367753, 8129.8374032520205, 8146.633401496828, 8513.574321283788, 8569.785755355917, 8627.085820137832, 8791.604377802887, 8800.515971621622], "unit": "score", "name": "yui.html", "value": 6073.628959657416}], "name": "dromaeo_css", "value": 6751.008924488319}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 112.0, 107.0, 110.0, 110.0, 110.0, 110.0, 111.0, 103.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.5}, {"lowerIsBetter": true, "replicates": [149.0, 131.0, 154.0, 165.0, 127.0, 146.0, 154.0, 125.0, 168.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 144.5}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 159.0, 160.0, 162.0, 161.0, 158.0, 162.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [96.0, 74.0, 73.0, 148.0, 73.0, 73.0, 75.0, 73.0, 153.0, 73.0], "unit": "score", "name": "audio-fft", "value": 91.1}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 154.0, 96.0, 96.0, 96.0, 151.0, 96.0, 96.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 111.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 144.0], "unit": "score", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [57.0, 54.0, 54.0, 56.0, 54.0, 55.0, 55.0, 55.0, 60.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.2}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 67.0, 67.0, 67.0, 72.0, 67.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 81.0, 82.0, 83.0, 82.0, 81.0, 82.0, 89.0, 90.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.5}, {"lowerIsBetter": true, "replicates": [117.0, 115.0, 123.0, 114.0, 119.0, 114.0, 115.0, 118.0, 114.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.1}, {"lowerIsBetter": true, "replicates": [145.0, 148.0, 141.0, 142.0, 142.0, 130.0, 144.0, 135.0, 147.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.5}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 64.0, 68.0, 66.0, 64.0, 67.0, 67.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.1}], "name": "kraken", "value": 1498.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.2127659574468], "unit": "score", "name": "Richards", "value": 207.39925000000005}, {"lowerIsBetter": false, "replicates": [188.71485185884129], "unit": "score", "name": "DeltaBlue", "value": 350.35928200000006}, {"lowerIsBetter": false, "replicates": [279.9552071668533], "unit": "score", "name": "Encrypt", "value": 950.7985320000004}, {"lowerIsBetter": false, "replicates": [5268.421052631579], "unit": "score", "name": "Decrypt", "value": 50.52386613386611}, {"lowerIsBetter": false, "replicates": [1939.922480620155], "unit": "score", "name": "RayTrace", "value": 381.452871128871}, {"lowerIsBetter": false, "replicates": [788.6435331230284], "unit": "score", "name": "Earley", "value": 845.075084}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [41755.102040816324], "unit": "score", "name": "RegExp", "value": 21.817333822091896}, {"lowerIsBetter": false, "replicates": [629.7229219143577], "unit": "score", "name": "Splay", "value": 129.40770799999999}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 18817.309378058435}]} 17:36:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "18817.31"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1498.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6751.01"}}} 17:36:32 INFO - Return code: 0 17:36:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:36:32 INFO - # TBPL SUCCESS # 17:36:32 INFO - Running post-action listener: _resource_record_post_action 17:36:32 INFO - Running post-run listener: _resource_record_post_run 17:36:33 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 16384; Write bytes: 552259584; Read time: 48; Write time: 664220 17:36:33 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237522944; Read time: 0; Write time: 368660 17:36:33 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 16384; Write bytes: 314736640; Read time: 48; Write time: 295560 17:36:33 INFO - Running post-run listener: _upload_blobber_files 17:36:33 INFO - Blob upload gear active. 17:36:33 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:36:33 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 17:36:33 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'] 17:36:33 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 17:36:33 INFO - (blobuploader) - INFO - Open directory for files ... 17:36:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:36:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:36:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:34 INFO - (blobuploader) - INFO - Done attempting. 17:36:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:36:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:36:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:35 INFO - (blobuploader) - INFO - Done attempting. 17:36:35 INFO - (blobuploader) - INFO - Iteration through files over. 17:36:35 INFO - Return code: 0 17:36:35 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:36:35 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:36:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f4e797e2ad02b5bbae578aaac12a30ba17ec7119c5e92298cc4e4cf9016635ccf1eed00f7217e2cd809877235f5c979ca5e0dd8fbe86628a7b8774d152f83cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0dc716ef1a94d08f5ea1ff99c762d00c21cf8449f46f808e4255940e9bcd7f68cc9e33be1fe962049b7bc71261f9088a0687cbc1dadead92a8e56172a93009da"} 17:36:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:36:35 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:36:35 INFO - Contents: 17:36:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f4e797e2ad02b5bbae578aaac12a30ba17ec7119c5e92298cc4e4cf9016635ccf1eed00f7217e2cd809877235f5c979ca5e0dd8fbe86628a7b8774d152f83cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0dc716ef1a94d08f5ea1ff99c762d00c21cf8449f46f808e4255940e9bcd7f68cc9e33be1fe962049b7bc71261f9088a0687cbc1dadead92a8e56172a93009da"} 17:36:35 INFO - Running post-run listener: copy_logs_to_upload_dir 17:36:35 INFO - Copying logs to upload dir... 17:36:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:36:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.794157 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-19 17:36:35.642717) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 17:36:35.646354) ========= 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-1453252003.933676-862171949 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/8f4e797e2ad02b5bbae578aaac12a30ba17ec7119c5e92298cc4e4cf9016635ccf1eed00f7217e2cd809877235f5c979ca5e0dd8fbe86628a7b8774d152f83cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0dc716ef1a94d08f5ea1ff99c762d00c21cf8449f46f808e4255940e9bcd7f68cc9e33be1fe962049b7bc71261f9088a0687cbc1dadead92a8e56172a93009da"} build_url:https://queue.taskcluster.net/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011587 build_url: 'https://queue.taskcluster.net/v1/task/FD2urM-AT6an-vdyRR3ocQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f4e797e2ad02b5bbae578aaac12a30ba17ec7119c5e92298cc4e4cf9016635ccf1eed00f7217e2cd809877235f5c979ca5e0dd8fbe86628a7b8774d152f83cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0dc716ef1a94d08f5ea1ff99c762d00c21cf8449f46f808e4255940e9bcd7f68cc9e33be1fe962049b7bc71261f9088a0687cbc1dadead92a8e56172a93009da"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 17:36:35.672007) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 17:36:35.672376) ========= 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-1453252003.933676-862171949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004648 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 17:36:35.757131) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 17:36:35.757483) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 17:36:35.757896) ========= ========= Total master_lag: 0.37 =========