builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-030 starttime: 1456579831.03 results: success (0) buildid: 20160225005029 builduid: 3da0c03b862e43d3be251c62de973dd4 revision: a28dc9d1e31e03b79c0ace56d9cd2527d98cb11f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-27 05:30:31.025478) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-27 05:30:31.025940) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-27 05:30:31.026225) ========= 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=4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.003948 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-27 05:30:31.040963) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-27 05:30:31.041231) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-27 05:30:31.049615) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:30:31.049871) ========= 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=4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003901 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:30:31.097180) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-27 05:30:31.097458) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-27 05:30:31.097817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:30:31.098087) ========= 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=4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-27 05:30:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-02-27 05:30:31 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165814 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:30:31.276129) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:30:31.276450) ========= 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=4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014777 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:30:31.325313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-27 05:30:31.325661) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a28dc9d1e31e03b79c0ace56d9cd2527d98cb11f --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a28dc9d1e31e03b79c0ace56d9cd2527d98cb11f --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=4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-27 05:30:31,558 truncating revision to first 12 chars 2016-02-27 05:30:31,559 Setting DEBUG logging. 2016-02-27 05:30:31,559 attempt 1/10 2016-02-27 05:30:31,559 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a28dc9d1e31e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-27 05:30:32,349 unpacking tar archive at: mozilla-aurora-a28dc9d1e31e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.100328 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-27 05:30:32.438471) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-27 05:30:32.438832) ========= echo a28dc9d1e31e03b79c0ace56d9cd2527d98cb11f in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a28dc9d1e31e03b79c0ace56d9cd2527d98cb11f'] 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=4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False a28dc9d1e31e03b79c0ace56d9cd2527d98cb11f program finished with exit code 0 elapsedTime=0.003440 script_repo_revision: 'a28dc9d1e31e03b79c0ace56d9cd2527d98cb11f' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-27 05:30:32.486408) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-27 05:30:32.486880) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-27 05:30:32.496479) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-02-27 05:30:32.496760) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:30:32 INFO - MultiFileLogger online at 20160227 05:30:32 in /builds/slave/test-pgo 05:30:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:30:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:30:32 INFO - {'append_to_log': False, 05:30:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:30:32 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:30:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:30:32 INFO - 'branch': 'Mozilla-Aurora', 05:30:32 INFO - 'buildbot_json_path': 'buildprops.json', 05:30:32 INFO - 'config_files': ('talos/linux_config.py',), 05:30:32 INFO - 'default_actions': ('clobber', 05:30:32 INFO - 'read-buildbot-config', 05:30:32 INFO - 'download-and-extract', 05:30:32 INFO - 'populate-webroot', 05:30:32 INFO - 'create-virtualenv', 05:30:32 INFO - 'install', 05:30:32 INFO - 'run-tests'), 05:30:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:30:32 INFO - 'download_minidump_stackwalk': True, 05:30:32 INFO - 'download_symbols': 'ondemand', 05:30:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:30:32 INFO - 'tooltool.py': '/tools/tooltool.py', 05:30:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:30:32 INFO - '/tools/misc-python/virtualenv.py')}, 05:30:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:30:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:30:32 INFO - 'installer_path': 'installer.exe', 05:30:32 INFO - 'log_level': 'info', 05:30:32 INFO - 'log_name': 'talos', 05:30:32 INFO - 'log_to_console': True, 05:30:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:30:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:30:32 INFO - 'opt_config_files': (), 05:30:32 INFO - 'pip_index': False, 05:30:32 INFO - 'sps_profile': False, 05:30:32 INFO - 'sps_profile_interval': 0, 05:30:32 INFO - 'suite': 'dromaeojs-e10s', 05:30:32 INFO - 'system_bits': '32', 05:30:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:30:32 INFO - 'title': 'talos-linux64-ix-030', 05:30:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:30:32 INFO - 'use_talos_json': True, 05:30:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:30:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:30:32 INFO - 'work_dir': 'build'} 05:30:32 INFO - ##### 05:30:32 INFO - ##### Running clobber step. 05:30:32 INFO - ##### 05:30:32 INFO - Running pre-action listener: _resource_record_pre_action 05:30:32 INFO - Running main action method: clobber 05:30:32 INFO - rmtree: /builds/slave/test-pgo/build 05:30:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:30:33 INFO - Running post-action listener: _resource_record_post_action 05:30:33 INFO - ##### 05:30:33 INFO - ##### Running read-buildbot-config step. 05:30:33 INFO - ##### 05:30:33 INFO - Running pre-action listener: _resource_record_pre_action 05:30:33 INFO - Running main action method: read_buildbot_config 05:30:33 INFO - Using buildbot properties: 05:30:33 INFO - { 05:30:33 INFO - "project": "", 05:30:33 INFO - "product": "firefox", 05:30:33 INFO - "script_repo_revision": "production", 05:30:33 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 05:30:33 INFO - "repository": "", 05:30:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 05:30:33 INFO - "buildid": "20160225005029", 05:30:33 INFO - "pgo_build": "True", 05:30:33 INFO - "basedir": "/builds/slave/test-pgo", 05:30:33 INFO - "buildnumber": 167, 05:30:33 INFO - "slavename": "talos-linux64-ix-030", 05:30:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:30:33 INFO - "platform": "ubuntu64_hw", 05:30:33 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:30:33 INFO - "branch": "mozilla-aurora", 05:30:33 INFO - "repo_path": "releases/mozilla-aurora", 05:30:33 INFO - "revision": "a28dc9d1e31e03b79c0ace56d9cd2527d98cb11f", 05:30:33 INFO - "stage_platform": "linux64-pgo", 05:30:33 INFO - "builduid": "3da0c03b862e43d3be251c62de973dd4", 05:30:33 INFO - "slavebuilddir": "test" 05:30:33 INFO - } 05:30:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 05:30:33 INFO - Running post-action listener: _resource_record_post_action 05:30:33 INFO - ##### 05:30:33 INFO - ##### Running download-and-extract step. 05:30:33 INFO - ##### 05:30:33 INFO - Running pre-action listener: _resource_record_pre_action 05:30:33 INFO - Running main action method: download_and_extract 05:30:33 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:33 INFO - https://queue.taskcluster.net/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:30:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/test_packages.json 05:30:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/test_packages.json 05:30:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:30:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:30:33 INFO - Downloaded 1448 bytes. 05:30:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:30:33 INFO - Using the following test package requirements: 05:30:33 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 05:30:33 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:30:33 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:30:33 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:30:33 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 05:30:33 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:30:33 INFO - u'jsshell-linux-x86_64.zip'], 05:30:33 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:30:33 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:30:33 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 05:30:33 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:30:33 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:30:33 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:30:33 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:30:33 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:30:33 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:30:33 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 05:30:33 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:30:33 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:30:33 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:33 INFO - https://queue.taskcluster.net/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:30:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:30:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:30:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:30:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:30:34 INFO - Downloaded 23079153 bytes. 05:30:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:30:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:30:36 INFO - Return code: 0 05:30:36 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:30: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')]} 05:30:36 INFO - https://queue.taskcluster.net/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:30:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:30:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:30:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:30:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:30:37 INFO - Downloaded 23079153 bytes. 05:30:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:30:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:30:39 INFO - Return code: 0 05:30:39 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')]} 05:30:39 INFO - https://queue.taskcluster.net/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:30:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 05:30:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 05:30:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 05:30:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:30:39 INFO - Downloaded 10706649 bytes. 05:30:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:30:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 05:30:40 INFO - Return code: 0 05:30: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')]} 05:30:40 INFO - https://queue.taskcluster.net/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:30:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:30:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:30:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:30:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:30:41 INFO - Downloaded 59964862 bytes. 05:30:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:30:41 INFO - mkdir: /builds/slave/test-pgo/properties 05:30:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:30:41 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:30:41 INFO - Contents: 05:30:41 INFO - build_url:https://queue.taskcluster.net/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:30:42 INFO - Running post-action listener: _resource_record_post_action 05:30:42 INFO - Running post-action listener: set_extra_try_arguments 05:30:42 INFO - ##### 05:30:42 INFO - ##### Running populate-webroot step. 05:30:42 INFO - ##### 05:30:42 INFO - Running pre-action listener: _resource_record_pre_action 05:30:42 INFO - Running main action method: populate_webroot 05:30:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:30:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:30:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:30:42 INFO - '--tppagecycles', 05:30:42 INFO - '7'], 05:30:42 INFO - 'tests': ['tsvgm']}}, 05:30:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:30:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:30:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:30:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:30:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:30:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:30:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:42 INFO - 'talos_options': ['--e10s'], 05:30:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:42 INFO - 'tests': ['damp', 'tps']}, 05:30:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:42 INFO - 'talos_options': ['--e10s'], 05:30:42 INFO - 'tests': ['damp', 'tps']}, 05:30:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:30:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:30:42 INFO - 'other': {'tests': ['a11yr', 05:30:42 INFO - 'ts_paint', 05:30:42 INFO - 'tpaint', 05:30:42 INFO - 'sessionrestore', 05:30:42 INFO - 'sessionrestore_no_auto_restore']}, 05:30:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:30:42 INFO - 'tests': ['a11yr', 05:30:42 INFO - 'ts_paint', 05:30:42 INFO - 'tpaint', 05:30:42 INFO - 'sessionrestore', 05:30:42 INFO - 'sessionrestore_no_auto_restore']}, 05:30:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:30:42 INFO - 'tests': ['a11yr', 05:30:42 INFO - 'ts_paint', 05:30:42 INFO - 'tpaint', 05:30:42 INFO - 'sessionrestore', 05:30:42 INFO - 'sessionrestore_no_auto_restore']}, 05:30:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:30:42 INFO - 'tests': ['a11yr', 05:30:42 INFO - 'ts_paint', 05:30:42 INFO - 'tpaint', 05:30:42 INFO - 'sessionrestore', 05:30:42 INFO - 'sessionrestore_no_auto_restore']}, 05:30:42 INFO - 'other_l64': {'tests': ['a11yr', 05:30:42 INFO - 'ts_paint', 05:30:42 INFO - 'tpaint', 05:30:42 INFO - 'sessionrestore', 05:30:42 INFO - 'sessionrestore_no_auto_restore']}, 05:30:42 INFO - 'other_nol64': {'tests': ['a11yr', 05:30:42 INFO - 'ts_paint', 05:30:42 INFO - 'tpaint', 05:30:42 INFO - 'sessionrestore', 05:30:42 INFO - 'sessionrestore_no_auto_restore']}, 05:30:42 INFO - 'svgr': {'tests': ['tsvgx', 05:30:42 INFO - 'tsvgr_opacity', 05:30:42 INFO - 'tart', 05:30:42 INFO - 'tscrollx', 05:30:42 INFO - 'cart']}, 05:30:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:30:42 INFO - 'tests': ['tsvgx', 05:30:42 INFO - 'tsvgr_opacity', 05:30:42 INFO - 'tart', 05:30:42 INFO - 'tscrollx', 05:30:42 INFO - 'cart']}, 05:30:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:42 INFO - 'tests': ['tp5o']}, 05:30:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:42 INFO - 'talos_options': ['--e10s'], 05:30:42 INFO - 'tests': ['tp5o']}, 05:30:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:42 INFO - 'talos_options': ['--xperf_path', 05:30:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:42 INFO - 'tests': ['tp5n']}, 05:30:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:30:42 INFO - 'talos_options': ['--e10s', 05:30:42 INFO - '--xperf_path', 05:30:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:42 INFO - 'tests': ['tp5n']}}, 05:30:42 INFO - 'talos.zip': {'path': '', 05:30:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:30:42 INFO - Running post-action listener: _resource_record_post_action 05:30:42 INFO - ##### 05:30:42 INFO - ##### Running create-virtualenv step. 05:30:42 INFO - ##### 05:30:42 INFO - Running pre-action listener: _resource_record_pre_action 05:30:42 INFO - Running main action method: create_virtualenv 05:30:42 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:30:42 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 05:30:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:30:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:30:42 INFO - Using real prefix '/usr' 05:30:42 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:30:42 INFO - Installing distribute.............................................................................................................................................................................................done. 05:30:44 INFO - Installing pip.................done. 05:30:44 INFO - Return code: 0 05:30:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0fdcccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1554230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e67f0>, '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 0x15522d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1552760>, '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': '4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789', '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 05:30:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:30:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:30:44 INFO - Using env: {'DISPLAY': ':0', 05:30:44 INFO - 'HOME': '/home/cltbld', 05:30:44 INFO - 'LANG': 'en_US.UTF-8', 05:30:44 INFO - 'LANGUAGE': 'en_US:en', 05:30:44 INFO - 'LOGNAME': 'cltbld', 05:30:44 INFO - 'MAIL': '/var/mail/cltbld', 05:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:44 INFO - 'MOZ_NO_REMOTE': '1', 05:30:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:44 INFO - 'NO_EM_RESTART': '1', 05:30:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:44 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:44 INFO - 'SHELL': '/bin/bash', 05:30:44 INFO - 'SHLVL': '1', 05:30:44 INFO - 'TERM': 'linux', 05:30:44 INFO - 'TMOUT': '86400', 05:30:44 INFO - 'USER': 'cltbld', 05:30:44 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789', 05:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:44 INFO - '_': '/tools/buildbot/bin/python'} 05:30:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:45 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 05:30:45 INFO - Cleaning up... 05:30:45 INFO - Return code: 0 05:30:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:30: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')]} 05:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30: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')]} 05:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0fdcccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1554230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e67f0>, '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 0x15522d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1552760>, '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': '4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789', '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 05:30:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:30:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:30:45 INFO - Using env: {'DISPLAY': ':0', 05:30:45 INFO - 'HOME': '/home/cltbld', 05:30:45 INFO - 'LANG': 'en_US.UTF-8', 05:30:45 INFO - 'LANGUAGE': 'en_US:en', 05:30:45 INFO - 'LOGNAME': 'cltbld', 05:30:45 INFO - 'MAIL': '/var/mail/cltbld', 05:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:45 INFO - 'MOZ_NO_REMOTE': '1', 05:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:45 INFO - 'NO_EM_RESTART': '1', 05:30:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:45 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:45 INFO - 'SHELL': '/bin/bash', 05:30:45 INFO - 'SHLVL': '1', 05:30:45 INFO - 'TERM': 'linux', 05:30:45 INFO - 'TMOUT': '86400', 05:30:45 INFO - 'USER': 'cltbld', 05:30:45 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789', 05:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:45 INFO - '_': '/tools/buildbot/bin/python'} 05:30:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:45 INFO - Downloading/unpacking psutil>=0.7.1 05:30: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 05:30: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 05:30: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 05:30: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 05:30: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 05:30: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 05:30:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:30:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:47 INFO - Installing collected packages: psutil 05:30:47 INFO - Running setup.py install for psutil 05:30:47 INFO - building 'psutil._psutil_linux' extension 05:30:47 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 05:30:47 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 05:30:47 INFO - building 'psutil._psutil_posix' extension 05:30:47 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 05:30:47 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 05:30:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:47 INFO - Successfully installed psutil 05:30:47 INFO - Cleaning up... 05:30:47 INFO - Return code: 0 05:30:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:30:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0fdcccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1554230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e67f0>, '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 0x15522d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1552760>, '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': '4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789', '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 05:30:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:30:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:30:47 INFO - Using env: {'DISPLAY': ':0', 05:30:47 INFO - 'HOME': '/home/cltbld', 05:30:47 INFO - 'LANG': 'en_US.UTF-8', 05:30:47 INFO - 'LANGUAGE': 'en_US:en', 05:30:47 INFO - 'LOGNAME': 'cltbld', 05:30:47 INFO - 'MAIL': '/var/mail/cltbld', 05:30:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:47 INFO - 'MOZ_NO_REMOTE': '1', 05:30:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:47 INFO - 'NO_EM_RESTART': '1', 05:30:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:47 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:47 INFO - 'SHELL': '/bin/bash', 05:30:47 INFO - 'SHLVL': '1', 05:30:47 INFO - 'TERM': 'linux', 05:30:47 INFO - 'TMOUT': '86400', 05:30:47 INFO - 'USER': 'cltbld', 05:30:47 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789', 05:30:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:47 INFO - '_': '/tools/buildbot/bin/python'} 05:30:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:30:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:30:49 INFO - Installing collected packages: mozsystemmonitor 05:30:49 INFO - Running setup.py install for mozsystemmonitor 05:30:50 INFO - Successfully installed mozsystemmonitor 05:30:50 INFO - Cleaning up... 05:30:50 INFO - Return code: 0 05:30:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:30:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0fdcccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1554230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e67f0>, '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 0x15522d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1552760>, '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': '4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789', '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 05:30:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:30:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:30:50 INFO - Using env: {'DISPLAY': ':0', 05:30:50 INFO - 'HOME': '/home/cltbld', 05:30:50 INFO - 'LANG': 'en_US.UTF-8', 05:30:50 INFO - 'LANGUAGE': 'en_US:en', 05:30:50 INFO - 'LOGNAME': 'cltbld', 05:30:50 INFO - 'MAIL': '/var/mail/cltbld', 05:30:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:50 INFO - 'MOZ_NO_REMOTE': '1', 05:30:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:50 INFO - 'NO_EM_RESTART': '1', 05:30:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:50 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:50 INFO - 'SHELL': '/bin/bash', 05:30:50 INFO - 'SHLVL': '1', 05:30:50 INFO - 'TERM': 'linux', 05:30:50 INFO - 'TMOUT': '86400', 05:30:50 INFO - 'USER': 'cltbld', 05:30:50 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789', 05:30:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:50 INFO - '_': '/tools/buildbot/bin/python'} 05:30:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:50 INFO - Downloading/unpacking blobuploader==1.2.4 05:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:52 INFO - Downloading blobuploader-1.2.4.tar.gz 05:30:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:30:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:30:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:52 INFO - Downloading docopt-0.6.1.tar.gz 05:30:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:30:52 INFO - Installing collected packages: blobuploader, requests, docopt 05:30:52 INFO - Running setup.py install for blobuploader 05:30:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:30:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:30:53 INFO - Running setup.py install for requests 05:30:53 INFO - Running setup.py install for docopt 05:30:53 INFO - Successfully installed blobuploader requests docopt 05:30:53 INFO - Cleaning up... 05:30:53 INFO - Return code: 0 05:30:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:30:53 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')]} 05:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:53 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')]} 05:30:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0fdcccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1554230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e67f0>, '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 0x15522d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1552760>, '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': '4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789', '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 05:30:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:30:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:30:53 INFO - Using env: {'DISPLAY': ':0', 05:30:53 INFO - 'HOME': '/home/cltbld', 05:30:53 INFO - 'LANG': 'en_US.UTF-8', 05:30:53 INFO - 'LANGUAGE': 'en_US:en', 05:30:53 INFO - 'LOGNAME': 'cltbld', 05:30:53 INFO - 'MAIL': '/var/mail/cltbld', 05:30:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:53 INFO - 'MOZ_NO_REMOTE': '1', 05:30:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:53 INFO - 'NO_EM_RESTART': '1', 05:30:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:53 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:53 INFO - 'SHELL': '/bin/bash', 05:30:53 INFO - 'SHLVL': '1', 05:30:53 INFO - 'TERM': 'linux', 05:30:53 INFO - 'TMOUT': '86400', 05:30:53 INFO - 'USER': 'cltbld', 05:30:53 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789', 05:30:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:53 INFO - '_': '/tools/buildbot/bin/python'} 05:30:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:30:53 INFO - Running setup.py (path:/tmp/pip-Ggx51e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:30:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:30:53 INFO - Running setup.py (path:/tmp/pip-OLf4YR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:30:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:30:53 INFO - Running setup.py (path:/tmp/pip-3Alutd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:30:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:30:54 INFO - Running setup.py (path:/tmp/pip-6EZrvH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:30:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:30:54 INFO - Running setup.py (path:/tmp/pip-tjRmKL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:30:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:30:54 INFO - Running setup.py (path:/tmp/pip-CCBP9C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:30:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:30:54 INFO - Running setup.py (path:/tmp/pip-9wYoC9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:30:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:30:54 INFO - Running setup.py (path:/tmp/pip-MMm_sF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:30:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:30:54 INFO - Running setup.py (path:/tmp/pip-41DyF6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:30:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:30:54 INFO - Running setup.py (path:/tmp/pip-zrgNNV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:30:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:30:54 INFO - Running setup.py (path:/tmp/pip-vMDnP_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:30:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:30:54 INFO - Running setup.py (path:/tmp/pip-p7NFMn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:30:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:30:54 INFO - Running setup.py (path:/tmp/pip-E7__WJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:30:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:30:54 INFO - Running setup.py (path:/tmp/pip-DSQHxm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:30:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:30:54 INFO - Running setup.py (path:/tmp/pip-Ldna5p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:30:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:30:54 INFO - Running setup.py (path:/tmp/pip-PexB6D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:30:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:30:54 INFO - Running setup.py (path:/tmp/pip-pbvChI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:30:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:30:55 INFO - Running setup.py install for manifestparser 05:30:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:30:55 INFO - Running setup.py install for mozcrash 05:30:55 INFO - Running setup.py install for mozdebug 05:30:55 INFO - Running setup.py install for mozdevice 05:30:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:30:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:30:55 INFO - Running setup.py install for mozfile 05:30:55 INFO - Running setup.py install for mozhttpd 05:30:55 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:30:55 INFO - Running setup.py install for mozinfo 05:30:55 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:30:55 INFO - Running setup.py install for mozInstall 05:30:55 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:30:55 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:30:55 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:30:55 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:30:55 INFO - Running setup.py install for mozleak 05:30:55 INFO - Running setup.py install for mozlog 05:30:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:30:56 INFO - Running setup.py install for moznetwork 05:30:56 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:30:56 INFO - Running setup.py install for mozprocess 05:30:56 INFO - Running setup.py install for mozprofile 05:30:56 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:30:56 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:30:56 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:30:56 INFO - Running setup.py install for mozrunner 05:30:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:30:56 INFO - Running setup.py install for mozscreenshot 05:30:56 INFO - Running setup.py install for moztest 05:30:56 INFO - Running setup.py install for mozversion 05:30:56 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:30:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:30:56 INFO - Cleaning up... 05:30:56 INFO - Return code: 0 05:30:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:30:56 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')]} 05:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:56 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')]} 05:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:30:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0fdcccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1554230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e67f0>, '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 0x15522d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1552760>, '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': '4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789', '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 05:30:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:30:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:30:56 INFO - Using env: {'DISPLAY': ':0', 05:30:56 INFO - 'HOME': '/home/cltbld', 05:30:56 INFO - 'LANG': 'en_US.UTF-8', 05:30:56 INFO - 'LANGUAGE': 'en_US:en', 05:30:56 INFO - 'LOGNAME': 'cltbld', 05:30:56 INFO - 'MAIL': '/var/mail/cltbld', 05:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:56 INFO - 'MOZ_NO_REMOTE': '1', 05:30:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:56 INFO - 'NO_EM_RESTART': '1', 05:30:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:30:56 INFO - 'PWD': '/builds/slave/test-pgo', 05:30:56 INFO - 'SHELL': '/bin/bash', 05:30:56 INFO - 'SHLVL': '1', 05:30:56 INFO - 'TERM': 'linux', 05:30:56 INFO - 'TMOUT': '86400', 05:30:56 INFO - 'USER': 'cltbld', 05:30:56 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789', 05:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:56 INFO - '_': '/tools/buildbot/bin/python'} 05:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:30:57 INFO - Running setup.py (path:/tmp/pip-qToWZw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:30:57 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)) 05:30:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:30:57 INFO - Running setup.py (path:/tmp/pip-H7Xbjk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:30:57 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)) 05:30:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:30:57 INFO - Running setup.py (path:/tmp/pip-Drplxs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:30:57 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)) 05:30:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:30:57 INFO - Running setup.py (path:/tmp/pip-aZD8FM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:30:57 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)) 05:30:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:30:57 INFO - Running setup.py (path:/tmp/pip-cn28lY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:30:57 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)) 05:30:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:30:57 INFO - Running setup.py (path:/tmp/pip-6wBasU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:30:57 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)) 05:30:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:30:57 INFO - Running setup.py (path:/tmp/pip-8UbLLG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:30:57 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)) 05:30:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:30:57 INFO - Running setup.py (path:/tmp/pip-eLdJHy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:30:57 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)) 05:30:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:30:57 INFO - Running setup.py (path:/tmp/pip-eGEQ1W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:30:57 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)) 05:30:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:30:57 INFO - Running setup.py (path:/tmp/pip-eF7NnP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:30:57 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)) 05:30:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:30:57 INFO - Running setup.py (path:/tmp/pip-vgNG0_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:30:57 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)) 05:30:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:30:57 INFO - Running setup.py (path:/tmp/pip-pWOmco-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:30:57 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)) 05:30:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:30:57 INFO - Running setup.py (path:/tmp/pip-fW6FPF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:30:57 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)) 05:30:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:30:57 INFO - Running setup.py (path:/tmp/pip-swqRCe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:30:58 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)) 05:30:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:30:58 INFO - Running setup.py (path:/tmp/pip-7gHZ0d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:30:58 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)) 05:30:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:30:58 INFO - Running setup.py (path:/tmp/pip-x6rA0T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:30:58 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)) 05:30:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:30:58 INFO - Running setup.py (path:/tmp/pip-pxq712-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:30:58 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)) 05:30:58 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)) 05:30:58 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)) 05:30:58 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)) 05:30:58 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)) 05:30:58 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)) 05:30:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:30: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 05:30: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 05:30: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 05:30: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 05:30: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 05:30: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 05:31:00 INFO - Downloading blessings-1.6.tar.gz 05:31:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:31:00 INFO - Installing collected packages: blessings 05:31:00 INFO - Running setup.py install for blessings 05:31:00 INFO - Successfully installed blessings 05:31:00 INFO - Cleaning up... 05:31:00 INFO - Return code: 0 05:31:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:31:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:31:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:31:00 INFO - Reading from file tmpfile_stdout 05:31:00 INFO - Current package versions: 05:31:00 INFO - argparse == 1.2.1 05:31:00 INFO - blessings == 1.6 05:31:00 INFO - blobuploader == 1.2.4 05:31:00 INFO - docopt == 0.6.1 05:31:00 INFO - manifestparser == 1.1 05:31:00 INFO - mozInstall == 1.12 05:31:00 INFO - mozcrash == 0.16 05:31:00 INFO - mozdebug == 0.1 05:31:00 INFO - mozdevice == 0.48 05:31:00 INFO - mozfile == 1.2 05:31:00 INFO - mozhttpd == 0.7 05:31:00 INFO - mozinfo == 0.9 05:31:00 INFO - mozleak == 0.1 05:31:00 INFO - mozlog == 3.1 05:31:00 INFO - moznetwork == 0.27 05:31:00 INFO - mozprocess == 0.22 05:31:00 INFO - mozprofile == 0.28 05:31:00 INFO - mozrunner == 6.11 05:31:00 INFO - mozscreenshot == 0.1 05:31:00 INFO - mozsystemmonitor == 0.0 05:31:00 INFO - moztest == 0.7 05:31:00 INFO - mozversion == 1.4 05:31:00 INFO - psutil == 3.1.1 05:31:00 INFO - requests == 1.2.3 05:31:00 INFO - wsgiref == 0.1.2 05:31:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0fdcccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1554230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e67f0>, '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 0x15522d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1552760>, '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': '4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789', '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 05:31:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:31:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:31:00 INFO - Using env: {'DISPLAY': ':0', 05:31:00 INFO - 'HOME': '/home/cltbld', 05:31:00 INFO - 'LANG': 'en_US.UTF-8', 05:31:00 INFO - 'LANGUAGE': 'en_US:en', 05:31:00 INFO - 'LOGNAME': 'cltbld', 05:31:00 INFO - 'MAIL': '/var/mail/cltbld', 05:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:00 INFO - 'MOZ_NO_REMOTE': '1', 05:31:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:00 INFO - 'NO_EM_RESTART': '1', 05:31:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:31:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:31:00 INFO - 'SHELL': '/bin/bash', 05:31:00 INFO - 'SHLVL': '1', 05:31:00 INFO - 'TERM': 'linux', 05:31:00 INFO - 'TMOUT': '86400', 05:31:00 INFO - 'USER': 'cltbld', 05:31:00 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789', 05:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:00 INFO - '_': '/tools/buildbot/bin/python'} 05:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:00 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)) 05:31:00 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)) 05:31:00 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)) 05:31:00 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)) 05:31:00 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)) 05:31:00 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)) 05:31:00 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)) 05:31:00 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)) 05:31:00 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)) 05:31:00 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)) 05:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:31:00 INFO - Cleaning up... 05:31:00 INFO - Return code: 0 05:31:00 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0fdcccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1554230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e67f0>, '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 0x15522d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1552760>, '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': '4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789', '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 05:31:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:31:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:31:00 INFO - Using env: {'DISPLAY': ':0', 05:31:00 INFO - 'HOME': '/home/cltbld', 05:31:00 INFO - 'LANG': 'en_US.UTF-8', 05:31:00 INFO - 'LANGUAGE': 'en_US:en', 05:31:00 INFO - 'LOGNAME': 'cltbld', 05:31:00 INFO - 'MAIL': '/var/mail/cltbld', 05:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:00 INFO - 'MOZ_NO_REMOTE': '1', 05:31:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:00 INFO - 'NO_EM_RESTART': '1', 05:31:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:31:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:31:00 INFO - 'SHELL': '/bin/bash', 05:31:00 INFO - 'SHLVL': '1', 05:31:00 INFO - 'TERM': 'linux', 05:31:00 INFO - 'TMOUT': '86400', 05:31:00 INFO - 'USER': 'cltbld', 05:31:00 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789', 05:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:00 INFO - '_': '/tools/buildbot/bin/python'} 05:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:00 INFO - Downloading/unpacking jsonschema 05:31: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 05:31: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 05:31: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 05:31: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 05:31: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 05:31: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 05:31:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:31:02 INFO - Downloading/unpacking functools32 (from jsonschema) 05:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:02 INFO - Downloading functools32-3.2.3-2.tar.gz 05:31:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:31:03 INFO - warning: no files found matching '*.txt' 05:31:03 INFO - no previously-included directories found matching 'build' 05:31:03 INFO - no previously-included directories found matching 'dist' 05:31:03 INFO - no previously-included directories found matching '.git*' 05:31:03 INFO - Installing collected packages: jsonschema, functools32 05:31:03 INFO - Running setup.py install for functools32 05:31:03 INFO - warning: no files found matching '*.txt' 05:31:03 INFO - no previously-included directories found matching 'build' 05:31:03 INFO - no previously-included directories found matching 'dist' 05:31:03 INFO - no previously-included directories found matching '.git*' 05:31:03 INFO - Successfully installed jsonschema functools32 05:31:03 INFO - Cleaning up... 05:31:03 INFO - Return code: 0 05:31:03 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0fdcccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1554230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e67f0>, '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 0x15522d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1552760>, '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': '4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789', '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 05:31:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:31:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:31:03 INFO - Using env: {'DISPLAY': ':0', 05:31:03 INFO - 'HOME': '/home/cltbld', 05:31:03 INFO - 'LANG': 'en_US.UTF-8', 05:31:03 INFO - 'LANGUAGE': 'en_US:en', 05:31:03 INFO - 'LOGNAME': 'cltbld', 05:31:03 INFO - 'MAIL': '/var/mail/cltbld', 05:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:03 INFO - 'MOZ_NO_REMOTE': '1', 05:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:03 INFO - 'NO_EM_RESTART': '1', 05:31:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:31:03 INFO - 'PWD': '/builds/slave/test-pgo', 05:31:03 INFO - 'SHELL': '/bin/bash', 05:31:03 INFO - 'SHLVL': '1', 05:31:03 INFO - 'TERM': 'linux', 05:31:03 INFO - 'TMOUT': '86400', 05:31:03 INFO - 'USER': 'cltbld', 05:31:03 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789', 05:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:03 INFO - '_': '/tools/buildbot/bin/python'} 05:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:03 INFO - Downloading/unpacking flake8 05:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:31:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:31:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:31:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:31:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:31:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:31:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:31:05 INFO - no previously-included directories found matching 'docs/_build' 05:31:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:31:06 INFO - Running setup.py install for pep8 05:31:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:31:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:31:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:31:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:31:06 INFO - no previously-included directories found matching 'docs/_build' 05:31:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:31:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:31:06 INFO - Cleaning up... 05:31:06 INFO - Return code: 0 05:31:06 INFO - Running post-action listener: _resource_record_post_action 05:31:06 INFO - Running post-action listener: _start_resource_monitoring 05:31:06 INFO - Starting resource monitoring. 05:31:06 INFO - ##### 05:31:06 INFO - ##### Running install step. 05:31:06 INFO - ##### 05:31:06 INFO - Running pre-action listener: _resource_record_pre_action 05:31:06 INFO - Running main action method: install 05:31:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:31:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:31:06 INFO - Reading from file tmpfile_stdout 05:31:06 INFO - Detecting whether we're running mozinstall >=1.0... 05:31:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:31:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:31:06 INFO - Reading from file tmpfile_stdout 05:31:06 INFO - Output received: 05:31:06 INFO - Usage: mozinstall [options] installer 05:31:06 INFO - Options: 05:31:06 INFO - -h, --help show this help message and exit 05:31:06 INFO - -d DEST, --destination=DEST 05:31:06 INFO - Directory to install application into. [default: 05:31:06 INFO - "/builds/slave/test-pgo"] 05:31:06 INFO - --app=APP Application being installed. [default: firefox] 05:31:06 INFO - mkdir: /builds/slave/test-pgo/build/application 05:31:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:31:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:31:21 INFO - Reading from file tmpfile_stdout 05:31:21 INFO - Output received: 05:31:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:31:21 INFO - Running post-action listener: _resource_record_post_action 05:31:21 INFO - ##### 05:31:21 INFO - ##### Running run-tests step. 05:31:21 INFO - ##### 05:31:21 INFO - Running pre-action listener: _resource_record_pre_action 05:31:21 INFO - Running main action method: run_tests 05:31:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:31:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:31:21 INFO - Python 2.7.3 05:31:21 INFO - Return code: 0 05:31:21 INFO - grabbing minidump binary from tooltool 05:31:21 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')]} 05:31:21 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 0x15e67f0>, '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 0x15522d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1552760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:31:21 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 05:31:21 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 05:31:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:31:21 INFO - Return code: 0 05:31:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:31:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:31:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:31:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:31:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:31:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:31:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:31:22 INFO - Return code: 0 05:31:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 05:31:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:31:22 INFO - Using env: {'DISPLAY': ':0', 05:31:22 INFO - 'HOME': '/home/cltbld', 05:31:22 INFO - 'LANG': 'en_US.UTF-8', 05:31:22 INFO - 'LANGUAGE': 'en_US:en', 05:31:22 INFO - 'LOGNAME': 'cltbld', 05:31:22 INFO - 'MAIL': '/var/mail/cltbld', 05:31:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:31:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:22 INFO - 'MOZ_NO_REMOTE': '1', 05:31:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:31:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:22 INFO - 'NO_EM_RESTART': '1', 05:31:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:31:22 INFO - 'PWD': '/builds/slave/test-pgo', 05:31:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:31:22 INFO - 'SHELL': '/bin/bash', 05:31:22 INFO - 'SHLVL': '1', 05:31:22 INFO - 'TERM': 'linux', 05:31:22 INFO - 'TMOUT': '86400', 05:31:22 INFO - 'USER': 'cltbld', 05:31:22 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789', 05:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:22 INFO - '_': '/tools/buildbot/bin/python'} 05:31:22 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:31:22 INFO - mozversion application_buildid: 20160225005029 05:31:22 INFO - mozversion application_changeset: a28dc9d1e31e03b79c0ace56d9cd2527d98cb11f 05:31:22 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:31:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:31:22 INFO - mozversion application_name: Firefox 05:31:22 INFO - mozversion application_remotingname: firefox-dev 05:31:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:31:22 INFO - mozversion application_vendor: Mozilla 05:31:22 INFO - mozversion application_version: 46.0a2 05:31:22 INFO - mozversion platform_buildid: 20160225005029 05:31:22 INFO - mozversion platform_changeset: a28dc9d1e31e03b79c0ace56d9cd2527d98cb11f 05:31:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:31:22 INFO - mozversion platform_version: 46.0a2 05:31:22 INFO - using testdate: 1456579882 05:31:22 INFO - actual date: 1456579882 05:31:22 INFO - starting webserver on 'localhost:43533' 05:31:22 INFO - SUITE-START | Running 3 tests 05:31:22 INFO - TEST-START | dromaeo_css 05:31:22 INFO - operating with platform_type : linux_ 05:31:22 INFO - Initialising browser for dromaeo_css test... 05:31:22 INFO - TEST-INFO | started process 6818 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzaDDxD/profile http://localhost:43533/getInfo.html) 05:31:26 INFO - PROCESS | 6818 | 05:31:26 INFO - PROCESS | 6818 | (process:6895): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:31:27 INFO - PROCESS | 6818 | __metrics Screen width/height:1600/1200 05:31:27 INFO - PROCESS | 6818 | colorDepth:24 05:31:27 INFO - PROCESS | 6818 | Browser inner width/height: 1024/697 05:31:27 INFO - PROCESS | 6818 | __metrics 05:31:28 INFO - TEST-INFO | 6818: exit 0 05:31:28 INFO - Browser initialized. 05:31:28 INFO - Running cycle 1/1 for dromaeo_css test... 05:31:28 INFO - TEST-INFO | started process 6944 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzaDDxD/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:31:29 INFO - PROCESS | 6944 | 05:31:29 INFO - PROCESS | 6944 | (process:7009): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:31:40 INFO - PROCESS | 6944 | RSS: Main: 140898304 05:31:40 INFO - PROCESS | 6944 | 05:32:29 INFO - PROCESS | 6944 | 1456579949733 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] 05:34:37 INFO - PROCESS | 6944 | Cycle 1(1): loaded http://localhost:43533/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43533/tests/dromaeo/cssquery-ext.html) 05:34:38 INFO - PROCESS | 6944 | RSS: Main: 145747968 05:34:38 INFO - PROCESS | 6944 | 05:37:40 INFO - PROCESS | 6944 | Cycle 1(1): loaded http://localhost:43533/tests/dromaeo/cssquery-ext.html (next: http://localhost:43533/tests/dromaeo/cssquery-jquery.html) 05:37:40 INFO - PROCESS | 6944 | RSS: Main: 144871424 05:37:40 INFO - PROCESS | 6944 | 05:40:42 INFO - PROCESS | 6944 | Cycle 1(1): loaded http://localhost:43533/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43533/tests/dromaeo/cssquery-mootools.html) 05:40:43 INFO - PROCESS | 6944 | RSS: Main: 143536128 05:40:43 INFO - PROCESS | 6944 | 05:43:44 INFO - PROCESS | 6944 | Cycle 1(1): loaded http://localhost:43533/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43533/tests/dromaeo/cssquery-prototype.html) 05:43:45 INFO - PROCESS | 6944 | RSS: Main: 143323136 05:43:45 INFO - PROCESS | 6944 | 05:46:47 INFO - PROCESS | 6944 | Cycle 1(1): loaded http://localhost:43533/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43533/tests/dromaeo/cssquery-yui.html) 05:46:48 INFO - PROCESS | 6944 | RSS: Main: 143941632 05:46:48 INFO - PROCESS | 6944 | 05:49:50 INFO - PROCESS | 6944 | Cycle 1(1): loaded http://localhost:43533/tests/dromaeo/cssquery-yui.html (next: http://localhost:43533/tests/dromaeo/cssquery-dojo.html) 05:49:50 INFO - PROCESS | 6944 | RSS: Main: 147132416 05:49:50 INFO - PROCESS | 6944 | 05:49:50 INFO - PROCESS | 6944 | __start_tp_report 05:49:50 INFO - PROCESS | 6944 | _x_x_mozilla_page_load 05:49:50 INFO - PROCESS | 6944 | _x_x_mozilla_page_load_details 05:49:50 INFO - PROCESS | 6944 | |i|pagename|runs| 05:49:50 INFO - PROCESS | 6944 | |0;dojo.html;3316.5356850040985;3348.2633820559486;3356.16095976006;3358.5130156127357;3371.966280337199;5535.280413546238;5549.417311182328;5552.666839989603;5560.304961879765;5564.443555644433;5533.253010843535;5581.6371935824245;5595.888082238353;5606.439356064391;5613.21415001899;5073.467285934979;5109.821156259532;5150.33045704058;5172.017316709813;5242.798024829562;4956.107900577895;5016.372953380827;5092.592592592584;5107.3360463139925;5125.769340379673;5101.642884998052;5119.411267704206;5152.227165925104;5156.948430515685;5167.173252279636;5144.202648589475;5155.716435596022;5162.535371816517;5176.964607078599;5195.6622819516615;4914.606831453475;4992.90014199714;5064.088464076464;5066.670666406671;5067.594592432597;5301.204819277139;5313.3092697949405;5323.653962492425;5324.627276090675;5325.121354976424;5894.941050589482;5906.497947674453;5953.434423729739;5963.671998040106;5974.820755377345;5908.586398952075;5986.132010858445;5996.100584912255;5998.340182579913;6005.3394126646035;5613.550915926716;5639.577031722637;5648.887022259573;5649;5695.7152142392715;6035.30593981689;6052.757889684363;6068.666223357669;6071.787487437919;6076.240469941257;5746.339170995389;5853.473187413068;5856.912146317723;5864.970675146597;5894.705264736746;5879.5002424794375;5928.762849486058;5996.940030599638;6010.54920880927;6040.486558642565;5816.098504731774;5888.646681199141;5904.261967254093;5913.852153696106;5920.644761314335;5793.623414478046;5912.3496415394275;5923.200367950358;5924.5852790305125;5926.377730338339;4487.842925497657;4516.36770852081;4542.977285113553;4543.091381723602;4579.427571553556;4110.17796440713;4112.362583799516;4114.691398145151;4129.009037830899;4146.854860079883;5469.644473109235;5486.91769623456;5527.170924361298;5554.055810512223;5558.44415558441;5922.052471604523;5933.1396947443245;5951.196588460502;5999.970000150059;6028.608140470856;5566.944330556724;5582.525485333711;5597.944020559824;5599.7480113394995;5603.691796951207;5017.724025178651;5099.745012749348;5104.540591346797;5140.074786538459;5175.223716442564;6096.329403765582;6132.2331366082535;6133.197417601116;6145.631262124287;6154.907676384858;5915.438033386821;5920.881582368328;5924.200232968494;5925.851853703692;5926.348101708722;5892.086726557391;5963.761449541969;5979.701014949323;6040.426159514839;6075.301340345917;5885.352611212848;5910.143029260647;5912.142739302691;5923.526117910471;5932.584719069624;5975.25309336333;5989.550783691154;5991.191189189403;5999.070144127667;6002.189704390026;5722.5421966241765;5798.478136967693;5835.8541036472725;5860.062390017577;5913.349531551612;5754.136879468113;5772.5381969441505;5786.334571524329;5796.62321949072;5803.100519419497;5707.800226992035;5708.686022268815;5715.542756579547;5718.428157184248;5729.2265544151005;5705.885882282414;5744;5744.913826292693;5841.795537156179;5875.882482350244;5693.971530142323;5709.771609135588;5717.42825717425;5733.31200255972;5738 05:49:50 INFO - PROCESS | 6944 | |1;ext.html;538.3727956930177;561.5956511311855;573.4122524412477;576.4464767451719;593.5103539579848;39680;40538.18923621526;40781.184376312456;40837.7958110209;40867;42749.14501709964;42759.14481710364;43054;43425.131497370036;43487.78256108723;8814.735557933256;9091.999880013193;9099.22656574192;9118.088191180863;9132.771680708001;8703;8757.343199260049;8775.868361974544;8791.516466594334;8800.647974081028;8796.296296296281;8881.644734210624;8920.910790892105;8921.33090018248;8931.240844528224;8706.1729135732;8786.209241168262;8834.779130521756;8846.557672116369;8857.911420885774;8836.381453298272;8891.644334226688;8935.865962010575;8952.68665596701;8967.596458159333;40186.79906600477;40688.186236275105;40707;40713;40733.79633101845;3352.932941341184;3441.7934923904395;3486.4073107571776;3618.8009659468717;3818.885433437001;30966.84516577425;31147.844260778777;31196.844015779774;31462.213444663837;32086;4208.789560521992;4240.957590424118;4300.80646370914;4373.825046998117;4412;276012;276077;276614;277703;337351;56993.43006569881;57389.713051434475;57569.71215143981;57655.71172144113;57814;61277;61365.386346135965;61602;61869;61934.38065619376;16924.746128808078;17148.914255428645;17153.656926861393;17160.31358745661;17210.569735756708;13044.152130111703;13336.933315333361;13634.795478067837;13644.454221831214;13733.381997810122;20561;20757.792422075585;20897.89551052235;20898.059587318607;21057.789422105583;8352.331813454908;8555.828883422297;8593.828123437495;8608.698695545625;8628.094050124771;1030.386919782728;1100.0649447969322;1118.8937050980144;1167.544657583543;1170.011340417346;30292.54561181584;30467.847660761556;30956.535651965238;30968.535471967938;31519.684803151675;1163.081165878963;1198.4906414773686;1230.354064116346;1245.495574292413;1287.8905293050009;15962.68074638524;16010.439634612732;16046.518604441886;16053.357865685475;16406.83593164077;326179;502679;508340;529906;543304;57189;57813;58002.419975799705;58178.127328090115;58321.41678583244;1456.3082535795625;1521.9391224350902;1522.360608544414;1523.6114790728293;1526.7404541228018;30822.383552328378;31492.527612086295;31599;31939.680603193672;32217.35565288728;46203.3069503951;47679.52320476751;47727.52272477231;47818;47897;302358;303305;306230;307428;308153;33716.15709607279;34014.319713605095;34016.319673605896;34624.48063279002;34627;43583.12833743371;43944.12111757683;43947;44349;44848.55151448444;37394;37684.811575941945;37689.246215075;38743.2251354977;39180.608193917695;38224.23551529009;39835;41578.168436631706;41927.58072419237;41988;35747.10632234215;36091.27817443689;36147.45778813267;36356.27287454289;36617.81691091634;30035.849820750755;31876.36247275088;31922.20194495156;31969.200769980936;32117.518237226926;26890.731092689606;27288.317792055357;27573.44853102967;27613.171604851887;27618.028421392555 05:49:50 INFO - PROCESS | 6944 | |2;jquery.html;386.0252861524652;388.4639197906888;388.83543786359854;390.23124444843654;396.0850435494007;15774.21128943551;16722.832771672278;16848.915755421236;19184.808151918478;19231.519212019706;16836.24236909339;16842.157892105377;17120.229589668463;17235.482935511955;18160.909195454038;5060.39275286966;5681.715914204273;5714.1428785682065;5717.42825717427;5722.685252311121;5452.345718513784;5627.971860140694;5641.802536911209;5649.774009039654;5651.8587035324035;5542.528885044776;5611.831645050655;5616.354119276295;5639.379668236491;6081.695915204245;6125.111858780474;6143.232095988002;6156.630602163885;6172.382761723837;6179.876402471948;5392.299001129828;5596.776128954837;5612.354579223401;5617.606767526275;5620.747066382022;13997.720045599031;15760.527184184493;20768.688469672816;21279.574408511744;21298.25456109029;2135.562209746998;2195.9890200548894;2196.4728465168246;2229.4537838229576;2269.5914735347633;10198.439085850276;10253.282270241087;10332;10443.79112417755;10481.318714283547;1847.8891266523917;1874.4189301316635;1889.8299153076289;1930.6524825531399;1976.4861136104573;59579.702101489645;60204.698976504835;60347.39652603505;60549.09176362402;60678.393216067714;11013.449327533592;11065.446727663746;11075.50160242791;11087.22389432732;11122.55509779616;14668.119912805267;14747.77878331826;14759.92620036893;14788;14795.408183672747;8266.256036956704;8285.088640249567;8357.791055223668;8357.958210209032;8376.581170941428;8020.2781749641645;8058.959705201553;8059.959700201462;8064.435489515795;8096.271335579826;4679.321498382716;4687.20317546018;4742.762861856893;4749.738764367993;4802.327674125625;1979.3072424651257;1994.192352097374;2002.5294055896852;2017.485541186988;2018.5458271889001;487.4199702354187;493.92344186651127;986.2356673577891;1000.6797824696027;1081.5025088459397;11003;11039.724006899893;11086.611968581223;11275.154363422776;11528.135389845795;495.7248726956574;498.5737194698553;503.6071863946055;517.9456157103525;524.9972552424927;6241.095041218998;6344.365563443711;6420.967895160495;6432.35676432353;6444.548881578245;550449;563261;563421;571725;572651;47675.284870726966;48632.27051594229;49332.50667493351;57492;75364.62317688376;1166.5567084508002;1201.7896868048056;1204.4399354300292;1207.1007099710596;1215.9817602735789;16125.575112280821;16228.107454090139;16318.918405407898;16332.755008675116;16619.3352265908;31695.36609267848;34188.48717269293;34473.482897756054;34984.72599281039;35405.645943540236;37308.25383492369;43560.128797424506;45583.54416455793;45728;46250.30624540567;7680.385569154566;7800.4149688774705;7928.167542408195;7966.522008679498;8084.919150808417;11179.72050698739;11457.369844658291;11720.120990925885;12053.879461205275;12312.81530777057;10693.572257109628;11008.229423940247;11035.889641103486;11208.215424920178;11310.4910279036;3233.708966193054;5408.891822163613;9739.318247722591;10976.890231097586;10983.286086404358;10009.849852252077;10613.522391492555;10636.52135653913;10658.413787241467;11246.437678116225;7754.418418618513;7790.844183116419;7886.921130788619;7984.960075199587;8071.394645401501;9457.19613832832;10621.203409744454;10629.202809789142;10727.40999245049;10909.945450272699 05:49:50 INFO - PROCESS | 6944 | |3;mootools.html;1564.053747482773;1575.0628376116206;1831.5878927241372;1885.3872491440286;1939.6508628446875;8131.430799844006;8210.50736955783;8346.749597512076;8346.91653083469;8393.874091888627;8356.456830306026;8356.623951922164;8377.287930525912;8384.287335576468;8418.536980466071;2311.4799170186698;2325.988370058147;2331.8484298520625;2343.7773411525877;2352.882355882199;2434.099383228208;2437.402836305099;2465.864377459239;2469.987650061747;2470.0984140788573;2308.8383813133087;2346.5072334809624;2380.428697112689;2386.689730335054;2399.196269249803;2324.081987614891;2328.7089113860766;2331;2335.1710142899283;2341.6487526870937;2318.652202169671;2350.894209760565;2351.8000969917575;2361.563110824503;2377.274931146017;7768.262015108556;7807.882881756778;7814.140444551095;7817.804554886116;7828.843423131506;4925.039617274633;5089.440161582223;5113.411957624883;5117.181250999822;5119.87200319995;3138.089953913385;3143.654198038214;3157.1002264354547;3160.146760374686;3161.2729072313496;1025.3642741500244;1029.9588016479331;1037.9724073167586;1058.2645061682133;1064.7391389109719;10685.038346548848;10861.3483191008;10899.782004359948;10955.83566246507;10993.780124397466;4323.69734118615;4332.480102387671;4358.8155370843715;4374.606285434326;4392.604665580113;8521.190486903733;8544.658213671508;8644.654213831376;8656.437331573428;8666.523341216167;4794.4486384065585;4819.807207711652;4836.419629644395;4853.417589889165;4867.9269810952865;4376.081022985145;4377.562243775661;4383.715058521186;4399;4420.447444069491;3570.785752854837;3637.1452708613456;3653.963460365362;3658.8902332929524;3696.6857817085847;1077.859878215827;1087.8150714378417;1095.0746619106842;1097.550004498168;1119.6249256499163;996.6013594562088;996.9482196282846;1101.8512500812287;1303.2962200411862;1461.5834487171105;7509.13644930829;7521.9247807522315;7542.6605802739;7559.357454616419;7628.580428076398;672.6939242644585;673.3468535520635;677.9220389655154;686.8488932434856;819.2585709932521;5989.880202396015;6001.609895356788;6021.42796434338;6040.697965101727;6057.666828324396;9188.8621670675;9364.672236471692;9697.612095516242;9808.607655693691;9819.41083534976;9532.761680958032;9546.379485333431;9588.856167157359;9620.567074481665;9725;7390.482666213421;7600;7608.0489938757655;7653.693852245848;7691.961540192375;7289.125304963226;7298;7310.853782924205;7319.2314806944505;7362.9631851840395;8389.161083891806;8431.325493960347;8608.827823443622;8620.655173792979;8768;8583.527905964982;8687.522186279562;8698.347623928357;8702.651893924172;8846.646134154562;6581.901271480836;6687.6321802301345;6702;6705.195376554844;6710.932890671031;7557.584332861746;7616.7334143304715;7619.847603048019;7639.809004774925;7653.502522336031;6952.513324067267;7115.6086415247655;7403.889416587555;7610.200928902385;7694.923050769421;6848.417884479875;7295.598742069237;7300.853982920418;7324;7329.780106596811;7407.1852096268285;7455.739049133254;7457.366123879531;7467.663955121924;7475.88786168197;6910.896336555056;6958.8956165658565;6984.022236886942;7015.123109611299;7033.824154396181;6870.656467176721;6928.4803639726215;6961.965190174017;7115.217326094229;7149.785506434815 05:49:50 INFO - PROCESS | 6944 | |4;prototype.html;366.10852573982356;377.8205352457583;378.58355808610514;381.43928425214926;386.88393481955404;6394;6401.839954001152;6411.102445657606;6416.973284274517;6674.933250667492;6434.356564343563;6442.742290308382;6450.838729031777;6468.0944667746435;6468.902966455507;4953;4955.529224723664;4959.752012399384;4963.205887058053;4963.801447942078;4971.105201063807;4971.527704868032;4979.078870408968;4983.900321993558;4994.051130285234;4859.052484765472;4938.283948827418;4938.925916111261;4942.406911170647;4963.40439147301;4896.192128298826;4899.877503062434;4939.283803848458;4940.135476291634;4950.059488697172;4291.463567054118;4316.050468896838;4317.417148684919;4318.82724691012;4343.391925130484;6006.309274433409;6111;6115.113308570277;6133.080037994292;6138.14066030756;5796.333421656522;5799.18811366409;5802.680852553108;5803.564732645069;5832.854178645525;6878.931210687879;6889.896651550231;6902.447804175654;6906.240313565504;6996.230414654384;4813.9890622969215;4823.372961515016;4836.129496690594;4838.346823178861;4839.104765618336;6972.616506092163;7082.468814838908;7191.748288809867;7191.748288809918;7228.421726261939;4840.709557426566;4853.199222128309;4865.0756356292195;4866.683665561727;4869.342638743795;4913.606911447076;4928.704277743275;4935.925961110586;4938.234573641092;4948.505149485023;5618.52242559387;5667.659940403589;5673.687947162945;5708.600397972102;5723.627964182315;6915.654217289115;6921.7231310747;6955.443564514827;7003.439724822104;7017.122859642544;1719.0974738262512;1738.4263193146232;1780.5904641932427;1784.8036715961234;1786.2497750944635;1175.529788084773;1200.5977997370803;1203.554684766642;1206.2702065250396;1220.6094049904123;6455.7740479083;6459.321771214049;6491.902621460682;6492.448141907897;6501.707423165969;6986.580805151707;6990.790276291719;6995.650217489105;7008.824779380557;7028.92971070293;6353.555251132469;6432.967835160888;6469.77355792545;6472.870542589122;6484.708188131545;3803.8858834235016;3816.656500914931;3831.4061320495366;3856.5950575189763;3856.807159642007;7144.071270734771;7174.426045916314;7195.46034047438;7227.27727227273;7256.7822965311125;7153.284671532805;7227.89158162628;7248.166460857069;7251.5286506376915;7407.740729074457;7415.851682966419;7420.962895185489;7424.740134095281;7429;7454.589997550187;7206.063211782434;7208;7237.203907570269;7248.492605517563;7253.601051942193;6945.374916257561;7049.436045116481;7073.080499535027;7108.289171082851;7113.0753002109395;7367.963160184165;7386.630668466662;7403.000594919617;7403.370713489198;7405.259474052552;4917.237828136645;4991.925121123259;5002.52476014778;5011.09800235961;5014.52362025607;7070.8232294191;7075.221725610281;7198.820029499305;7212.4951253411755;7226.566406015446;7036.542624729376;7049.365557099885;7052.118485189351;7054.964725176546;7091.64541772899;6920.169579650475;6936.375726184668;6942.271061538668;6981.057557229709;6985.057017302599;6645.966770166118;6857.5199736019995;6938.340857618518;6962.3385778353;6962.7911162665205;6974.6861391238535;7003.194632617314;7005.334493223136;7026.1217347831525;7033.402160816388;6753.493487988322;6785.117934668461;6939.514234003773;6943.340382663639;6945 05:49:50 INFO - PROCESS | 6944 | |5;yui.html;787.6180052674453;789.1398375770416;874.6676263020054;884.5311984648134;914.5107367558353;12970.351482425876;13003.544875929345;13120.015998800092;13135;13213.7357252855;13861.722765544682;13919.164850109;13935.44258229672;13987.930060349683;14016.22910739909;872.8385248728973;893.9865902011475;896.7623579751371;897.3180382908971;902;866.58403966096;866.7053201911349;868.7784614923186;875.6103533927405;878.9033206347297;911.8404279251138;916.0656130746635;922.1470140120396;923.6628630549834;924.0943875002469;912.0879120879088;916.8395530782086;923.0953665407905;923.3997901364099;925.2320573923695;675.2605896543278;678.7522554267706;680.4930326906436;682.7712716240065;684.4319215051495;13718.65703357414;13748.587542373745;13767.449302027906;13784.241866697328;13809.654758631013;13525.458981640722;13551.186928784304;13773.173609583357;13905.930470347583;14296.714065718732;11352.14858885587;11422.14333924959;11631.302121872715;11659.125565582615;11828.645140645795;3882.9805850970565;3885.067583779901;3895.7272990890647;3897.8830635080994;3909.2963266612;52229.47770522284;52370.73814630903;52378.7381063096;52506.94986100295;52733.47266527362;11078.446077696082;11290.830637540443;11316.377599231957;11389.544418223344;11401.600943966921;19470.318538851072;19477.12352944121;19485.318013869448;19574.217031318873;19665.803341966683;8144.918550814535;8214.383921205934;8411.117042240088;8667.869981950276;8676.60955257015;4459.9331010034875;4465.754383508874;4546.954530454719;4639.512851150648;4643.930341044887;3309.255417531036;3318.634950155529;3333.2000319923045;3338.749593780476;3350.128966468687;550.5513006899445;603.1736520966217;605.1286147946943;610.0300522169771;612.0268772651506;559.8824246908194;574.2333984131232;626.9247690277195;678.4877417549817;712.9500934934505;9392.624295028123;9699.185541882222;9826.4104153751;9885.802283954425;9945.900540994497;513.1532970598468;531.2376739379004;582.4932308891292;633.2003414120952;725.6263024542365;4191.958080419217;4541.909161816745;4542.750148741785;4591.242444996538;4751.904961900743;63238.68380658067;63446.36553634405;63691.68154159199;63975.68012159909;63991.36008639854;54645.72677136589;56370.718146409;57471;57821.421785781604;58080.70959645175;49222.26166607432;50657.746711266205;51036.48963510391;52808.73595631997;53819;10095.343802652804;10180.338278012201;10278.588856445658;10339.327943683636;10388.532516036645;38621.227575448895;38776;39119.41320880132;39307.6069239304;39578.406323904586;46306.53693463157;49059.5094049055;50802.74598626983;51046.23430648618;51208.23187652263;13081.345932703518;13122.60632181036;13147.14543554666;13269.734605308033;13394.464221431423;13196.60410187696;13241.735165296448;13262.403191856196;13308.201507909556;13448.058635895393;12210.57262995791;12279.079069069678;12653.683657908627;13046.282454465096;13317.866821331663;12521.436535356113;12646.430910609228;12837.358132093545;12892.935535322264;12906.548270810477;11364;11902.988245999188;12178.208416452902;12728.427220774902;13240.602781916557;9714.611415543299;10453.557238173898;10473.26687131924;10574.788504230026;10841.945790270998;10467.947660261954;10877;11096.167787415814;11418.31490110596;11490.08079353633 05:49:50 INFO - PROCESS | 6944 | __end_tp_report 05:49:50 INFO - PROCESS | 6944 | __start_cc_report 05:49:50 INFO - PROCESS | 6944 | _x_x_mozilla_cycle_collect,304 05:49:50 INFO - PROCESS | 6944 | __end_cc_report 05:49:50 INFO - PROCESS | 6944 | __startTimestamp1456580990450__endTimestamp 05:49:50 INFO - PROCESS | 6944 | 05:49:50 INFO - PROCESS | 6944 | ------- Summary: start ------- 05:49:50 INFO - PROCESS | 6944 | Number of tests: 6 05:49:50 INFO - PROCESS | 6944 | 05:49:50 INFO - PROCESS | 6944 | [#0] dojo.html Cycles:165 Average:5520.79 Median:5718.43 stddev:597.08 (10.4%) stddev-sans-first:573.32 05:49:50 INFO - PROCESS | 6944 | Values: 3316.5 3348.3 3356.2 3358.5 3372.0 5535.3 5549.4 5552.7 5560.3 5564.4 5533.3 5581.6 5595.9 5606.4 5613.2 5073.5 5109.8 5150.3 5172.0 5242.8 4956.1 5016.4 5092.6 5107.3 5125.8 5101.6 5119.4 5152.2 5156.9 5167.2 5144.2 5155.7 5162.5 5177.0 5195.7 4914.6 4992.9 5064.1 5066.7 5067.6 5301.2 5313.3 5323.7 5324.6 5325.1 5894.9 5906.5 5953.4 5963.7 5974.8 5908.6 5986.1 5996.1 5998.3 6005.3 5613.6 5639.6 5648.9 5649.0 5695.7 6035.3 6052.8 6068.7 6071.8 6076.2 5746.3 5853.5 5856.9 5865.0 5894.7 5879.5 5928.8 5996.9 6010.5 6040.5 5816.1 5888.6 5904.3 5913.9 5920.6 5793.6 5912.3 5923.2 5924.6 5926.4 4487.8 4516.4 4543.0 4543.1 4579.4 4110.2 4112.4 4114.7 4129.0 4146.9 5469.6 5486.9 5527.2 5554.1 5558.4 5922.1 5933.1 5951.2 6000.0 6028.6 5566.9 5582.5 5597.9 5599.7 5603.7 5017.7 5099.7 5104.5 5140.1 5175.2 6096.3 6132.2 6133.2 6145.6 6154.9 5915.4 5920.9 5924.2 5925.9 5926.3 5892.1 5963.8 5979.7 6040.4 6075.3 5885.4 5910.1 5912.1 5923.5 5932.6 5975.3 5989.6 5991.2 5999.1 6002.2 5722.5 5798.5 5835.9 5860.1 5913.3 5754.1 5772.5 5786.3 5796.6 5803.1 5707.8 5708.7 5715.5 5718.4 5729.2 5705.9 5744.0 5744.9 5841.8 5875.9 5694.0 5709.8 5717.4 5733.3 5738.0 05:49:50 INFO - PROCESS | 6944 | 05:49:50 INFO - PROCESS | 6944 | [#1] ext.html Cycles:180 Average:52888.66 Median:38961.92 stddev:98458.76 (252.7%) stddev-sans-first:98656.51 05:49:50 INFO - PROCESS | 6944 | Values: 538.4 561.6 573.4 576.4 593.5 39680.0 40538.2 40781.2 40837.8 40867.0 42749.1 42759.1 43054.0 43425.1 43487.8 8814.7 9092.0 9099.2 9118.1 9132.8 8703.0 8757.3 8775.9 8791.5 8800.6 8796.3 8881.6 8920.9 8921.3 8931.2 8706.2 8786.2 8834.8 8846.6 8857.9 8836.4 8891.6 8935.9 8952.7 8967.6 40186.8 40688.2 40707.0 40713.0 40733.8 3352.9 3441.8 3486.4 3618.8 3818.9 30966.8 31147.8 31196.8 31462.2 32086.0 4208.8 4241.0 4300.8 4373.8 4412.0 276012.0 276077.0 276614.0 277703.0 337351.0 56993.4 57389.7 57569.7 57655.7 57814.0 61277.0 61365.4 61602.0 61869.0 61934.4 16924.7 17148.9 17153.7 17160.3 17210.6 13044.2 13336.9 13634.8 13644.5 13733.4 20561.0 20757.8 20897.9 20898.1 21057.8 8352.3 8555.8 8593.8 8608.7 8628.1 1030.4 1100.1 1118.9 1167.5 1170.0 30292.5 30467.8 30956.5 30968.5 31519.7 1163.1 1198.5 1230.4 1245.5 1287.9 15962.7 16010.4 16046.5 16053.4 16406.8 326179.0 502679.0 508340.0 529906.0 543304.0 57189.0 57813.0 58002.4 58178.1 58321.4 1456.3 1521.9 1522.4 1523.6 1526.7 30822.4 31492.5 31599.0 31939.7 32217.4 46203.3 47679.5 47727.5 47818.0 47897.0 302358.0 303305.0 306230.0 307428.0 308153.0 33716.2 34014.3 34016.3 34624.5 34627.0 43583.1 43944.1 43947.0 44349.0 44848.6 37394.0 37684.8 37689.2 38743.2 39180.6 38224.2 39835.0 41578.2 41927.6 41988.0 35747.1 36091.3 36147.5 36356.3 36617.8 30035.8 31876.4 31922.2 31969.2 32117.5 26890.7 27288.3 27573.4 27613.2 27618.0 05:49:50 INFO - PROCESS | 6944 | 05:49:50 INFO - PROCESS | 6944 | [#2] jquery.html Cycles:180 Average:28002.14 Median:387.24 stddev:92008.25 (23759.7%) stddev-sans-first:92242.98 05:49:50 INFO - PROCESS | 6944 | Values: 386.0 388.5 388.8 390.2 396.1 15774.2 16722.8 16848.9 19184.8 19231.5 16836.2 16842.2 17120.2 17235.5 18160.9 5060.4 5681.7 5714.1 5717.4 5722.7 5452.3 5628.0 5641.8 5649.8 5651.9 5542.5 5611.8 5616.4 5639.4 6081.7 6125.1 6143.2 6156.6 6172.4 6179.9 5392.3 5596.8 5612.4 5617.6 5620.7 13997.7 15760.5 20768.7 21279.6 21298.3 2135.6 2196.0 2196.5 2229.5 2269.6 10198.4 10253.3 10332.0 10443.8 10481.3 1847.9 1874.4 1889.8 1930.7 1976.5 59579.7 60204.7 60347.4 60549.1 60678.4 11013.4 11065.4 11075.5 11087.2 11122.6 14668.1 14747.8 14759.9 14788.0 14795.4 8266.3 8285.1 8357.8 8358.0 8376.6 8020.3 8059.0 8060.0 8064.4 8096.3 4679.3 4687.2 4742.8 4749.7 4802.3 1979.3 1994.2 2002.5 2017.5 2018.5 487.4 493.9 986.2 1000.7 1081.5 11003.0 11039.7 11086.6 11275.2 11528.1 495.7 498.6 503.6 517.9 525.0 6241.1 6344.4 6421.0 6432.4 6444.5 550449.0 563261.0 563421.0 571725.0 572651.0 47675.3 48632.3 49332.5 57492.0 75364.6 1166.6 1201.8 1204.4 1207.1 1216.0 16125.6 16228.1 16318.9 16332.8 16619.3 31695.4 34188.5 34473.5 34984.7 35405.6 37308.3 43560.1 45583.5 45728.0 46250.3 7680.4 7800.4 7928.2 7966.5 8084.9 11179.7 11457.4 11720.1 12053.9 12312.8 10693.6 11008.2 11035.9 11208.2 11310.5 3233.7 5408.9 9739.3 10976.9 10983.3 10009.8 10613.5 10636.5 10658.4 11246.4 7754.4 7790.8 7886.9 7985.0 8071.4 9457.2 10621.2 10629.2 10727.4 10909.9 05:49:50 INFO - PROCESS | 6944 | 05:49:50 INFO - PROCESS | 6944 | [#3] mootools.html Cycles:180 Average:5618.22 Median:3763.17 stddev:2903.21 (77.1%) stddev-sans-first:2895.36 05:49:50 INFO - PROCESS | 6944 | Values: 1564.1 1575.1 1831.6 1885.4 1939.7 8131.4 8210.5 8346.7 8346.9 8393.9 8356.5 8356.6 8377.3 8384.3 8418.5 2311.5 2326.0 2331.8 2343.8 2352.9 2434.1 2437.4 2465.9 2470.0 2470.1 2308.8 2346.5 2380.4 2386.7 2399.2 2324.1 2328.7 2331.0 2335.2 2341.6 2318.7 2350.9 2351.8 2361.6 2377.3 7768.3 7807.9 7814.1 7817.8 7828.8 4925.0 5089.4 5113.4 5117.2 5119.9 3138.1 3143.7 3157.1 3160.1 3161.3 1025.4 1030.0 1038.0 1058.3 1064.7 10685.0 10861.3 10899.8 10955.8 10993.8 4323.7 4332.5 4358.8 4374.6 4392.6 8521.2 8544.7 8644.7 8656.4 8666.5 4794.4 4819.8 4836.4 4853.4 4867.9 4376.1 4377.6 4383.7 4399.0 4420.4 3570.8 3637.1 3654.0 3658.9 3696.7 1077.9 1087.8 1095.1 1097.6 1119.6 996.6 996.9 1101.9 1303.3 1461.6 7509.1 7521.9 7542.7 7559.4 7628.6 672.7 673.3 677.9 686.8 819.3 5989.9 6001.6 6021.4 6040.7 6057.7 9188.9 9364.7 9697.6 9808.6 9819.4 9532.8 9546.4 9588.9 9620.6 9725.0 7390.5 7600.0 7608.0 7653.7 7692.0 7289.1 7298.0 7310.9 7319.2 7363.0 8389.2 8431.3 8608.8 8620.7 8768.0 8583.5 8687.5 8698.3 8702.7 8846.6 6581.9 6687.6 6702.0 6705.2 6710.9 7557.6 7616.7 7619.8 7639.8 7653.5 6952.5 7115.6 7403.9 7610.2 7694.9 6848.4 7295.6 7300.9 7324.0 7329.8 7407.2 7455.7 7457.4 7467.7 7475.9 6910.9 6958.9 6984.0 7015.1 7033.8 6870.7 6928.5 6962.0 7115.2 7149.8 05:49:50 INFO - PROCESS | 6944 | 05:49:50 INFO - PROCESS | 6944 | [#4] prototype.html Cycles:180 Average:5772.75 Median:6463.71 stddev:1738.42 (26.9%) stddev-sans-first:1695.27 05:49:50 INFO - PROCESS | 6944 | Values: 366.1 377.8 378.6 381.4 386.9 6394.0 6401.8 6411.1 6417.0 6674.9 6434.4 6442.7 6450.8 6468.1 6468.9 4953.0 4955.5 4959.8 4963.2 4963.8 4971.1 4971.5 4979.1 4983.9 4994.1 4859.1 4938.3 4938.9 4942.4 4963.4 4896.2 4899.9 4939.3 4940.1 4950.1 4291.5 4316.1 4317.4 4318.8 4343.4 6006.3 6111.0 6115.1 6133.1 6138.1 5796.3 5799.2 5802.7 5803.6 5832.9 6878.9 6889.9 6902.4 6906.2 6996.2 4814.0 4823.4 4836.1 4838.3 4839.1 6972.6 7082.5 7191.7 7191.7 7228.4 4840.7 4853.2 4865.1 4866.7 4869.3 4913.6 4928.7 4935.9 4938.2 4948.5 5618.5 5667.7 5673.7 5708.6 5723.6 6915.7 6921.7 6955.4 7003.4 7017.1 1719.1 1738.4 1780.6 1784.8 1786.2 1175.5 1200.6 1203.6 1206.3 1220.6 6455.8 6459.3 6491.9 6492.4 6501.7 6986.6 6990.8 6995.7 7008.8 7028.9 6353.6 6433.0 6469.8 6472.9 6484.7 3803.9 3816.7 3831.4 3856.6 3856.8 7144.1 7174.4 7195.5 7227.3 7256.8 7153.3 7227.9 7248.2 7251.5 7407.7 7415.9 7421.0 7424.7 7429.0 7454.6 7206.1 7208.0 7237.2 7248.5 7253.6 6945.4 7049.4 7073.1 7108.3 7113.1 7368.0 7386.6 7403.0 7403.4 7405.3 4917.2 4991.9 5002.5 5011.1 5014.5 7070.8 7075.2 7198.8 7212.5 7226.6 7036.5 7049.4 7052.1 7055.0 7091.6 6920.2 6936.4 6942.3 6981.1 6985.1 6646.0 6857.5 6938.3 6962.3 6962.8 6974.7 7003.2 7005.3 7026.1 7033.4 6753.5 6785.1 6939.5 6943.3 6945.0 05:49:50 INFO - PROCESS | 6944 | 05:49:50 INFO - PROCESS | 6944 | [#5] yui.html Cycles:180 Average:15213.61 Median:4462.84 stddev:17652.24 (395.5%) stddev-sans-first:17668.52 05:49:50 INFO - PROCESS | 6944 | Values: 787.6 789.1 874.7 884.5 914.5 12970.4 13003.5 13120.0 13135.0 13213.7 13861.7 13919.2 13935.4 13987.9 14016.2 872.8 894.0 896.8 897.3 902.0 866.6 866.7 868.8 875.6 878.9 911.8 916.1 922.1 923.7 924.1 912.1 916.8 923.1 923.4 925.2 675.3 678.8 680.5 682.8 684.4 13718.7 13748.6 13767.4 13784.2 13809.7 13525.5 13551.2 13773.2 13905.9 14296.7 11352.1 11422.1 11631.3 11659.1 11828.6 3883.0 3885.1 3895.7 3897.9 3909.3 52229.5 52370.7 52378.7 52506.9 52733.5 11078.4 11290.8 11316.4 11389.5 11401.6 19470.3 19477.1 19485.3 19574.2 19665.8 8144.9 8214.4 8411.1 8667.9 8676.6 4459.9 4465.8 4547.0 4639.5 4643.9 3309.3 3318.6 3333.2 3338.7 3350.1 550.6 603.2 605.1 610.0 612.0 559.9 574.2 626.9 678.5 713.0 9392.6 9699.2 9826.4 9885.8 9945.9 513.2 531.2 582.5 633.2 725.6 4192.0 4541.9 4542.8 4591.2 4751.9 63238.7 63446.4 63691.7 63975.7 63991.4 54645.7 56370.7 57471.0 57821.4 58080.7 49222.3 50657.7 51036.5 52808.7 53819.0 10095.3 10180.3 10278.6 10339.3 10388.5 38621.2 38776.0 39119.4 39307.6 39578.4 46306.5 49059.5 50802.7 51046.2 51208.2 13081.3 13122.6 13147.1 13269.7 13394.5 13196.6 13241.7 13262.4 13308.2 13448.1 12210.6 12279.1 12653.7 13046.3 13317.9 12521.4 12646.4 12837.4 12892.9 12906.5 11364.0 11903.0 12178.2 12728.4 13240.6 9714.6 10453.6 10473.3 10574.8 10841.9 10467.9 10877.0 11096.2 11418.3 11490.1 05:49:50 INFO - PROCESS | 6944 | -------- Summary: end -------- 05:49:50 INFO - PROCESS | 6944 | 05:49:51 INFO - TEST-INFO | 6944: exit 0 05:49:51 INFO - TEST-OK | dromaeo_css | took 1108210ms 05:49:51 INFO - TEST-START | kraken 05:49:51 INFO - operating with platform_type : linux_ 05:49:51 INFO - Initialising browser for kraken test... 05:49:51 INFO - TEST-INFO | started process 7183 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4xO5lw/profile http://localhost:43533/getInfo.html) 05:49:54 INFO - PROCESS | 7183 | 05:49:54 INFO - PROCESS | 7183 | (process:7261): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:49:55 INFO - PROCESS | 7183 | __metrics Screen width/height:1600/1200 05:49:55 INFO - PROCESS | 7183 | colorDepth:24 05:49:55 INFO - PROCESS | 7183 | Browser inner width/height: 1024/697 05:49:55 INFO - PROCESS | 7183 | __metrics 05:49:56 INFO - TEST-INFO | 7183: exit 0 05:49:56 INFO - Browser initialized. 05:49:56 INFO - Running cycle 1/1 for kraken test... 05:49:56 INFO - TEST-INFO | started process 7310 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4xO5lw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:49:57 INFO - PROCESS | 7310 | 05:49:57 INFO - PROCESS | 7310 | (process:7370): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:50:08 INFO - PROCESS | 7310 | RSS: Main: 141119488 05:50:08 INFO - PROCESS | 7310 | 05:50:10 INFO - PROCESS | 7310 | Cycle 1(1): loaded http://localhost:43533/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43533/tests/kraken/driver.html?testName=audio-beat-detection) 05:50:11 INFO - PROCESS | 7310 | RSS: Main: 146296832 05:50:11 INFO - PROCESS | 7310 | 05:50:13 INFO - PROCESS | 7310 | Cycle 1(1): loaded http://localhost:43533/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43533/tests/kraken/driver.html?testName=audio-dft) 05:50:14 INFO - PROCESS | 7310 | RSS: Main: 145252352 05:50:14 INFO - PROCESS | 7310 | 05:50:17 INFO - PROCESS | 7310 | Cycle 1(1): loaded http://localhost:43533/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43533/tests/kraken/driver.html?testName=audio-fft) 05:50:17 INFO - PROCESS | 7310 | RSS: Main: 145997824 05:50:17 INFO - PROCESS | 7310 | 05:50:19 INFO - PROCESS | 7310 | Cycle 1(1): loaded http://localhost:43533/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43533/tests/kraken/driver.html?testName=audio-oscillator) 05:50:20 INFO - PROCESS | 7310 | RSS: Main: 145518592 05:50:20 INFO - PROCESS | 7310 | 05:50:22 INFO - PROCESS | 7310 | Cycle 1(1): loaded http://localhost:43533/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43533/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:50:23 INFO - PROCESS | 7310 | RSS: Main: 146878464 05:50:23 INFO - PROCESS | 7310 | 05:50:26 INFO - PROCESS | 7310 | Cycle 1(1): loaded http://localhost:43533/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43533/tests/kraken/driver.html?testName=imaging-darkroom) 05:50:26 INFO - PROCESS | 7310 | RSS: Main: 145620992 05:50:26 INFO - PROCESS | 7310 | 05:50:30 INFO - PROCESS | 7310 | Cycle 1(1): loaded http://localhost:43533/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43533/tests/kraken/driver.html?testName=imaging-desaturate) 05:50:30 INFO - PROCESS | 7310 | RSS: Main: 145817600 05:50:30 INFO - PROCESS | 7310 | 05:50:33 INFO - PROCESS | 7310 | Cycle 1(1): loaded http://localhost:43533/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43533/tests/kraken/driver.html?testName=json-parse-financial) 05:50:34 INFO - PROCESS | 7310 | RSS: Main: 145780736 05:50:34 INFO - PROCESS | 7310 | 05:50:35 INFO - PROCESS | 7310 | Cycle 1(1): loaded http://localhost:43533/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43533/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:50:36 INFO - PROCESS | 7310 | RSS: Main: 146206720 05:50:36 INFO - PROCESS | 7310 | 05:50:38 INFO - PROCESS | 7310 | Cycle 1(1): loaded http://localhost:43533/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43533/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:50:38 INFO - PROCESS | 7310 | RSS: Main: 144723968 05:50:38 INFO - PROCESS | 7310 | 05:50:40 INFO - PROCESS | 7310 | Cycle 1(1): loaded http://localhost:43533/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43533/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:50:41 INFO - PROCESS | 7310 | RSS: Main: 146264064 05:50:41 INFO - PROCESS | 7310 | 05:50:43 INFO - PROCESS | 7310 | Cycle 1(1): loaded http://localhost:43533/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43533/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:50:44 INFO - PROCESS | 7310 | RSS: Main: 147369984 05:50:44 INFO - PROCESS | 7310 | 05:50:46 INFO - PROCESS | 7310 | Cycle 1(1): loaded http://localhost:43533/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43533/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:50:47 INFO - PROCESS | 7310 | RSS: Main: 146759680 05:50:47 INFO - PROCESS | 7310 | 05:50:48 INFO - PROCESS | 7310 | Cycle 1(1): loaded http://localhost:43533/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43533/tests/kraken/driver.html?testName=ai-astar) 05:50:49 INFO - PROCESS | 7310 | RSS: Main: 147865600 05:50:49 INFO - PROCESS | 7310 | 05:50:49 INFO - PROCESS | 7310 | __start_tp_report 05:50:49 INFO - PROCESS | 7310 | _x_x_mozilla_page_load 05:50:49 INFO - PROCESS | 7310 | _x_x_mozilla_page_load_details 05:50:49 INFO - PROCESS | 7310 | |i|pagename|runs| 05:50:49 INFO - PROCESS | 7310 | |0;ai-astar;112;105;113;108;110;120;112;111;109;111 05:50:49 INFO - PROCESS | 7310 | |1;audio-beat-detection;154;134;157;165;128;151;162;135;174;131 05:50:49 INFO - PROCESS | 7310 | |2;audio-dft;163;163;162;165;165;163;162;165;165;162 05:50:49 INFO - PROCESS | 7310 | |3;audio-fft;72;73;76;152;76;73;74;76;170;72 05:50:49 INFO - PROCESS | 7310 | |4;audio-oscillator;94;95;148;95;96;95;140;96;95;134 05:50:49 INFO - PROCESS | 7310 | |5;imaging-gaussian-blur;110;110;109;110;110;109;110;109;109;111 05:50:49 INFO - PROCESS | 7310 | |6;imaging-darkroom;148;146;146;146;146;147;147;148;147;147 05:50:49 INFO - PROCESS | 7310 | |7;imaging-desaturate;96;96;96;97;96;96;96;96;97;96 05:50:49 INFO - PROCESS | 7310 | |8;json-parse-financial;58;57;56;60;57;59;75;63;56;55 05:50:49 INFO - PROCESS | 7310 | |9;json-stringify-tinderbox;64;64;64;63;65;66;66;65;65;65 05:50:49 INFO - PROCESS | 7310 | |10;stanford-crypto-aes;83;84;82;84;83;83;84;82;83;91 05:50:49 INFO - PROCESS | 7310 | |11;stanford-crypto-ccm;115;112;111;112;126;119;111;109;109;125 05:50:49 INFO - PROCESS | 7310 | |12;stanford-crypto-pbkdf2;142;141;136;139;138;137;137;134;127;124 05:50:49 INFO - PROCESS | 7310 | |13;stanford-crypto-sha256-iterative;68;65;70;64;65;66;66;65;66;64 05:50:49 INFO - PROCESS | 7310 | __end_tp_report 05:50:49 INFO - PROCESS | 7310 | __start_cc_report 05:50:49 INFO - PROCESS | 7310 | _x_x_mozilla_cycle_collect,717 05:50:49 INFO - PROCESS | 7310 | __end_cc_report 05:50:49 INFO - PROCESS | 7310 | __startTimestamp1456581049182__endTimestamp 05:50:49 INFO - PROCESS | 7310 | 05:50:49 INFO - PROCESS | 7310 | ------- Summary: start ------- 05:50:49 INFO - PROCESS | 7310 | Number of tests: 14 05:50:49 INFO - PROCESS | 7310 | 05:50:49 INFO - PROCESS | 7310 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.50 stddev:3.90 (3.5%) stddev-sans-first:4.12 05:50:49 INFO - PROCESS | 7310 | Values: 112.0 105.0 113.0 108.0 110.0 120.0 112.0 111.0 109.0 111.0 05:50:49 INFO - PROCESS | 7310 | 05:50:49 INFO - PROCESS | 7310 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:155.50 stddev:16.09 (10.3%) stddev-sans-first:16.96 05:50:49 INFO - PROCESS | 7310 | Values: 154.0 134.0 157.0 165.0 128.0 151.0 162.0 135.0 174.0 131.0 05:50:49 INFO - PROCESS | 7310 | 05:50:49 INFO - PROCESS | 7310 | [#2] audio-dft Cycles:10 Average:163.50 Median:164.00 stddev:1.35 (0.8%) stddev-sans-first:1.42 05:50:49 INFO - PROCESS | 7310 | Values: 163.0 163.0 162.0 165.0 165.0 163.0 162.0 165.0 165.0 162.0 05:50:49 INFO - PROCESS | 7310 | 05:50:49 INFO - PROCESS | 7310 | [#3] audio-fft Cycles:10 Average:91.40 Median:73.50 stddev:36.96 (50.3%) stddev-sans-first:38.53 05:50:49 INFO - PROCESS | 7310 | Values: 72.0 73.0 76.0 152.0 76.0 73.0 74.0 76.0 170.0 72.0 05:50:49 INFO - PROCESS | 7310 | 05:50:49 INFO - PROCESS | 7310 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:95.00 stddev:22.25 (23.4%) stddev-sans-first:22.94 05:50:49 INFO - PROCESS | 7310 | Values: 94.0 95.0 148.0 95.0 96.0 95.0 140.0 96.0 95.0 134.0 05:50:49 INFO - PROCESS | 7310 | 05:50:49 INFO - PROCESS | 7310 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 05:50:49 INFO - PROCESS | 7310 | Values: 110.0 110.0 109.0 110.0 110.0 109.0 110.0 109.0 109.0 111.0 05:50:49 INFO - PROCESS | 7310 | 05:50:49 INFO - PROCESS | 7310 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 05:50:49 INFO - PROCESS | 7310 | Values: 148.0 146.0 146.0 146.0 146.0 147.0 147.0 148.0 147.0 147.0 05:50:49 INFO - PROCESS | 7310 | 05:50:49 INFO - PROCESS | 7310 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:50:49 INFO - PROCESS | 7310 | Values: 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 97.0 96.0 05:50:49 INFO - PROCESS | 7310 | 05:50:49 INFO - PROCESS | 7310 | [#8] json-parse-financial Cycles:10 Average:59.60 Median:58.50 stddev:5.89 (10.1%) stddev-sans-first:6.22 05:50:49 INFO - PROCESS | 7310 | Values: 58.0 57.0 56.0 60.0 57.0 59.0 75.0 63.0 56.0 55.0 05:50:49 INFO - PROCESS | 7310 | 05:50:49 INFO - PROCESS | 7310 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.95 (1.5%) stddev-sans-first:0.97 05:50:49 INFO - PROCESS | 7310 | Values: 64.0 64.0 64.0 63.0 65.0 66.0 66.0 65.0 65.0 65.0 05:50:49 INFO - PROCESS | 7310 | 05:50:49 INFO - PROCESS | 7310 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.50 stddev:2.60 (3.1%) stddev-sans-first:2.74 05:50:49 INFO - PROCESS | 7310 | Values: 83.0 84.0 82.0 84.0 83.0 83.0 84.0 82.0 83.0 91.0 05:50:49 INFO - PROCESS | 7310 | 05:50:49 INFO - PROCESS | 7310 | [#11] stanford-crypto-ccm Cycles:10 Average:114.90 Median:113.50 stddev:6.31 (5.6%) stddev-sans-first:6.70 05:50:49 INFO - PROCESS | 7310 | Values: 115.0 112.0 111.0 112.0 126.0 119.0 111.0 109.0 109.0 125.0 05:50:49 INFO - PROCESS | 7310 | 05:50:49 INFO - PROCESS | 7310 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.50 Median:137.50 stddev:5.80 (4.2%) stddev-sans-first:5.65 05:50:49 INFO - PROCESS | 7310 | Values: 142.0 141.0 136.0 139.0 138.0 137.0 137.0 134.0 127.0 124.0 05:50:49 INFO - PROCESS | 7310 | 05:50:49 INFO - PROCESS | 7310 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.85 (2.8%) stddev-sans-first:1.80 05:50:49 INFO - PROCESS | 7310 | Values: 68.0 65.0 70.0 64.0 65.0 66.0 66.0 65.0 66.0 64.0 05:50:49 INFO - PROCESS | 7310 | -------- Summary: end -------- 05:50:49 INFO - PROCESS | 7310 | 05:50:50 INFO - TEST-INFO | 7310: exit 0 05:50:50 INFO - TEST-OK | kraken | took 58973ms 05:50:50 INFO - TEST-START | v8_7 05:50:50 INFO - operating with platform_type : linux_ 05:50:50 INFO - Initialising browser for v8_7 test... 05:50:50 INFO - TEST-INFO | started process 7598 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpv887hg/profile http://localhost:43533/getInfo.html) 05:50:53 INFO - PROCESS | 7598 | 05:50:53 INFO - PROCESS | 7598 | (process:7677): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:50:54 INFO - PROCESS | 7598 | __metrics Screen width/height:1600/1200 05:50:54 INFO - PROCESS | 7598 | colorDepth:24 05:50:54 INFO - PROCESS | 7598 | Browser inner width/height: 1024/697 05:50:54 INFO - PROCESS | 7598 | __metrics 05:50:55 INFO - TEST-INFO | 7598: exit 0 05:50:55 INFO - Browser initialized. 05:50:55 INFO - Running cycle 1/1 for v8_7 test... 05:50:55 INFO - TEST-INFO | started process 7726 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpv887hg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:50:56 INFO - PROCESS | 7726 | 05:50:56 INFO - PROCESS | 7726 | (process:7789): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:51:07 INFO - PROCESS | 7726 | RSS: Main: 140226560 05:51:07 INFO - PROCESS | 7726 | 05:51:29 INFO - PROCESS | 7726 | Cycle 1(1): loaded http://localhost:43533/tests/v8_7/run.html (next: http://localhost:43533/tests/v8_7/run.html) 05:51:29 INFO - PROCESS | 7726 | RSS: Main: 144326656 05:51:29 INFO - PROCESS | 7726 | 05:51:29 INFO - PROCESS | 7726 | __start_tp_report 05:51:29 INFO - PROCESS | 7726 | _x_x_mozilla_page_load 05:51:29 INFO - PROCESS | 7726 | _x_x_mozilla_page_load_details 05:51:29 INFO - PROCESS | 7726 | |i|pagename|runs| 05:51:29 INFO - PROCESS | 7726 | |0;Richards;166.41704110500916 05:51:29 INFO - PROCESS | 7726 | |1;DeltaBlue;176.05633802816902 05:51:29 INFO - PROCESS | 7726 | |2;Encrypt;278.473962684489 05:51:29 INFO - PROCESS | 7726 | |3;Decrypt;5291.005291005291 05:51:29 INFO - PROCESS | 7726 | |4;RayTrace;929.368029739777 05:51:29 INFO - PROCESS | 7726 | |5;Earley;571.4285714285714 05:51:29 INFO - PROCESS | 7726 | |6;Boyer;11247.191011235955 05:51:29 INFO - PROCESS | 7726 | |7;RegExp;39115.38461538462 05:51:29 INFO - PROCESS | 7726 | |8;Splay;518.4033177812338 05:51:29 INFO - PROCESS | 7726 | |9;NavierStokes;4822.115384615385 05:51:29 INFO - PROCESS | 7726 | __end_tp_report 05:51:29 INFO - PROCESS | 7726 | __startTimestamp1456581089873__endTimestamp 05:51:29 INFO - PROCESS | 7726 | 05:51:29 INFO - PROCESS | 7726 | ------- Summary: start ------- 05:51:29 INFO - PROCESS | 7726 | Number of tests: 10 05:51:29 INFO - PROCESS | 7726 | 05:51:29 INFO - PROCESS | 7726 | [#0] Richards Cycles:1 Average:166.42 Median:166.42 stddev:0.00 (0.0%) 05:51:29 INFO - PROCESS | 7726 | Values: 166.4 05:51:29 INFO - PROCESS | 7726 | 05:51:29 INFO - PROCESS | 7726 | [#1] DeltaBlue Cycles:1 Average:176.06 Median:176.06 stddev:0.00 (0.0%) 05:51:29 INFO - PROCESS | 7726 | Values: 176.1 05:51:29 INFO - PROCESS | 7726 | 05:51:29 INFO - PROCESS | 7726 | [#2] Encrypt Cycles:1 Average:278.47 Median:278.47 stddev:0.00 (0.0%) 05:51:29 INFO - PROCESS | 7726 | Values: 278.5 05:51:29 INFO - PROCESS | 7726 | 05:51:29 INFO - PROCESS | 7726 | [#3] Decrypt Cycles:1 Average:5291.01 Median:5291.01 stddev:0.00 (0.0%) 05:51:29 INFO - PROCESS | 7726 | Values: 5291.0 05:51:29 INFO - PROCESS | 7726 | 05:51:29 INFO - PROCESS | 7726 | [#4] RayTrace Cycles:1 Average:929.37 Median:929.37 stddev:0.00 (0.0%) 05:51:29 INFO - PROCESS | 7726 | Values: 929.4 05:51:29 INFO - PROCESS | 7726 | 05:51:29 INFO - PROCESS | 7726 | [#5] Earley Cycles:1 Average:571.43 Median:571.43 stddev:0.00 (0.0%) 05:51:29 INFO - PROCESS | 7726 | Values: 571.4 05:51:29 INFO - PROCESS | 7726 | 05:51:29 INFO - PROCESS | 7726 | [#6] Boyer Cycles:1 Average:11247.19 Median:11247.19 stddev:0.00 (0.0%) 05:51:29 INFO - PROCESS | 7726 | Values: 11247.2 05:51:29 INFO - PROCESS | 7726 | 05:51:29 INFO - PROCESS | 7726 | [#7] RegExp Cycles:1 Average:39115.38 Median:39115.38 stddev:0.00 (0.0%) 05:51:29 INFO - PROCESS | 7726 | Values: 39115.4 05:51:29 INFO - PROCESS | 7726 | 05:51:29 INFO - PROCESS | 7726 | [#8] Splay Cycles:1 Average:518.40 Median:518.40 stddev:0.00 (0.0%) 05:51:29 INFO - PROCESS | 7726 | Values: 518.4 05:51:29 INFO - PROCESS | 7726 | 05:51:29 INFO - PROCESS | 7726 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 05:51:29 INFO - PROCESS | 7726 | Values: 4822.1 05:51:29 INFO - PROCESS | 7726 | -------- Summary: end -------- 05:51:29 INFO - PROCESS | 7726 | 05:51:30 INFO - TEST-INFO | 7726: exit 0 05:51:30 INFO - TEST-OK | v8_7 | took 40644ms 05:51:30 INFO - SUITE-END | took 1207s 05:51:30 INFO - Completed test suite (00:20:08) 05:51:30 INFO - Working with test: dromaeo_css 05:51:30 INFO - Generating results file: dromaeo_css 05:51:30 INFO - Working with test: kraken 05:51:30 INFO - Generating results file: kraken 05:51:30 INFO - javascript benchmark 05:51:30 INFO - Working with test: v8_7 05:51:30 INFO - Generating results file: v8_7 05:51:30 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:51:30 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 05:51:30 INFO - process_Request line: dromaeo_css 7247.50 graph.html#tests=[[72,52,43]] 05:51:30 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:51:31 INFO - process_Request line: kraken 1501.10 graph.html#tests=[[232,52,43]] 05:51:31 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:51:31 INFO - process_Request line: v8_7 21870.97 graph.html#tests=[[230,52,43]] 05:51:31 INFO - RETURN: dromaeo_css: 7247.50 05:51:31 INFO - RETURN: kraken: 1501.10 05:51:31 INFO - RETURN: v8_7: 21870.97 05:51:31 INFO - javascript benchmark 05:51:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3316.5356850040985, 3348.2633820559486, 3356.16095976006, 3358.5130156127357, 3371.966280337199, 5535.280413546238, 5549.417311182328, 5552.666839989603, 5560.304961879765, 5564.443555644433, 5533.253010843535, 5581.6371935824245, 5595.888082238353, 5606.439356064391, 5613.21415001899, 5073.467285934979, 5109.821156259532, 5150.33045704058, 5172.017316709813, 5242.798024829562, 4956.107900577895, 5016.372953380827, 5092.592592592584, 5107.3360463139925, 5125.769340379673, 5101.642884998052, 5119.411267704206, 5152.227165925104, 5156.948430515685, 5167.173252279636, 5144.202648589475, 5155.716435596022, 5162.535371816517, 5176.964607078599, 5195.6622819516615, 4914.606831453475, 4992.90014199714, 5064.088464076464, 5066.670666406671, 5067.594592432597, 5301.204819277139, 5313.3092697949405, 5323.653962492425, 5324.627276090675, 5325.121354976424, 5894.941050589482, 5906.497947674453, 5953.434423729739, 5963.671998040106, 5974.820755377345, 5908.586398952075, 5986.132010858445, 5996.100584912255, 5998.340182579913, 6005.3394126646035, 5613.550915926716, 5639.577031722637, 5648.887022259573, 5649.0, 5695.7152142392715, 6035.30593981689, 6052.757889684363, 6068.666223357669, 6071.787487437919, 6076.240469941257, 5746.339170995389, 5853.473187413068, 5856.912146317723, 5864.970675146597, 5894.705264736746, 5879.5002424794375, 5928.762849486058, 5996.940030599638, 6010.54920880927, 6040.486558642565, 5816.098504731774, 5888.646681199141, 5904.261967254093, 5913.852153696106, 5920.644761314335, 5793.623414478046, 5912.3496415394275, 5923.200367950358, 5924.5852790305125, 5926.377730338339, 4487.842925497657, 4516.36770852081, 4542.977285113553, 4543.091381723602, 4579.427571553556, 4110.17796440713, 4112.362583799516, 4114.691398145151, 4129.009037830899, 4146.854860079883, 5469.644473109235, 5486.91769623456, 5527.170924361298, 5554.055810512223, 5558.44415558441, 5922.052471604523, 5933.1396947443245, 5951.196588460502, 5999.970000150059, 6028.608140470856, 5566.944330556724, 5582.525485333711, 5597.944020559824, 5599.7480113394995, 5603.691796951207, 5017.724025178651, 5099.745012749348, 5104.540591346797, 5140.074786538459, 5175.223716442564, 6096.329403765582, 6132.2331366082535, 6133.197417601116, 6145.631262124287, 6154.907676384858, 5915.438033386821, 5920.881582368328, 5924.200232968494, 5925.851853703692, 5926.348101708722, 5892.086726557391, 5963.761449541969, 5979.701014949323, 6040.426159514839, 6075.301340345917, 5885.352611212848, 5910.143029260647, 5912.142739302691, 5923.526117910471, 5932.584719069624, 5975.25309336333, 5989.550783691154, 5991.191189189403, 5999.070144127667, 6002.189704390026, 5722.5421966241765, 5798.478136967693, 5835.8541036472725, 5860.062390017577, 5913.349531551612, 5754.136879468113, 5772.5381969441505, 5786.334571524329, 5796.62321949072, 5803.100519419497, 5707.800226992035, 5708.686022268815, 5715.542756579547, 5718.428157184248, 5729.2265544151005, 5705.885882282414, 5744.0, 5744.913826292693, 5841.795537156179, 5875.882482350244, 5693.971530142323, 5709.771609135588, 5717.42825717425, 5733.31200255972, 5738.0], "unit": "score", "name": "dojo.html", "value": 5482.856185103038}, {"lowerIsBetter": false, "replicates": [538.3727956930177, 561.5956511311855, 573.4122524412477, 576.4464767451719, 593.5103539579848, 39680.0, 40538.18923621526, 40781.184376312456, 40837.7958110209, 40867.0, 42749.14501709964, 42759.14481710364, 43054.0, 43425.131497370036, 43487.78256108723, 8814.735557933256, 9091.999880013193, 9099.22656574192, 9118.088191180863, 9132.771680708001, 8703.0, 8757.343199260049, 8775.868361974544, 8791.516466594334, 8800.647974081028, 8796.296296296281, 8881.644734210624, 8920.910790892105, 8921.33090018248, 8931.240844528224, 8706.1729135732, 8786.209241168262, 8834.779130521756, 8846.557672116369, 8857.911420885774, 8836.381453298272, 8891.644334226688, 8935.865962010575, 8952.68665596701, 8967.596458159333, 40186.79906600477, 40688.186236275105, 40707.0, 40713.0, 40733.79633101845, 3352.932941341184, 3441.7934923904395, 3486.4073107571776, 3618.8009659468717, 3818.885433437001, 30966.84516577425, 31147.844260778777, 31196.844015779774, 31462.213444663837, 32086.0, 4208.789560521992, 4240.957590424118, 4300.80646370914, 4373.825046998117, 4412.0, 276012.0, 276077.0, 276614.0, 277703.0, 337351.0, 56993.43006569881, 57389.713051434475, 57569.71215143981, 57655.71172144113, 57814.0, 61277.0, 61365.386346135965, 61602.0, 61869.0, 61934.38065619376, 16924.746128808078, 17148.914255428645, 17153.656926861393, 17160.31358745661, 17210.569735756708, 13044.152130111703, 13336.933315333361, 13634.795478067837, 13644.454221831214, 13733.381997810122, 20561.0, 20757.792422075585, 20897.89551052235, 20898.059587318607, 21057.789422105583, 8352.331813454908, 8555.828883422297, 8593.828123437495, 8608.698695545625, 8628.094050124771, 1030.386919782728, 1100.0649447969322, 1118.8937050980144, 1167.544657583543, 1170.011340417346, 30292.54561181584, 30467.847660761556, 30956.535651965238, 30968.535471967938, 31519.684803151675, 1163.081165878963, 1198.4906414773686, 1230.354064116346, 1245.495574292413, 1287.8905293050009, 15962.68074638524, 16010.439634612732, 16046.518604441886, 16053.357865685475, 16406.83593164077, 326179.0, 502679.0, 508340.0, 529906.0, 543304.0, 57189.0, 57813.0, 58002.419975799705, 58178.127328090115, 58321.41678583244, 1456.3082535795625, 1521.9391224350902, 1522.360608544414, 1523.6114790728293, 1526.7404541228018, 30822.383552328378, 31492.527612086295, 31599.0, 31939.680603193672, 32217.35565288728, 46203.3069503951, 47679.52320476751, 47727.52272477231, 47818.0, 47897.0, 302358.0, 303305.0, 306230.0, 307428.0, 308153.0, 33716.15709607279, 34014.319713605095, 34016.319673605896, 34624.48063279002, 34627.0, 43583.12833743371, 43944.12111757683, 43947.0, 44349.0, 44848.55151448444, 37394.0, 37684.811575941945, 37689.246215075, 38743.2251354977, 39180.608193917695, 38224.23551529009, 39835.0, 41578.168436631706, 41927.58072419237, 41988.0, 35747.10632234215, 36091.27817443689, 36147.45778813267, 36356.27287454289, 36617.81691091634, 30035.849820750755, 31876.36247275088, 31922.20194495156, 31969.200769980936, 32117.518237226926, 26890.731092689606, 27288.317792055357, 27573.44853102967, 27613.171604851887, 27618.028421392555], "unit": "score", "name": "ext.html", "value": 19747.79532779405}, {"lowerIsBetter": false, "replicates": [386.0252861524652, 388.4639197906888, 388.83543786359854, 390.23124444843654, 396.0850435494007, 15774.21128943551, 16722.832771672278, 16848.915755421236, 19184.808151918478, 19231.519212019706, 16836.24236909339, 16842.157892105377, 17120.229589668463, 17235.482935511955, 18160.909195454038, 5060.39275286966, 5681.715914204273, 5714.1428785682065, 5717.42825717427, 5722.685252311121, 5452.345718513784, 5627.971860140694, 5641.802536911209, 5649.774009039654, 5651.8587035324035, 5542.528885044776, 5611.831645050655, 5616.354119276295, 5639.379668236491, 6081.695915204245, 6125.111858780474, 6143.232095988002, 6156.630602163885, 6172.382761723837, 6179.876402471948, 5392.299001129828, 5596.776128954837, 5612.354579223401, 5617.606767526275, 5620.747066382022, 13997.720045599031, 15760.527184184493, 20768.688469672816, 21279.574408511744, 21298.25456109029, 2135.562209746998, 2195.9890200548894, 2196.4728465168246, 2229.4537838229576, 2269.5914735347633, 10198.439085850276, 10253.282270241087, 10332.0, 10443.79112417755, 10481.318714283547, 1847.8891266523917, 1874.4189301316635, 1889.8299153076289, 1930.6524825531399, 1976.4861136104573, 59579.702101489645, 60204.698976504835, 60347.39652603505, 60549.09176362402, 60678.393216067714, 11013.449327533592, 11065.446727663746, 11075.50160242791, 11087.22389432732, 11122.55509779616, 14668.119912805267, 14747.77878331826, 14759.92620036893, 14788.0, 14795.408183672747, 8266.256036956704, 8285.088640249567, 8357.791055223668, 8357.958210209032, 8376.581170941428, 8020.2781749641645, 8058.959705201553, 8059.959700201462, 8064.435489515795, 8096.271335579826, 4679.321498382716, 4687.20317546018, 4742.762861856893, 4749.738764367993, 4802.327674125625, 1979.3072424651257, 1994.192352097374, 2002.5294055896852, 2017.485541186988, 2018.5458271889001, 487.4199702354187, 493.92344186651127, 986.2356673577891, 1000.6797824696027, 1081.5025088459397, 11003.0, 11039.724006899893, 11086.611968581223, 11275.154363422776, 11528.135389845795, 495.7248726956574, 498.5737194698553, 503.6071863946055, 517.9456157103525, 524.9972552424927, 6241.095041218998, 6344.365563443711, 6420.967895160495, 6432.35676432353, 6444.548881578245, 550449.0, 563261.0, 563421.0, 571725.0, 572651.0, 47675.284870726966, 48632.27051594229, 49332.50667493351, 57492.0, 75364.62317688376, 1166.5567084508002, 1201.7896868048056, 1204.4399354300292, 1207.1007099710596, 1215.9817602735789, 16125.575112280821, 16228.107454090139, 16318.918405407898, 16332.755008675116, 16619.3352265908, 31695.36609267848, 34188.48717269293, 34473.482897756054, 34984.72599281039, 35405.645943540236, 37308.25383492369, 43560.128797424506, 45583.54416455793, 45728.0, 46250.30624540567, 7680.385569154566, 7800.4149688774705, 7928.167542408195, 7966.522008679498, 8084.919150808417, 11179.72050698739, 11457.369844658291, 11720.120990925885, 12053.879461205275, 12312.81530777057, 10693.572257109628, 11008.229423940247, 11035.889641103486, 11208.215424920178, 11310.4910279036, 3233.708966193054, 5408.891822163613, 9739.318247722591, 10976.890231097586, 10983.286086404358, 10009.849852252077, 10613.522391492555, 10636.52135653913, 10658.413787241467, 11246.437678116225, 7754.418418618513, 7790.844183116419, 7886.921130788619, 7984.960075199587, 8071.394645401501, 9457.19613832832, 10621.203409744454, 10629.202809789142, 10727.40999245049, 10909.945450272699], "unit": "score", "name": "jquery.html", "value": 8178.827400248938}, {"lowerIsBetter": false, "replicates": [1564.053747482773, 1575.0628376116206, 1831.5878927241372, 1885.3872491440286, 1939.6508628446875, 8131.430799844006, 8210.50736955783, 8346.749597512076, 8346.91653083469, 8393.874091888627, 8356.456830306026, 8356.623951922164, 8377.287930525912, 8384.287335576468, 8418.536980466071, 2311.4799170186698, 2325.988370058147, 2331.8484298520625, 2343.7773411525877, 2352.882355882199, 2434.099383228208, 2437.402836305099, 2465.864377459239, 2469.987650061747, 2470.0984140788573, 2308.8383813133087, 2346.5072334809624, 2380.428697112689, 2386.689730335054, 2399.196269249803, 2324.081987614891, 2328.7089113860766, 2331.0, 2335.1710142899283, 2341.6487526870937, 2318.652202169671, 2350.894209760565, 2351.8000969917575, 2361.563110824503, 2377.274931146017, 7768.262015108556, 7807.882881756778, 7814.140444551095, 7817.804554886116, 7828.843423131506, 4925.039617274633, 5089.440161582223, 5113.411957624883, 5117.181250999822, 5119.87200319995, 3138.089953913385, 3143.654198038214, 3157.1002264354547, 3160.146760374686, 3161.2729072313496, 1025.3642741500244, 1029.9588016479331, 1037.9724073167586, 1058.2645061682133, 1064.7391389109719, 10685.038346548848, 10861.3483191008, 10899.782004359948, 10955.83566246507, 10993.780124397466, 4323.69734118615, 4332.480102387671, 4358.8155370843715, 4374.606285434326, 4392.604665580113, 8521.190486903733, 8544.658213671508, 8644.654213831376, 8656.437331573428, 8666.523341216167, 4794.4486384065585, 4819.807207711652, 4836.419629644395, 4853.417589889165, 4867.9269810952865, 4376.081022985145, 4377.562243775661, 4383.715058521186, 4399.0, 4420.447444069491, 3570.785752854837, 3637.1452708613456, 3653.963460365362, 3658.8902332929524, 3696.6857817085847, 1077.859878215827, 1087.8150714378417, 1095.0746619106842, 1097.550004498168, 1119.6249256499163, 996.6013594562088, 996.9482196282846, 1101.8512500812287, 1303.2962200411862, 1461.5834487171105, 7509.13644930829, 7521.9247807522315, 7542.6605802739, 7559.357454616419, 7628.580428076398, 672.6939242644585, 673.3468535520635, 677.9220389655154, 686.8488932434856, 819.2585709932521, 5989.880202396015, 6001.609895356788, 6021.42796434338, 6040.697965101727, 6057.666828324396, 9188.8621670675, 9364.672236471692, 9697.612095516242, 9808.607655693691, 9819.41083534976, 9532.761680958032, 9546.379485333431, 9588.856167157359, 9620.567074481665, 9725.0, 7390.482666213421, 7600.0, 7608.0489938757655, 7653.693852245848, 7691.961540192375, 7289.125304963226, 7298.0, 7310.853782924205, 7319.2314806944505, 7362.9631851840395, 8389.161083891806, 8431.325493960347, 8608.827823443622, 8620.655173792979, 8768.0, 8583.527905964982, 8687.522186279562, 8698.347623928357, 8702.651893924172, 8846.646134154562, 6581.901271480836, 6687.6321802301345, 6702.0, 6705.195376554844, 6710.932890671031, 7557.584332861746, 7616.7334143304715, 7619.847603048019, 7639.809004774925, 7653.502522336031, 6952.513324067267, 7115.6086415247655, 7403.889416587555, 7610.200928902385, 7694.923050769421, 6848.417884479875, 7295.598742069237, 7300.853982920418, 7324.0, 7329.780106596811, 7407.1852096268285, 7455.739049133254, 7457.366123879531, 7467.663955121924, 7475.88786168197, 6910.896336555056, 6958.8956165658565, 6984.022236886942, 7015.123109611299, 7033.824154396181, 6870.656467176721, 6928.4803639726215, 6961.965190174017, 7115.217326094229, 7149.785506434815], "unit": "score", "name": "mootools.html", "value": 4571.375923606421}, {"lowerIsBetter": false, "replicates": [366.10852573982356, 377.8205352457583, 378.58355808610514, 381.43928425214926, 386.88393481955404, 6394.0, 6401.839954001152, 6411.102445657606, 6416.973284274517, 6674.933250667492, 6434.356564343563, 6442.742290308382, 6450.838729031777, 6468.0944667746435, 6468.902966455507, 4953.0, 4955.529224723664, 4959.752012399384, 4963.205887058053, 4963.801447942078, 4971.105201063807, 4971.527704868032, 4979.078870408968, 4983.900321993558, 4994.051130285234, 4859.052484765472, 4938.283948827418, 4938.925916111261, 4942.406911170647, 4963.40439147301, 4896.192128298826, 4899.877503062434, 4939.283803848458, 4940.135476291634, 4950.059488697172, 4291.463567054118, 4316.050468896838, 4317.417148684919, 4318.82724691012, 4343.391925130484, 6006.309274433409, 6111.0, 6115.113308570277, 6133.080037994292, 6138.14066030756, 5796.333421656522, 5799.18811366409, 5802.680852553108, 5803.564732645069, 5832.854178645525, 6878.931210687879, 6889.896651550231, 6902.447804175654, 6906.240313565504, 6996.230414654384, 4813.9890622969215, 4823.372961515016, 4836.129496690594, 4838.346823178861, 4839.104765618336, 6972.616506092163, 7082.468814838908, 7191.748288809867, 7191.748288809918, 7228.421726261939, 4840.709557426566, 4853.199222128309, 4865.0756356292195, 4866.683665561727, 4869.342638743795, 4913.606911447076, 4928.704277743275, 4935.925961110586, 4938.234573641092, 4948.505149485023, 5618.52242559387, 5667.659940403589, 5673.687947162945, 5708.600397972102, 5723.627964182315, 6915.654217289115, 6921.7231310747, 6955.443564514827, 7003.439724822104, 7017.122859642544, 1719.0974738262512, 1738.4263193146232, 1780.5904641932427, 1784.8036715961234, 1786.2497750944635, 1175.529788084773, 1200.5977997370803, 1203.554684766642, 1206.2702065250396, 1220.6094049904123, 6455.7740479083, 6459.321771214049, 6491.902621460682, 6492.448141907897, 6501.707423165969, 6986.580805151707, 6990.790276291719, 6995.650217489105, 7008.824779380557, 7028.92971070293, 6353.555251132469, 6432.967835160888, 6469.77355792545, 6472.870542589122, 6484.708188131545, 3803.8858834235016, 3816.656500914931, 3831.4061320495366, 3856.5950575189763, 3856.807159642007, 7144.071270734771, 7174.426045916314, 7195.46034047438, 7227.27727227273, 7256.7822965311125, 7153.284671532805, 7227.89158162628, 7248.166460857069, 7251.5286506376915, 7407.740729074457, 7415.851682966419, 7420.962895185489, 7424.740134095281, 7429.0, 7454.589997550187, 7206.063211782434, 7208.0, 7237.203907570269, 7248.492605517563, 7253.601051942193, 6945.374916257561, 7049.436045116481, 7073.080499535027, 7108.289171082851, 7113.0753002109395, 7367.963160184165, 7386.630668466662, 7403.000594919617, 7403.370713489198, 7405.259474052552, 4917.237828136645, 4991.925121123259, 5002.52476014778, 5011.09800235961, 5014.52362025607, 7070.8232294191, 7075.221725610281, 7198.820029499305, 7212.4951253411755, 7226.566406015446, 7036.542624729376, 7049.365557099885, 7052.118485189351, 7054.964725176546, 7091.64541772899, 6920.169579650475, 6936.375726184668, 6942.271061538668, 6981.057557229709, 6985.057017302599, 6645.966770166118, 6857.5199736019995, 6938.340857618518, 6962.3385778353, 6962.7911162665205, 6974.6861391238535, 7003.194632617314, 7005.334493223136, 7026.1217347831525, 7033.402160816388, 6753.493487988322, 6785.117934668461, 6939.514234003773, 6943.340382663639, 6945.0], "unit": "score", "name": "prototype.html", "value": 5214.262843169106}, {"lowerIsBetter": false, "replicates": [787.6180052674453, 789.1398375770416, 874.6676263020054, 884.5311984648134, 914.5107367558353, 12970.351482425876, 13003.544875929345, 13120.015998800092, 13135.0, 13213.7357252855, 13861.722765544682, 13919.164850109, 13935.44258229672, 13987.930060349683, 14016.22910739909, 872.8385248728973, 893.9865902011475, 896.7623579751371, 897.3180382908971, 902.0, 866.58403966096, 866.7053201911349, 868.7784614923186, 875.6103533927405, 878.9033206347297, 911.8404279251138, 916.0656130746635, 922.1470140120396, 923.6628630549834, 924.0943875002469, 912.0879120879088, 916.8395530782086, 923.0953665407905, 923.3997901364099, 925.2320573923695, 675.2605896543278, 678.7522554267706, 680.4930326906436, 682.7712716240065, 684.4319215051495, 13718.65703357414, 13748.587542373745, 13767.449302027906, 13784.241866697328, 13809.654758631013, 13525.458981640722, 13551.186928784304, 13773.173609583357, 13905.930470347583, 14296.714065718732, 11352.14858885587, 11422.14333924959, 11631.302121872715, 11659.125565582615, 11828.645140645795, 3882.9805850970565, 3885.067583779901, 3895.7272990890647, 3897.8830635080994, 3909.2963266612, 52229.47770522284, 52370.73814630903, 52378.7381063096, 52506.94986100295, 52733.47266527362, 11078.446077696082, 11290.830637540443, 11316.377599231957, 11389.544418223344, 11401.600943966921, 19470.318538851072, 19477.12352944121, 19485.318013869448, 19574.217031318873, 19665.803341966683, 8144.918550814535, 8214.383921205934, 8411.117042240088, 8667.869981950276, 8676.60955257015, 4459.9331010034875, 4465.754383508874, 4546.954530454719, 4639.512851150648, 4643.930341044887, 3309.255417531036, 3318.634950155529, 3333.2000319923045, 3338.749593780476, 3350.128966468687, 550.5513006899445, 603.1736520966217, 605.1286147946943, 610.0300522169771, 612.0268772651506, 559.8824246908194, 574.2333984131232, 626.9247690277195, 678.4877417549817, 712.9500934934505, 9392.624295028123, 9699.185541882222, 9826.4104153751, 9885.802283954425, 9945.900540994497, 513.1532970598468, 531.2376739379004, 582.4932308891292, 633.2003414120952, 725.6263024542365, 4191.958080419217, 4541.909161816745, 4542.750148741785, 4591.242444996538, 4751.904961900743, 63238.68380658067, 63446.36553634405, 63691.68154159199, 63975.68012159909, 63991.36008639854, 54645.72677136589, 56370.718146409, 57471.0, 57821.421785781604, 58080.70959645175, 49222.26166607432, 50657.746711266205, 51036.48963510391, 52808.73595631997, 53819.0, 10095.343802652804, 10180.338278012201, 10278.588856445658, 10339.327943683636, 10388.532516036645, 38621.227575448895, 38776.0, 39119.41320880132, 39307.6069239304, 39578.406323904586, 46306.53693463157, 49059.5094049055, 50802.74598626983, 51046.23430648618, 51208.23187652263, 13081.345932703518, 13122.60632181036, 13147.14543554666, 13269.734605308033, 13394.464221431423, 13196.60410187696, 13241.735165296448, 13262.403191856196, 13308.201507909556, 13448.058635895393, 12210.57262995791, 12279.079069069678, 12653.683657908627, 13046.282454465096, 13317.866821331663, 12521.436535356113, 12646.430910609228, 12837.358132093545, 12892.935535322264, 12906.548270810477, 11364.0, 11902.988245999188, 12178.208416452902, 12728.427220774902, 13240.602781916557, 9714.611415543299, 10453.557238173898, 10473.26687131924, 10574.788504230026, 10841.945790270998, 10467.947660261954, 10877.0, 11096.167787415814, 11418.31490110596, 11490.08079353633], "unit": "score", "name": "yui.html", "value": 6864.897075551284}], "name": "dromaeo_css", "value": 7247.492671342308}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 105.0, 113.0, 108.0, 110.0, 120.0, 112.0, 111.0, 109.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [154.0, 134.0, 157.0, 165.0, 128.0, 151.0, 162.0, 135.0, 174.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 149.1}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 162.0, 165.0, 165.0, 163.0, 162.0, 165.0, 165.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.5}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 76.0, 152.0, 76.0, 73.0, 74.0, 76.0, 170.0, 72.0], "unit": "score", "name": "audio-fft", "value": 91.4}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 148.0, 95.0, 96.0, 95.0, 140.0, 96.0, 95.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 148.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 56.0, 60.0, 57.0, 59.0, 75.0, 63.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 59.6}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 63.0, 65.0, 66.0, 66.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.7}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 82.0, 84.0, 83.0, 83.0, 84.0, 82.0, 83.0, 91.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [115.0, 112.0, 111.0, 112.0, 126.0, 119.0, 111.0, 109.0, 109.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.9}, {"lowerIsBetter": true, "replicates": [142.0, 141.0, 136.0, 139.0, 138.0, 137.0, 137.0, 134.0, 127.0, 124.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.5}, {"lowerIsBetter": true, "replicates": [68.0, 65.0, 70.0, 64.0, 65.0, 66.0, 66.0, 65.0, 66.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.9}], "name": "kraken", "value": 1501.1000000000004}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.41704110500916], "unit": "score", "name": "Richards", "value": 212.1297179999999}, {"lowerIsBetter": false, "replicates": [176.05633802816902], "unit": "score", "name": "DeltaBlue", "value": 375.5502399999999}, {"lowerIsBetter": false, "replicates": [278.473962684489], "unit": "score", "name": "Encrypt", "value": 955.8559709999997}, {"lowerIsBetter": false, "replicates": [5291.005291005291], "unit": "score", "name": "Decrypt", "value": 50.30820900000001}, {"lowerIsBetter": false, "replicates": [929.368029739777], "unit": "score", "name": "RayTrace", "value": 796.2281640000003}, {"lowerIsBetter": false, "replicates": [571.4285714285714], "unit": "score", "name": "Earley", "value": 1166.3102499999995}, {"lowerIsBetter": false, "replicates": [11247.191011235955], "unit": "score", "name": "Boyer", "value": 59.25595104895108}, {"lowerIsBetter": false, "replicates": [39115.38461538462], "unit": "score", "name": "RegExp", "value": 23.289685349065884}, {"lowerIsBetter": false, "replicates": [518.4033177812338], "unit": "score", "name": "Splay", "value": 157.19613900000004}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 21870.969564567167}]} 05:51:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "21870.97"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1501.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7247.50"}}} 05:51:31 INFO - Return code: 0 05:51:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:51:31 INFO - # TBPL SUCCESS # 05:51:31 INFO - Running post-action listener: _resource_record_post_action 05:51:31 INFO - Running post-run listener: _resource_record_post_run 05:51:32 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 4096; Write bytes: 508538880; Read time: 36; Write time: 570340 05:51:32 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 250257408; Read time: 0; Write time: 346880 05:51:32 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 4096; Write bytes: 258281472; Read time: 36; Write time: 223460 05:51:32 INFO - Running post-run listener: _upload_blobber_files 05:51:32 INFO - Blob upload gear active. 05:51:32 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:51:32 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 05:51:32 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', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:51:32 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 Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:51:32 INFO - (blobuploader) - INFO - Open directory for files ... 05:51:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:51:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:51:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:33 INFO - (blobuploader) - INFO - Done attempting. 05:51:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:51:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:51:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:51:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:51:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:51:34 INFO - (blobuploader) - INFO - Done attempting. 05:51:34 INFO - (blobuploader) - INFO - Iteration through files over. 05:51:34 INFO - Return code: 0 05:51:34 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:51:34 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:51:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d021edf4e755eeb251bf865dffea6a169daf8dcca2700d79d10babc9a700f9147b059439ba4332b88ed3f93db3cf33c73fefdd31f42325a2ff64dae40ef07f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d256a96a3bd6be1ca3f2431cfe265d8603609729a5cbc047241ed34026a1f9dbf73ebe16d0aca127317ca85ddd6682daba0d27ef1abea98fe1b9ad3914074e8a"} 05:51:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:51:34 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:51:34 INFO - Contents: 05:51:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d021edf4e755eeb251bf865dffea6a169daf8dcca2700d79d10babc9a700f9147b059439ba4332b88ed3f93db3cf33c73fefdd31f42325a2ff64dae40ef07f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d256a96a3bd6be1ca3f2431cfe265d8603609729a5cbc047241ed34026a1f9dbf73ebe16d0aca127317ca85ddd6682daba0d27ef1abea98fe1b9ad3914074e8a"} 05:51:34 INFO - Running post-run listener: copy_logs_to_upload_dir 05:51:34 INFO - Copying logs to upload dir... 05:51:34 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:51:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.922848 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-02-27 05:51:34.447056) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-27 05:51:34.451035) ========= 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=4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d021edf4e755eeb251bf865dffea6a169daf8dcca2700d79d10babc9a700f9147b059439ba4332b88ed3f93db3cf33c73fefdd31f42325a2ff64dae40ef07f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d256a96a3bd6be1ca3f2431cfe265d8603609729a5cbc047241ed34026a1f9dbf73ebe16d0aca127317ca85ddd6682daba0d27ef1abea98fe1b9ad3914074e8a"} build_url:https://queue.taskcluster.net/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011268 build_url: 'https://queue.taskcluster.net/v1/task/VErgnXtxRIuK0NDpqMtyHg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8d021edf4e755eeb251bf865dffea6a169daf8dcca2700d79d10babc9a700f9147b059439ba4332b88ed3f93db3cf33c73fefdd31f42325a2ff64dae40ef07f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d256a96a3bd6be1ca3f2431cfe265d8603609729a5cbc047241ed34026a1f9dbf73ebe16d0aca127317ca85ddd6682daba0d27ef1abea98fe1b9ad3914074e8a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-27 05:51:34.479539) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:51:34.480129) ========= 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=4ac8d263c7293b36a1be1aed000001be-1456579830.597944-1690602789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004403 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:51:34.563416) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-27 05:51:34.564139) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-27 05:51:34.564793) ========= ========= Total master_lag: 0.28 =========