builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-030 starttime: 1453884975.88 results: success (0) buildid: 20160126223100 builduid: 9945459066354a889baceae2d82d43ff revision: 650a0b9d45398d7bcfa772f05862730d2b88795e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-27 00:56:15.881524) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-27 00:56:15.882292) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-27 00:56:15.882597) ========= 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-1453881294.65609-1592859251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006423 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-27 00:56:15.926405) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-27 00:56:15.926731) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-27 00:56:15.963436) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 00:56:15.963759) ========= 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-1453881294.65609-1592859251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.032338 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 00:56:16.019782) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-27 00:56:16.020068) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-27 00:56:16.020431) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 00:56:16.020710) ========= 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-1453881294.65609-1592859251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-27 00:56:16-- 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% 204M=0s 2016-01-27 00:56:16 (204 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173487 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 00:56:16.209846) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 00:56:16.210156) ========= 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-1453881294.65609-1592859251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.110517 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 00:56:16.332447) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 00:56:16.332803) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 650a0b9d45398d7bcfa772f05862730d2b88795e --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 650a0b9d45398d7bcfa772f05862730d2b88795e --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-1453881294.65609-1592859251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-27 00:56:16,566 truncating revision to first 12 chars 2016-01-27 00:56:16,566 Setting DEBUG logging. 2016-01-27 00:56:16,566 attempt 1/10 2016-01-27 00:56:16,566 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/650a0b9d4539?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-27 00:56:16,799 unpacking tar archive at: mozilla-inbound-650a0b9d4539/testing/mozharness/ program finished with exit code 0 elapsedTime=0.509418 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 00:56:16.855875) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-27 00:56:16.856280) ========= echo 650a0b9d45398d7bcfa772f05862730d2b88795e in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'650a0b9d45398d7bcfa772f05862730d2b88795e'] 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-1453881294.65609-1592859251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 650a0b9d45398d7bcfa772f05862730d2b88795e program finished with exit code 0 elapsedTime=0.004614 script_repo_revision: '650a0b9d45398d7bcfa772f05862730d2b88795e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-27 00:56:16.907661) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-27 00:56:16.908010) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-27 00:56:16.918868) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-27 00:56:16.919324) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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-1453881294.65609-1592859251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:56:17 INFO - MultiFileLogger online at 20160127 00:56:17 in /builds/slave/test-pgo 00:56:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 00:56:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 00:56:17 INFO - {'append_to_log': False, 00:56:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 00:56:17 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 00:56:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 00:56:17 INFO - 'branch': 'Mozilla-Inbound', 00:56:17 INFO - 'buildbot_json_path': 'buildprops.json', 00:56:17 INFO - 'config_files': ('talos/linux_config.py',), 00:56:17 INFO - 'default_actions': ('clobber', 00:56:17 INFO - 'read-buildbot-config', 00:56:17 INFO - 'download-and-extract', 00:56:17 INFO - 'populate-webroot', 00:56:17 INFO - 'create-virtualenv', 00:56:17 INFO - 'install', 00:56:17 INFO - 'run-tests'), 00:56:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:56:17 INFO - 'download_minidump_stackwalk': True, 00:56:17 INFO - 'download_symbols': 'ondemand', 00:56:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:56:17 INFO - 'tooltool.py': '/tools/tooltool.py', 00:56:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:56:17 INFO - '/tools/misc-python/virtualenv.py')}, 00:56:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:56:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:56:17 INFO - 'installer_path': 'installer.exe', 00:56:17 INFO - 'log_level': 'info', 00:56:17 INFO - 'log_name': 'talos', 00:56:17 INFO - 'log_to_console': True, 00:56:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:56:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:56:17 INFO - 'opt_config_files': (), 00:56:17 INFO - 'pip_index': False, 00:56:17 INFO - 'sps_profile': False, 00:56:17 INFO - 'sps_profile_interval': 0, 00:56:17 INFO - 'suite': 'dromaeojs', 00:56:17 INFO - 'system_bits': '32', 00:56:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:56:17 INFO - 'title': 'talos-linux64-ix-030', 00:56:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:56:17 INFO - 'use_talos_json': True, 00:56:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 00:56:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:56:17 INFO - 'work_dir': 'build'} 00:56:17 INFO - ##### 00:56:17 INFO - ##### Running clobber step. 00:56:17 INFO - ##### 00:56:17 INFO - Running pre-action listener: _resource_record_pre_action 00:56:17 INFO - Running main action method: clobber 00:56:17 INFO - rmtree: /builds/slave/test-pgo/build 00:56:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 00:56:18 INFO - Running post-action listener: _resource_record_post_action 00:56:18 INFO - ##### 00:56:18 INFO - ##### Running read-buildbot-config step. 00:56:18 INFO - ##### 00:56:18 INFO - Running pre-action listener: _resource_record_pre_action 00:56:18 INFO - Running main action method: read_buildbot_config 00:56:18 INFO - Using buildbot properties: 00:56:18 INFO - { 00:56:18 INFO - "project": "", 00:56:18 INFO - "product": "firefox", 00:56:18 INFO - "script_repo_revision": "production", 00:56:18 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 00:56:18 INFO - "repository": "", 00:56:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 00:56:18 INFO - "buildid": "20160126223100", 00:56:18 INFO - "pgo_build": "True", 00:56:18 INFO - "basedir": "/builds/slave/test-pgo", 00:56:18 INFO - "buildnumber": 636, 00:56:18 INFO - "slavename": "talos-linux64-ix-030", 00:56:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:56:18 INFO - "platform": "ubuntu64_hw", 00:56:18 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 00:56:18 INFO - "branch": "mozilla-inbound", 00:56:18 INFO - "repo_path": "integration/mozilla-inbound", 00:56:18 INFO - "revision": "650a0b9d45398d7bcfa772f05862730d2b88795e", 00:56:18 INFO - "stage_platform": "linux64-pgo", 00:56:18 INFO - "builduid": "9945459066354a889baceae2d82d43ff", 00:56:18 INFO - "slavebuilddir": "test" 00:56:18 INFO - } 00:56:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 00:56:18 INFO - Running post-action listener: _resource_record_post_action 00:56:18 INFO - ##### 00:56:18 INFO - ##### Running download-and-extract step. 00:56:18 INFO - ##### 00:56:18 INFO - Running pre-action listener: _resource_record_pre_action 00:56:18 INFO - Running main action method: download_and_extract 00:56:18 INFO - mkdir: /builds/slave/test-pgo/build/tests 00:56:18 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')]} 00:56:18 INFO - https://queue.taskcluster.net/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:56:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/test_packages.json 00:56:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/test_packages.json 00:56:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 00:56:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 00:56:20 INFO - Downloaded 1448 bytes. 00:56:20 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 00:56:20 INFO - Using the following test package requirements: 00:56:20 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 00:56:20 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:56:20 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:56:20 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:20 INFO - u'jsshell-linux-x86_64.zip'], 00:56:20 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:56:20 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 00:56:20 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:56:20 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:56:20 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:56:20 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 00:56:20 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:20 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:56:20 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:56:20 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')]} 00:56:20 INFO - https://queue.taskcluster.net/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:56:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 00:56:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 00:56:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 00:56:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:56:28 INFO - Downloaded 22505208 bytes. 00:56:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 00:56:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 00:56:29 INFO - Return code: 0 00:56:29 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:29 INFO - https://queue.taskcluster.net/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:56:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 00:56:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 00:56:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 00:56:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:56:31 INFO - Downloaded 22505208 bytes. 00:56:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 00:56:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 00:56:32 INFO - Return code: 0 00:56:32 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')]} 00:56:32 INFO - https://queue.taskcluster.net/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:56:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 00:56:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 00:56:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 00:56:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:56:33 INFO - Downloaded 10706572 bytes. 00:56:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 00:56:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 00:56:33 INFO - Return code: 0 00:56: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')]} 00:56:33 INFO - https://queue.taskcluster.net/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:56:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 00:56:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 00:56:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 00:56:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:56:35 INFO - Downloaded 55986341 bytes. 00:56:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 00:56:35 INFO - mkdir: /builds/slave/test-pgo/properties 00:56:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 00:56:35 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 00:56:35 INFO - Contents: 00:56:35 INFO - build_url:https://queue.taskcluster.net/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 00:56:35 INFO - Running post-action listener: _resource_record_post_action 00:56:35 INFO - Running post-action listener: set_extra_try_arguments 00:56:35 INFO - ##### 00:56:35 INFO - ##### Running populate-webroot step. 00:56:35 INFO - ##### 00:56:35 INFO - Running pre-action listener: _resource_record_pre_action 00:56:35 INFO - Running main action method: populate_webroot 00:56:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:56:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:56:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:56:35 INFO - '--tppagecycles', 00:56:35 INFO - '7'], 00:56:35 INFO - 'tests': ['tsvgm']}}, 00:56:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:56:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:56:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:56:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:56:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:56:35 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:56:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:56:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:35 INFO - 'talos_options': ['--e10s'], 00:56:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:56:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:35 INFO - 'tests': ['damp', 'tps']}, 00:56:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:35 INFO - 'talos_options': ['--e10s'], 00:56:35 INFO - 'tests': ['damp', 'tps']}, 00:56:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:56:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:56:35 INFO - 'other': {'tests': ['a11yr', 00:56:35 INFO - 'ts_paint', 00:56:35 INFO - 'tpaint', 00:56:35 INFO - 'sessionrestore', 00:56:35 INFO - 'sessionrestore_no_auto_restore']}, 00:56:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:56:35 INFO - 'tests': ['a11yr', 00:56:35 INFO - 'ts_paint', 00:56:35 INFO - 'tpaint', 00:56:35 INFO - 'sessionrestore', 00:56:35 INFO - 'sessionrestore_no_auto_restore']}, 00:56:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:56:35 INFO - 'tests': ['a11yr', 00:56:35 INFO - 'ts_paint', 00:56:35 INFO - 'tpaint', 00:56:35 INFO - 'sessionrestore', 00:56:35 INFO - 'sessionrestore_no_auto_restore']}, 00:56:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:56:35 INFO - 'tests': ['a11yr', 00:56:35 INFO - 'ts_paint', 00:56:35 INFO - 'tpaint', 00:56:35 INFO - 'sessionrestore', 00:56:35 INFO - 'sessionrestore_no_auto_restore']}, 00:56:35 INFO - 'other_l64': {'tests': ['a11yr', 00:56:35 INFO - 'ts_paint', 00:56:35 INFO - 'tpaint', 00:56:35 INFO - 'sessionrestore', 00:56:35 INFO - 'sessionrestore_no_auto_restore']}, 00:56:35 INFO - 'other_nol64': {'tests': ['a11yr', 00:56:35 INFO - 'ts_paint', 00:56:35 INFO - 'tpaint', 00:56:35 INFO - 'sessionrestore', 00:56:35 INFO - 'sessionrestore_no_auto_restore']}, 00:56:35 INFO - 'svgr': {'tests': ['tsvgx', 00:56:35 INFO - 'tsvgr_opacity', 00:56:35 INFO - 'tart', 00:56:35 INFO - 'tscrollx', 00:56:35 INFO - 'cart']}, 00:56:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:56:35 INFO - 'tests': ['tsvgx', 00:56:35 INFO - 'tsvgr_opacity', 00:56:35 INFO - 'tart', 00:56:35 INFO - 'tscrollx', 00:56:35 INFO - 'cart']}, 00:56:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:35 INFO - 'tests': ['tp5o']}, 00:56:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:35 INFO - 'talos_options': ['--e10s'], 00:56:35 INFO - 'tests': ['tp5o']}, 00:56:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:35 INFO - 'talos_options': ['--xperf_path', 00:56:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:56:35 INFO - 'tests': ['tp5n']}, 00:56:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:35 INFO - 'talos_options': ['--e10s', 00:56:35 INFO - '--xperf_path', 00:56:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:56:35 INFO - 'tests': ['tp5n']}}, 00:56:35 INFO - 'talos.zip': {'path': '', 00:56:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:56:35 INFO - Running post-action listener: _resource_record_post_action 00:56:35 INFO - ##### 00:56:35 INFO - ##### Running create-virtualenv step. 00:56:35 INFO - ##### 00:56:35 INFO - Running pre-action listener: _resource_record_pre_action 00:56:35 INFO - Running main action method: create_virtualenv 00:56:35 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 00:56:35 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 00:56:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 00:56:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:56:35 INFO - Using real prefix '/usr' 00:56:35 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 00:56:35 INFO - Installing distribute.............................................................................................................................................................................................done. 00:56:37 INFO - Installing pip.................done. 00:56:37 INFO - Return code: 0 00:56:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 00:56:37 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')]} 00:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:37 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')]} 00:56:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:37 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 0x7f4b80fc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19937f0>, '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 0x18ff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ff760>, '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-1453881294.65609-1592859251', '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 00:56:37 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 00:56:37 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 00:56:37 INFO - Using env: {'DISPLAY': ':0', 00:56:37 INFO - 'HOME': '/home/cltbld', 00:56:37 INFO - 'LANG': 'en_US.UTF-8', 00:56:37 INFO - 'LANGUAGE': 'en_US:en', 00:56:37 INFO - 'LOGNAME': 'cltbld', 00:56:37 INFO - 'MAIL': '/var/mail/cltbld', 00:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:37 INFO - 'MOZ_NO_REMOTE': '1', 00:56:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:37 INFO - 'NO_EM_RESTART': '1', 00:56:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:56:37 INFO - 'PWD': '/builds/slave/test-pgo', 00:56:37 INFO - 'SHELL': '/bin/bash', 00:56:37 INFO - 'SHLVL': '1', 00:56:37 INFO - 'TERM': 'linux', 00:56:37 INFO - 'TMOUT': '86400', 00:56:37 INFO - 'USER': 'cltbld', 00:56:37 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453881294.65609-1592859251', 00:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:37 INFO - '_': '/tools/buildbot/bin/python'} 00:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:38 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 00:56:38 INFO - Cleaning up... 00:56:38 INFO - Return code: 0 00:56:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 00:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4b80fc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19937f0>, '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 0x18ff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ff760>, '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-1453881294.65609-1592859251', '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 00:56:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 00:56:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 00:56:38 INFO - Using env: {'DISPLAY': ':0', 00:56:38 INFO - 'HOME': '/home/cltbld', 00:56:38 INFO - 'LANG': 'en_US.UTF-8', 00:56:38 INFO - 'LANGUAGE': 'en_US:en', 00:56:38 INFO - 'LOGNAME': 'cltbld', 00:56:38 INFO - 'MAIL': '/var/mail/cltbld', 00:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:38 INFO - 'MOZ_NO_REMOTE': '1', 00:56:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:38 INFO - 'NO_EM_RESTART': '1', 00:56:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:56:38 INFO - 'PWD': '/builds/slave/test-pgo', 00:56:38 INFO - 'SHELL': '/bin/bash', 00:56:38 INFO - 'SHLVL': '1', 00:56:38 INFO - 'TERM': 'linux', 00:56:38 INFO - 'TMOUT': '86400', 00:56:38 INFO - 'USER': 'cltbld', 00:56:38 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453881294.65609-1592859251', 00:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:38 INFO - '_': '/tools/buildbot/bin/python'} 00:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:38 INFO - Downloading/unpacking psutil>=0.7.1 00:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 00:56:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:56:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:56:40 INFO - Installing collected packages: psutil 00:56:40 INFO - Running setup.py install for psutil 00:56:40 INFO - building 'psutil._psutil_linux' extension 00:56:40 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 00:56:40 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 00:56:40 INFO - building 'psutil._psutil_posix' extension 00:56:40 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 00:56:40 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 00:56:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:56:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:56:40 INFO - Successfully installed psutil 00:56:40 INFO - Cleaning up... 00:56:40 INFO - Return code: 0 00:56:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 00:56: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')]} 00:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56: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')]} 00:56:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:40 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 0x7f4b80fc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19937f0>, '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 0x18ff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ff760>, '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-1453881294.65609-1592859251', '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 00:56:40 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 00:56:40 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 00:56:40 INFO - Using env: {'DISPLAY': ':0', 00:56:40 INFO - 'HOME': '/home/cltbld', 00:56:40 INFO - 'LANG': 'en_US.UTF-8', 00:56:40 INFO - 'LANGUAGE': 'en_US:en', 00:56:40 INFO - 'LOGNAME': 'cltbld', 00:56:40 INFO - 'MAIL': '/var/mail/cltbld', 00:56:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:40 INFO - 'MOZ_NO_REMOTE': '1', 00:56:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:40 INFO - 'NO_EM_RESTART': '1', 00:56:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:56:40 INFO - 'PWD': '/builds/slave/test-pgo', 00:56:40 INFO - 'SHELL': '/bin/bash', 00:56:40 INFO - 'SHLVL': '1', 00:56:40 INFO - 'TERM': 'linux', 00:56:40 INFO - 'TMOUT': '86400', 00:56:40 INFO - 'USER': 'cltbld', 00:56:40 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453881294.65609-1592859251', 00:56:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:40 INFO - '_': '/tools/buildbot/bin/python'} 00:56:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:56:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:56:42 INFO - Installing collected packages: mozsystemmonitor 00:56:42 INFO - Running setup.py install for mozsystemmonitor 00:56:42 INFO - Successfully installed mozsystemmonitor 00:56:42 INFO - Cleaning up... 00:56:42 INFO - Return code: 0 00:56:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 00:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:42 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 0x7f4b80fc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19937f0>, '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 0x18ff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ff760>, '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-1453881294.65609-1592859251', '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 00:56:42 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 00:56:42 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 00:56:42 INFO - Using env: {'DISPLAY': ':0', 00:56:42 INFO - 'HOME': '/home/cltbld', 00:56:42 INFO - 'LANG': 'en_US.UTF-8', 00:56:42 INFO - 'LANGUAGE': 'en_US:en', 00:56:42 INFO - 'LOGNAME': 'cltbld', 00:56:42 INFO - 'MAIL': '/var/mail/cltbld', 00:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:42 INFO - 'MOZ_NO_REMOTE': '1', 00:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:42 INFO - 'NO_EM_RESTART': '1', 00:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:56:42 INFO - 'PWD': '/builds/slave/test-pgo', 00:56:42 INFO - 'SHELL': '/bin/bash', 00:56:42 INFO - 'SHLVL': '1', 00:56:42 INFO - 'TERM': 'linux', 00:56:42 INFO - 'TMOUT': '86400', 00:56:42 INFO - 'USER': 'cltbld', 00:56:42 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453881294.65609-1592859251', 00:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:42 INFO - '_': '/tools/buildbot/bin/python'} 00:56:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:43 INFO - Downloading/unpacking blobuploader==1.2.4 00:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:44 INFO - Downloading blobuploader-1.2.4.tar.gz 00:56:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:56:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:56:44 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 00:56:44 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 00:56:44 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 00:56:44 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 00:56:44 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 00:56:44 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 00:56:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 00:56:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:56: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 00:56: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 00:56: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 00:56: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 00:56: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 00:56: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 00:56:45 INFO - Downloading docopt-0.6.1.tar.gz 00:56:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 00:56:45 INFO - Installing collected packages: blobuploader, requests, docopt 00:56:45 INFO - Running setup.py install for blobuploader 00:56:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:56:45 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 00:56:45 INFO - Running setup.py install for requests 00:56:46 INFO - Running setup.py install for docopt 00:56:46 INFO - Successfully installed blobuploader requests docopt 00:56:46 INFO - Cleaning up... 00:56:46 INFO - Return code: 0 00:56:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:46 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 0x7f4b80fc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19937f0>, '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 0x18ff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ff760>, '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-1453881294.65609-1592859251', '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 00:56:46 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 00:56:46 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 00:56:46 INFO - Using env: {'DISPLAY': ':0', 00:56:46 INFO - 'HOME': '/home/cltbld', 00:56:46 INFO - 'LANG': 'en_US.UTF-8', 00:56:46 INFO - 'LANGUAGE': 'en_US:en', 00:56:46 INFO - 'LOGNAME': 'cltbld', 00:56:46 INFO - 'MAIL': '/var/mail/cltbld', 00:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:46 INFO - 'MOZ_NO_REMOTE': '1', 00:56:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:46 INFO - 'NO_EM_RESTART': '1', 00:56:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:56:46 INFO - 'PWD': '/builds/slave/test-pgo', 00:56:46 INFO - 'SHELL': '/bin/bash', 00:56:46 INFO - 'SHLVL': '1', 00:56:46 INFO - 'TERM': 'linux', 00:56:46 INFO - 'TMOUT': '86400', 00:56:46 INFO - 'USER': 'cltbld', 00:56:46 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453881294.65609-1592859251', 00:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:46 INFO - '_': '/tools/buildbot/bin/python'} 00:56:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:56:46 INFO - Running setup.py (path:/tmp/pip-xVOzmS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:56:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:56:46 INFO - Running setup.py (path:/tmp/pip-i974jd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:56:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:56:46 INFO - Running setup.py (path:/tmp/pip-rL3swC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:56:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:56:46 INFO - Running setup.py (path:/tmp/pip-zLzxjK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:56:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:56:46 INFO - Running setup.py (path:/tmp/pip-m6cfLo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:56:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:56:46 INFO - Running setup.py (path:/tmp/pip-3rrXiK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:56:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:56:46 INFO - Running setup.py (path:/tmp/pip-uRVkny-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:56:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:56:46 INFO - Running setup.py (path:/tmp/pip-6_GVEG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:56:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:56:47 INFO - Running setup.py (path:/tmp/pip-9TMgN6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:56:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:56:47 INFO - Running setup.py (path:/tmp/pip-bgDgBA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:56:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:56:47 INFO - Running setup.py (path:/tmp/pip-HQ76gK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:56:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:56:47 INFO - Running setup.py (path:/tmp/pip-bVBrsY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:56:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:56:47 INFO - Running setup.py (path:/tmp/pip-B0NHh0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:56:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:56:47 INFO - Running setup.py (path:/tmp/pip-dU9yBT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:56:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:56:47 INFO - Running setup.py (path:/tmp/pip-d7_2Sa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:56:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:56:47 INFO - Running setup.py (path:/tmp/pip-on2xda-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:56:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:56:47 INFO - Running setup.py (path:/tmp/pip-DkYCv1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:56:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:56:47 INFO - Running setup.py install for manifestparser 00:56:47 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 00:56:47 INFO - Running setup.py install for mozcrash 00:56:47 INFO - Running setup.py install for mozdebug 00:56:47 INFO - Running setup.py install for mozdevice 00:56:48 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 00:56:48 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 00:56:48 INFO - Running setup.py install for mozfile 00:56:48 INFO - Running setup.py install for mozhttpd 00:56:48 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 00:56:48 INFO - Running setup.py install for mozinfo 00:56:48 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 00:56:48 INFO - Running setup.py install for mozInstall 00:56:48 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 00:56:48 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 00:56:48 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 00:56:48 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 00:56:48 INFO - Running setup.py install for mozleak 00:56:48 INFO - Running setup.py install for mozlog 00:56:48 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 00:56:48 INFO - Running setup.py install for moznetwork 00:56:48 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 00:56:48 INFO - Running setup.py install for mozprocess 00:56:48 INFO - Running setup.py install for mozprofile 00:56:48 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 00:56:48 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 00:56:48 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 00:56:48 INFO - Running setup.py install for mozrunner 00:56:49 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 00:56:49 INFO - Running setup.py install for mozscreenshot 00:56:49 INFO - Running setup.py install for moztest 00:56:49 INFO - Running setup.py install for mozversion 00:56:49 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 00:56:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:56:49 INFO - Cleaning up... 00:56:49 INFO - Return code: 0 00:56:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:49 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 0x7f4b80fc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19937f0>, '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 0x18ff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ff760>, '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-1453881294.65609-1592859251', '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 00:56:49 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 00:56:49 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 00:56:49 INFO - Using env: {'DISPLAY': ':0', 00:56:49 INFO - 'HOME': '/home/cltbld', 00:56:49 INFO - 'LANG': 'en_US.UTF-8', 00:56:49 INFO - 'LANGUAGE': 'en_US:en', 00:56:49 INFO - 'LOGNAME': 'cltbld', 00:56:49 INFO - 'MAIL': '/var/mail/cltbld', 00:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:49 INFO - 'MOZ_NO_REMOTE': '1', 00:56:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:49 INFO - 'NO_EM_RESTART': '1', 00:56:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:56:49 INFO - 'PWD': '/builds/slave/test-pgo', 00:56:49 INFO - 'SHELL': '/bin/bash', 00:56:49 INFO - 'SHLVL': '1', 00:56:49 INFO - 'TERM': 'linux', 00:56:49 INFO - 'TMOUT': '86400', 00:56:49 INFO - 'USER': 'cltbld', 00:56:49 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453881294.65609-1592859251', 00:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:49 INFO - '_': '/tools/buildbot/bin/python'} 00:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:56:49 INFO - Running setup.py (path:/tmp/pip-vSGxAU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:56:49 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)) 00:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:56:49 INFO - Running setup.py (path:/tmp/pip-lUh7GD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:56:49 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)) 00:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:56:49 INFO - Running setup.py (path:/tmp/pip-uzUuDn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:56:49 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)) 00:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:56:49 INFO - Running setup.py (path:/tmp/pip-S_MpCB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:56:49 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)) 00:56:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:56:49 INFO - Running setup.py (path:/tmp/pip-ZM0koj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:56:50 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)) 00:56:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:56:50 INFO - Running setup.py (path:/tmp/pip-vNZ0BJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:56:50 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)) 00:56:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:56:50 INFO - Running setup.py (path:/tmp/pip-byjAtu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:56:50 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)) 00:56:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:56:50 INFO - Running setup.py (path:/tmp/pip-uQqPxy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:56:50 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)) 00:56:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:56:50 INFO - Running setup.py (path:/tmp/pip-WKn1MP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:56:50 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)) 00:56:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:56:50 INFO - Running setup.py (path:/tmp/pip-ErWyxE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:56:50 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)) 00:56:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:56:50 INFO - Running setup.py (path:/tmp/pip-IqwPQN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:56:50 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)) 00:56:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:56:50 INFO - Running setup.py (path:/tmp/pip-4MmxIf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:56:50 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)) 00:56:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:56:50 INFO - Running setup.py (path:/tmp/pip-_fcR8G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:56:50 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)) 00:56:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:56:50 INFO - Running setup.py (path:/tmp/pip-bfeqtW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:56:50 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)) 00:56:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:56:50 INFO - Running setup.py (path:/tmp/pip-jaqlA8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:56:50 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)) 00:56:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:56:50 INFO - Running setup.py (path:/tmp/pip-Po86lG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:56:50 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)) 00:56:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:56:50 INFO - Running setup.py (path:/tmp/pip-QAVVqX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:56:50 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)) 00:56:50 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)) 00:56:50 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)) 00:56:50 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)) 00:56:50 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)) 00:56:50 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)) 00:56:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:56: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 00:56: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 00:56: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 00:56: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 00:56: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 00:56: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 00:56:52 INFO - Downloading blessings-1.6.tar.gz 00:56:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 00:56:52 INFO - Installing collected packages: blessings 00:56:52 INFO - Running setup.py install for blessings 00:56:52 INFO - Successfully installed blessings 00:56:52 INFO - Cleaning up... 00:56:52 INFO - Return code: 0 00:56:52 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 00:56:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:56:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:56:53 INFO - Reading from file tmpfile_stdout 00:56:53 INFO - Current package versions: 00:56:53 INFO - argparse == 1.2.1 00:56:53 INFO - blessings == 1.6 00:56:53 INFO - blobuploader == 1.2.4 00:56:53 INFO - docopt == 0.6.1 00:56:53 INFO - manifestparser == 1.1 00:56:53 INFO - mozInstall == 1.12 00:56:53 INFO - mozcrash == 0.16 00:56:53 INFO - mozdebug == 0.1 00:56:53 INFO - mozdevice == 0.48 00:56:53 INFO - mozfile == 1.2 00:56:53 INFO - mozhttpd == 0.7 00:56:53 INFO - mozinfo == 0.9 00:56:53 INFO - mozleak == 0.1 00:56:53 INFO - mozlog == 3.1 00:56:53 INFO - moznetwork == 0.27 00:56:53 INFO - mozprocess == 0.22 00:56:53 INFO - mozprofile == 0.28 00:56:53 INFO - mozrunner == 6.11 00:56:53 INFO - mozscreenshot == 0.1 00:56:53 INFO - mozsystemmonitor == 0.0 00:56:53 INFO - moztest == 0.7 00:56:53 INFO - mozversion == 1.4 00:56:53 INFO - psutil == 3.1.1 00:56:53 INFO - requests == 1.2.3 00:56:53 INFO - wsgiref == 0.1.2 00:56:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:56: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')]} 00:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56: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')]} 00:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:53 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 0x7f4b80fc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19937f0>, '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 0x18ff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ff760>, '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-1453881294.65609-1592859251', '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 00:56:53 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 00:56:53 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 00:56:53 INFO - Using env: {'DISPLAY': ':0', 00:56:53 INFO - 'HOME': '/home/cltbld', 00:56:53 INFO - 'LANG': 'en_US.UTF-8', 00:56:53 INFO - 'LANGUAGE': 'en_US:en', 00:56:53 INFO - 'LOGNAME': 'cltbld', 00:56:53 INFO - 'MAIL': '/var/mail/cltbld', 00:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:53 INFO - 'MOZ_NO_REMOTE': '1', 00:56:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:53 INFO - 'NO_EM_RESTART': '1', 00:56:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:56:53 INFO - 'PWD': '/builds/slave/test-pgo', 00:56:53 INFO - 'SHELL': '/bin/bash', 00:56:53 INFO - 'SHLVL': '1', 00:56:53 INFO - 'TERM': 'linux', 00:56:53 INFO - 'TMOUT': '86400', 00:56:53 INFO - 'USER': 'cltbld', 00:56:53 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453881294.65609-1592859251', 00:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:53 INFO - '_': '/tools/buildbot/bin/python'} 00:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:53 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)) 00:56:53 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)) 00:56:53 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)) 00:56:53 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)) 00:56:53 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)) 00:56:53 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)) 00:56:53 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)) 00:56:53 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)) 00:56:53 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)) 00:56:53 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)) 00:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 00:56:53 INFO - Cleaning up... 00:56:53 INFO - Return code: 0 00:56:53 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 00:56: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')]} 00:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56: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')]} 00:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:53 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 0x7f4b80fc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19937f0>, '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 0x18ff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ff760>, '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-1453881294.65609-1592859251', '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 00:56:53 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 00:56:53 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 00:56:53 INFO - Using env: {'DISPLAY': ':0', 00:56:53 INFO - 'HOME': '/home/cltbld', 00:56:53 INFO - 'LANG': 'en_US.UTF-8', 00:56:53 INFO - 'LANGUAGE': 'en_US:en', 00:56:53 INFO - 'LOGNAME': 'cltbld', 00:56:53 INFO - 'MAIL': '/var/mail/cltbld', 00:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:53 INFO - 'MOZ_NO_REMOTE': '1', 00:56:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:53 INFO - 'NO_EM_RESTART': '1', 00:56:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:56:53 INFO - 'PWD': '/builds/slave/test-pgo', 00:56:53 INFO - 'SHELL': '/bin/bash', 00:56:53 INFO - 'SHLVL': '1', 00:56:53 INFO - 'TERM': 'linux', 00:56:53 INFO - 'TMOUT': '86400', 00:56:53 INFO - 'USER': 'cltbld', 00:56:53 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453881294.65609-1592859251', 00:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:53 INFO - '_': '/tools/buildbot/bin/python'} 00:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:53 INFO - Downloading/unpacking jsonschema 00:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:56:55 INFO - Downloading/unpacking functools32 (from jsonschema) 00:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:55 INFO - Downloading functools32-3.2.3-2.tar.gz 00:56:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 00:56:55 INFO - warning: no files found matching '*.txt' 00:56:55 INFO - no previously-included directories found matching 'build' 00:56:55 INFO - no previously-included directories found matching 'dist' 00:56:55 INFO - no previously-included directories found matching '.git*' 00:56:55 INFO - Installing collected packages: jsonschema, functools32 00:56:55 INFO - Running setup.py install for functools32 00:56:55 INFO - warning: no files found matching '*.txt' 00:56:55 INFO - no previously-included directories found matching 'build' 00:56:55 INFO - no previously-included directories found matching 'dist' 00:56:55 INFO - no previously-included directories found matching '.git*' 00:56:55 INFO - Successfully installed jsonschema functools32 00:56:55 INFO - Cleaning up... 00:56:55 INFO - Return code: 0 00:56:55 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 00:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:55 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 0x7f4b80fc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1901230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19937f0>, '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 0x18ff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ff760>, '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-1453881294.65609-1592859251', '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 00:56:55 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 00:56:55 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 00:56:55 INFO - Using env: {'DISPLAY': ':0', 00:56:55 INFO - 'HOME': '/home/cltbld', 00:56:55 INFO - 'LANG': 'en_US.UTF-8', 00:56:55 INFO - 'LANGUAGE': 'en_US:en', 00:56:55 INFO - 'LOGNAME': 'cltbld', 00:56:55 INFO - 'MAIL': '/var/mail/cltbld', 00:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:55 INFO - 'MOZ_NO_REMOTE': '1', 00:56:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:55 INFO - 'NO_EM_RESTART': '1', 00:56:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:56:55 INFO - 'PWD': '/builds/slave/test-pgo', 00:56:55 INFO - 'SHELL': '/bin/bash', 00:56:55 INFO - 'SHLVL': '1', 00:56:55 INFO - 'TERM': 'linux', 00:56:55 INFO - 'TMOUT': '86400', 00:56:55 INFO - 'USER': 'cltbld', 00:56:55 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453881294.65609-1592859251', 00:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:55 INFO - '_': '/tools/buildbot/bin/python'} 00:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:55 INFO - Downloading/unpacking flake8 00:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:56:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:56:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:56: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 00:56: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 00:56: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 00:56: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 00:56: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 00:56: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 00:56:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 00:56:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:56:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:56:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:56:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:56:58 INFO - no previously-included directories found matching 'docs/_build' 00:56:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:56:58 INFO - Running setup.py install for pep8 00:56:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:56:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:56:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:56:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:56:58 INFO - no previously-included directories found matching 'docs/_build' 00:56:58 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 00:56:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:56:58 INFO - Cleaning up... 00:56:58 INFO - Return code: 0 00:56:58 INFO - Running post-action listener: _resource_record_post_action 00:56:58 INFO - Running post-action listener: _start_resource_monitoring 00:56:58 INFO - Starting resource monitoring. 00:56:58 INFO - ##### 00:56:58 INFO - ##### Running install step. 00:56:58 INFO - ##### 00:56:58 INFO - Running pre-action listener: _resource_record_pre_action 00:56:58 INFO - Running main action method: install 00:56:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:56:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:56:58 INFO - Reading from file tmpfile_stdout 00:56:58 INFO - Detecting whether we're running mozinstall >=1.0... 00:56:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 00:56:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 00:56:58 INFO - Reading from file tmpfile_stdout 00:56:58 INFO - Output received: 00:56:58 INFO - Usage: mozinstall [options] installer 00:56:58 INFO - Options: 00:56:58 INFO - -h, --help show this help message and exit 00:56:58 INFO - -d DEST, --destination=DEST 00:56:58 INFO - Directory to install application into. [default: 00:56:58 INFO - "/builds/slave/test-pgo"] 00:56:58 INFO - --app=APP Application being installed. [default: firefox] 00:56:58 INFO - mkdir: /builds/slave/test-pgo/build/application 00:56:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 00:56:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 00:57:15 INFO - Reading from file tmpfile_stdout 00:57:15 INFO - Output received: 00:57:15 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 00:57:15 INFO - Running post-action listener: _resource_record_post_action 00:57:15 INFO - ##### 00:57:15 INFO - ##### Running run-tests step. 00:57:15 INFO - ##### 00:57:15 INFO - Running pre-action listener: _resource_record_pre_action 00:57:15 INFO - Running main action method: run_tests 00:57:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 00:57:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 00:57:15 INFO - Python 2.7.3 00:57:15 INFO - Return code: 0 00:57:15 INFO - grabbing minidump binary from tooltool 00:57:15 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')]} 00:57:15 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 0x19937f0>, '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 0x18ff2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ff760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 00:57:15 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 00:57:15 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 00:57:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:57:15 INFO - Return code: 0 00:57:15 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 00:57:15 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 00:57:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 00:57:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 00:57:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 00:57:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 00:57:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 00:57:16 INFO - Return code: 0 00:57:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.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_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 00:57:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.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_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 00:57:16 INFO - Using env: {'DISPLAY': ':0', 00:57:16 INFO - 'HOME': '/home/cltbld', 00:57:16 INFO - 'LANG': 'en_US.UTF-8', 00:57:16 INFO - 'LANGUAGE': 'en_US:en', 00:57:16 INFO - 'LOGNAME': 'cltbld', 00:57:16 INFO - 'MAIL': '/var/mail/cltbld', 00:57:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:57:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 00:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:57:16 INFO - 'MOZ_NO_REMOTE': '1', 00:57:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:57:16 INFO - 'NO_EM_RESTART': '1', 00:57:16 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:57:16 INFO - 'PWD': '/builds/slave/test-pgo', 00:57:16 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 00:57:16 INFO - 'SHELL': '/bin/bash', 00:57:16 INFO - 'SHLVL': '1', 00:57:16 INFO - 'TERM': 'linux', 00:57:16 INFO - 'TMOUT': '86400', 00:57:16 INFO - 'USER': 'cltbld', 00:57:16 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1453881294.65609-1592859251', 00:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:57:16 INFO - '_': '/tools/buildbot/bin/python'} 00:57:16 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.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_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:57:16 INFO - mozversion application_buildid: 20160126223100 00:57:16 INFO - mozversion application_changeset: 650a0b9d45398d7bcfa772f05862730d2b88795e 00:57:16 INFO - mozversion application_display_name: Nightly 00:57:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:57:16 INFO - mozversion application_name: Firefox 00:57:16 INFO - mozversion application_remotingname: firefox 00:57:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:57:16 INFO - mozversion application_vendor: Mozilla 00:57:16 INFO - mozversion application_version: 47.0a1 00:57:16 INFO - mozversion platform_buildid: 20160126223100 00:57:16 INFO - mozversion platform_changeset: 650a0b9d45398d7bcfa772f05862730d2b88795e 00:57:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:57:16 INFO - mozversion platform_version: 47.0a1 00:57:16 INFO - using testdate: 1453885036 00:57:16 INFO - actual date: 1453885036 00:57:16 INFO - starting webserver on 'localhost:42169' 00:57:16 INFO - SUITE-START | Running 3 tests 00:57:16 INFO - TEST-START | dromaeo_css 00:57:16 INFO - operating with platform_type : linux_ 00:57:16 INFO - Initialising browser for dromaeo_css test... 00:57:16 INFO - TEST-INFO | started process 27858 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPKKBIo/profile http://localhost:42169/getInfo.html) 00:57:20 INFO - PROCESS | 27858 | __metrics Screen width/height:1600/1200 00:57:20 INFO - PROCESS | 27858 | colorDepth:24 00:57:20 INFO - PROCESS | 27858 | Browser inner width/height: 1024/697 00:57:20 INFO - PROCESS | 27858 | __metrics 00:57:20 INFO - PROCESS | 27858 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 00:57:20 INFO - PROCESS | 27858 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:57:21 INFO - TEST-INFO | 27858: exit 0 00:57:21 INFO - Browser initialized. 00:57:21 INFO - Running cycle 1/1 for dromaeo_css test... 00:57:21 INFO - TEST-INFO | started process 27950 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPKKBIo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:57:33 INFO - PROCESS | 27950 | RSS: Main: 148684800 00:57:33 INFO - PROCESS | 27950 | 00:58:24 INFO - PROCESS | 27950 | 1453885104797 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] 01:00:32 INFO - PROCESS | 27950 | Cycle 1(1): loaded http://localhost:42169/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42169/tests/dromaeo/cssquery-ext.html) 01:00:34 INFO - PROCESS | 27950 | RSS: Main: 265605120 01:00:34 INFO - PROCESS | 27950 | 01:03:36 INFO - PROCESS | 27950 | Cycle 1(1): loaded http://localhost:42169/tests/dromaeo/cssquery-ext.html (next: http://localhost:42169/tests/dromaeo/cssquery-jquery.html) 01:03:37 INFO - PROCESS | 27950 | RSS: Main: 234430464 01:03:37 INFO - PROCESS | 27950 | 01:06:39 INFO - PROCESS | 27950 | Cycle 1(1): loaded http://localhost:42169/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42169/tests/dromaeo/cssquery-mootools.html) 01:06:39 INFO - PROCESS | 27950 | RSS: Main: 235896832 01:06:39 INFO - PROCESS | 27950 | 01:09:41 INFO - PROCESS | 27950 | Cycle 1(1): loaded http://localhost:42169/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42169/tests/dromaeo/cssquery-prototype.html) 01:09:42 INFO - PROCESS | 27950 | RSS: Main: 212983808 01:09:42 INFO - PROCESS | 27950 | 01:12:44 INFO - PROCESS | 27950 | Cycle 1(1): loaded http://localhost:42169/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42169/tests/dromaeo/cssquery-yui.html) 01:12:45 INFO - PROCESS | 27950 | RSS: Main: 218853376 01:12:45 INFO - PROCESS | 27950 | 01:15:48 INFO - PROCESS | 27950 | Cycle 1(1): loaded http://localhost:42169/tests/dromaeo/cssquery-yui.html (next: http://localhost:42169/tests/dromaeo/cssquery-dojo.html) 01:15:48 INFO - PROCESS | 27950 | RSS: Main: 280535040 01:15:48 INFO - PROCESS | 27950 | 01:15:48 INFO - PROCESS | 27950 | __start_tp_report 01:15:48 INFO - PROCESS | 27950 | _x_x_mozilla_page_load 01:15:48 INFO - PROCESS | 27950 | _x_x_mozilla_page_load_details 01:15:48 INFO - PROCESS | 27950 | |i|pagename|runs| 01:15:48 INFO - PROCESS | 27950 | |0;dojo.html;3103.844807759612;3112.8132312061266;3157.6210854697424;3165.2719874428867;3180.363927214558;4969.2049272116465;5044.369453818273;5076.847694569165;5078.162103252964;5089.923651145235;4932.482089380608;5104.6937183768905;5169.638125331228;5191.428942816287;5196.454372290912;4660.487346391894;4681.929771053428;4698.694584851991;4814.229723244282;4827.348307978431;4749.596284315838;4762.928556071662;4784.856454306359;4829.541193586621;4869.464358920516;4554.72671639701;4641.466231383383;4681.695689780154;4792.424909010941;4801.5438533339275;4723.858284251478;4726.456457507396;4726.480087190406;4734.147853386389;4775.379200703921;4708.176069187913;4712.952870471286;4716.221823399135;4728.054389122155;4741.383620129361;4959.20652695567;5002.6748261363255;5068.062408454448;5068.5691716204165;5107.029664363796;5530.0598898187;5566.359868615121;5566.582506312002;5574.665520068768;5581.2186293918885;5498.395176530578;5577.9163312550345;5587.078132108198;5589.916151257735;5590.5527557795685;5102.336696229503;5159.458256883048;5176.197689358156;5177.223416487519;5191.065608190562;5622.550195984311;5630.634008789498;5651.632643878134;5658.773649053992;5675.744591493392;5425.6202065855805;5427.158790387496;5471.23402723619;5473.890522189534;5474;5425.9186112208345;5456.563474921997;5551.361593416728;5603.187537806995;5659;5511.366192887869;5524;5526.530244929226;5540.279763630702;5540.9168862467095;5459.426760190202;5502.889942201214;5522.5858060644805;5553.389127196006;5606.215129881738;4280.700350975464;4341.39220509129;4348.978255108705;4361.672874534423;4375.387445757597;3859.073822282688;3864.9806750966627;3870.767753934773;3903.394973779069;3909.159530700913;5109.412417572027;5136.486351364908;5142.04872098663;5149.871253218625;5150.098732721834;5452.754626041838;5525.917111243334;5555.749991250404;5575.832725018256;5605.747741351649;5189.221616757441;5189.4032186299055;5195.766190521435;5196.636235463481;5197.7401129943355;4784.6889952153;4789.3294938708605;4794.880127996758;4799.256115302133;4842.346283251786;5636.60543761941;5722.4277572242445;5754.74103665336;5775.711214439261;5820.447057529528;5408.729563521887;5409.729513524387;5424.2406063151975;5426.945730542644;5439.456054394529;5582;5596.244506991504;5596.524295434933;5598.972005140111;5606.887862242814;5403.162509810985;5449.972750136224;5461.781528738965;5505.201745746925;5531.0873705838085;5468.398476167698;5490.945090549043;5510.476504732044;5511.751971161227;5514.61397702157;5304.283921670525;5369.1140961740875;5371.301730774974;5407.891842163056;5453.563714902878;5389.730513474232;5419;5423.647462914898;5429.158480435539;5468.863278417913;5350.652207606493;5373.328333958255;5376.086065368819;5378.677279363251;5378.784848606012;5431.212474191299;5464;5473.452654734495;5476.6166368355425;5512.972435137799;5308.840734777963;5322.042032434199;5360.544353729821;5361.946380536301;5415.783368665209 01:15:48 INFO - PROCESS | 27950 | |1;ext.html;535.1945322289955;548.3255595617392;558.1153871114284;564.9180868774027;565.2990292037873;28016.299592510197;28496.715032849665;35717.2856542869;35748.463773043426;35934;39513.20973580526;40014.59985400145;40042.79978600103;40081.19837603254;40151.799241003755;8380.245777880005;8495;8574.657013719476;8576.142385761435;8584.442011269248;8282.668693252293;8416.242538171564;8425.789355266106;8428.704995325164;8463.238308552229;8666.263367613761;8737.257333126692;8740.562971851414;8741.082186370435;8749.16882896127;8480.151984801532;8500.532470714108;8543.401961862672;8554.315654747605;8558.400911936167;8538.957305213435;8664.740057798275;8677.088905664878;8677.652893884237;8685.478871267744;38499.8075009626;38847.8057609713;38900.80549597234;38935.610643893764;39046.804765976274;3210.325831575372;3289.5723555937816;3506.6493350664987;3665.9266814663824;3936.350502167139;29118.27204319888;29313.56029659557;29412;30528.84735576308;30539;3466.2201004773974;3491.8428670709627;3590.425531914881;3611.0972256935765;3685.5024571682748;269611;270276;271260;271759;272542;51355.74322128366;52328;57053.42946570481;57668.423315766304;59029.11456328158;53013.204801928005;53437.73281133569;53524;53676;53735;13457.192568445924;13524.797128043087;13534.390952407166;13539.526116585872;13545.45818167282;10558;10723.356598604109;10750.94624526888;10939.45302734876;10999.34003959749;18609.81390186108;18704.81295187058;18715.625687486176;18766.624667506574;18902.338418155297;6689.919149318912;7037.472189585802;7043.084399028094;7066.964665176642;7082.220955694869;848.8811566380712;872.6727477196051;926.0924294191595;1033.943133127685;1036.0623635609786;28175.295617609314;28294.85852570724;28352.716472835422;28576;28749.712502874703;947.8247422166145;1031.63377001165;1065.9200559958035;1110.0287248657426;1117.458032854065;14643.56069317922;14674.266286685623;14740.557783266519;14971.70056598862;15014.24928753558;318746;321532;321686;321835;322563;50783.49216507788;50950.23574646383;51044.74477627588;51066.23400648993;51131.233031504555;1307.6730817295677;1323.1730168644597;1334.6129622409587;1335.826342575459;1336.9866301336863;27055.188344349703;27240.318992025357;28237.356629226968;28239;28276.43447131087;46452;46965.76517117529;46981;47007.76496117497;47026.52973470221;297316;297574;297705;298878;300209;27349.316267092687;30889.8455507721;31404.528932066496;31587.84206078955;31809.840950795096;37957.430638540995;40510;40594.1881162381;41465.37801932913;41483.37774933439;34154.31691366109;34565.82717086399;34573;34792.304153917285;35638.64361356457;28079.95911745259;32970.67029329676;33725.49411758777;34981.30037399289;35272.64727352796;32421.35157296794;32424.351512969137;32729.18177045593;36097.27805443929;36544;28107.859460702566;28880;29731.405371892008;30042.849785750932;31575.526367104972;22883.199088031837;23625.881870590536;24429.633555496326;24526;24815.62776558317 01:15:48 INFO - PROCESS | 27950 | |2;jquery.html;364.94890715299846;366.38081642024974;368.26898606266565;368.64609974424553;369.3628490853277;13503.25732084735;13604.591862244148;15516.379344826208;17010.659786804274;18234.726479102825;15138.772918406232;15613.21933903306;15620.609484762886;15660.060396376226;16781;5360.812371566996;5550.333959924815;5579.721013949286;5582.692951887665;5586.078297080977;4068.8575899843513;4205.243056249874;5507.284053073095;5560.6941618210985;5854.268216472941;5936.673482958436;6136.386361363872;6157.261128664567;6165.982612868894;6168.568200225986;6180.412860778241;6219.1915051043525;6239.220097487814;6241;6249.437550620421;5299.49654782795;5467.480589344046;5486.286782718261;5491.450854914477;5495.395506494322;19528.51178720529;19789;20310.89844550768;20851.478713032146;20879.686804697943;1876.5121068522146;1992.1931617694856;2026.422469596158;2137.7969092936146;2563.8718963655933;12900.225986440844;13070.215787052808;13079.738405231938;13130.343482825916;13217.801732974012;1734.141599908041;1740.02047082906;1817.6092140189924;1822.571695651521;1865.9533511662182;55149;55538.99999999959;57816.421835781526;57866;57950.42049579535;9750.463724495221;9958.203343732484;10093.848592271122;10097.444640544694;10190.541425635864;13202.603921882359;13235.338233088307;13313.20120792736;13319.866801331862;13330.400131994083;7221.061262035902;7237.421006319481;7266.527675701062;7268.709251629875;7361.190269070398;6782.1861376635115;6838.589684618839;6843.760468383683;6889.965550172217;6897.689603967733;5983.910241346383;6022.789202377896;6082.361352058058;6125.295591007002;6149.354317796657;1676.8742344324226;1731.480555833245;1739.678159540489;1803.9098045097955;1806.719958406449;894.6868595991481;923.4643906534194;994.2692121290845;1040.370575801629;1045.163868904873;15038;16331.591710207102;16332.346706131859;17504.737428938577;17605.823941760675;981.5424095218594;1000.1049061090283;1006.9496525173712;1023.4729114506035;1040.152275895143;9140;10011.349262297927;10036.498175091216;10263.435511046964;10370.637027704144;334593;371376;383779;386204;533663;56055.43944560502;63185.36814631887;63787.36212637907;64225;73893;1092.0662833277593;1115.5649296774266;1135.500379832871;1139.1058019454854;1143.89704926557;12066.457009434422;14102.224377659328;14500.564983050524;14670.926645367132;15008.47470338533;29674.406511870075;29859.552106718853;30251;30317.393652127274;30733.692663073976;35609.49374022693;38223;39569.60430395774;39573.60426395699;39824.800875996596;7390.482666213314;7582.924170758221;7611.961940190264;7703;7753.37972962173;10267.94866025665;10689;11171.497282622138;11322.094232461548;11474.827877581676;7016.122984626922;7055.717771289296;7171.533850299714;7308;7337.669804858688;7538.736144234926;7718.266764657348;7748.957735227166;7837.568933708472;7847.254510821463;7204;7254.310840470147;7476.850462990818;7891.84216315659;8018.599070046591;10045.949770251102;10278.588856445958;10303.896961030294;10508.579656813949;10527.789164275588;7488.700451981859;7652.61736913141;7951.284384405431;7959.164287749702;8029.357651387992 01:15:48 INFO - PROCESS | 27950 | |3;mootools.html;1292.2311224821228;1444.8338441079275;1447.2980604406864;1583.1292788966066;1757.2180379731017;7101.502894797366;7284.745033923807;7731.458797884144;7944.165862584432;7966.123726390092;7856.96071519643;7880.566568838712;7956.920430795705;7957;7987.760367188979;2004.7293615361957;2059.4336557446672;2297.4600968772324;2307.938348359748;2317.0268487235317;2258.6499092640584;2328.0687724910085;2329.6272596384583;2329.7320808107115;2330.0563271874835;2161.794629510194;2178.814800741939;2256.17649557911;2256.5148493073984;2256.717910261217;2274.113095892595;2292.255017119443;2297.529006553661;2298.9425264368356;2303.4702018535745;2262.5135595846973;2280.8403411761183;2283.680284760135;2291.2667946257206;2292.7019487466523;7991.520508769434;8133.674653013873;8155.877661835078;8158.918410815934;8162.14297498766;4625.7687115644085;4729.290606409032;4750.121227572876;4755.762211889391;4758.048390321949;2964.584958105867;3087.3825234952874;3140.9214769630944;3141.685831416863;3143.8899638512544;955.4506158958557;955.9330846840654;985.1527686189871;989.5893204320271;1002.7092143278513;10922.508487118019;11014.779704405866;11018;11035.282706624044;11038.944805276002;4071.1043570414463;4200.915981680349;4236.491621005499;4252.87241382759;4258.403823464718;8983.55082245885;9160;9164.633414663473;9168.44989300644;9179.449233046038;4828.855134345905;4841;4841.757912104381;4845;4846.854594362175;4379.562043795659;4440.62254708347;4441.977790111094;4458.130664520452;4459.799309031101;3327.6505966873615;3355.379254837863;3491.1446695559243;3524.4713293006253;3594.0475773919934;1072.383379556758;1078.4769386847372;1084.5553323137476;1090.9890901091046;1099.8130317845985;1218.7196944702769;1228.1648479034343;1250.9624711258678;1251.5744646820124;1262.4571434283162;7207.207207207203;7303.087114110736;7308.269173082649;7377.040984672066;7377.88933166003;1096.1231015187818;1101.9614313499148;1106.9003789658968;1107.6510899066768;1134.982975255372;5550.69471179089;5645.68948707825;5656.971715141398;5658.292713410824;5660.490555849911;9245.90754092464;9257.166854983085;9446.055394460636;9527.714168574954;9560.66537671192;9359.906400935903;9427.811443771223;9475.384100033476;9492.288078394147;9569.760755981017;7303.977443157962;7341.155767086853;7445.739399121005;7505.812354691067;7506.399488041053;6743.325667433218;6786.728530858711;6788.321167883172;6793.72825086991;6794.626295553792;8248.711295104642;8498.405111642373;8525.317974561896;8659.13408659129;8662.956685216534;8465.83068338642;8505.064442911398;8651.178138076873;8677.696280630147;8689.348298877483;6893.655317234018;7205.639718014183;7241.384482319062;7260.346568808833;7260.419166466776;6766.560173588701;6908.965455172692;7278.6724597392185;7407.777766667009;7448.813779655552;6896.241413444617;7039.380942383178;7054.259302773135;7237.312455316736;7258.600776957318;6864.759733409307;6908.620025898423;6924.861502769816;7024.789256322319;7123.646507163622;6899.310068993061;7154.856902861809;7162.89255661155;7165.928340716735;7168.713251469882;6310.337414571404;6311.652859092794;6345.524085693683;6357.809265722036;6361.522885783677;6281.528885333527;6291.182146320949;6309.810705678837;6328.557001009885;6335.90496142549 01:15:48 INFO - PROCESS | 27950 | |4;prototype.html;325.5344856854698;338.8542926541587;343.359634282064;347.5985237051206;356.51691957397725;5731.197632331467;5845.5908086433965;5869.911951320733;5885.529157667382;5904.6457212567275;5662;5783.971080144604;5797.739101740422;5799.159121927318;5804.622699524528;4545.499995000548;4562.247229207185;4564.292534657116;4568.45178578571;4569.268916973285;4346.391505189276;4430.867073987785;4446.733196008234;4519.186546421643;4549.499555048942;4472.060867217888;4497.168023915569;4503.977480112595;4532.546745325458;4541.636669066484;4498.595126438636;4519.84180553679;4527.977360113211;4529.2526733089;4533.455985281755;3981.7610943343493;3983.9243404280683;3987.003249187703;3993.740406873573;4007.5992400759983;5465.180222966586;5589.972050139764;5604.607677462579;5615.241942337773;5618.381977982419;5176.171812510018;5183.922241166386;5185.818496352647;5192.402873669538;5194.584433245332;5926.792562260343;6187.07193920911;6242.313345531988;6257.687115644199;6268.435840774307;4232.76719780412;4274.593913578236;4326.4159338489535;4331.328644060176;4362.062156636339;6436;6492.642904640243;6504.577202481823;6505.707243174022;6520.250171230322;4477.440319960005;4484.215262329079;4485.842995495142;4486.820527178941;4488.506264310923;4455.420795296655;4519.751413672214;4538.591526762607;4539.273716205457;4543.636509079266;5172.250023746611;5192.92210616841;5202.92195617066;5203.635745497854;5210.947890521046;6253.187085678924;6264.248290205204;6266.154069200691;6268.4671802897265;6271.811845644638;1582.6834633073431;1603.559021269137;1604.0375774535185;1604.5587463447412;1606.7429211326132;1051.164324362134;1064.685917654294;1066.8133076711545;1087.0162502934857;1093.7265683579105;5866.882662346815;5890.882182356415;5891.528677705774;5894.086416605347;5898.8230353089475;6426.678666066678;6428.19647544057;6429.646369449725;6431.807045788634;6503.122078519434;5883.294004719461;5887.411258874164;5889.322727886262;5890.8821823563285;5891.293044834647;3369.107186595554;3496.283261931298;3499.0377646147513;3500.054985153994;3500.964990350115;6747.257801641816;6757.155355580552;6763.560368576027;6768.2216545097945;6768.289329620417;6604.174478190226;6604.537682362285;6606.735730570724;6610.735570577219;6611.966940165268;6563.409293163638;6724.899126513106;6731.057651928734;6735.191776986793;6740.595564266159;6188.257409110935;6309.810705678837;6433.5496515243485;6460.709268082854;6506.544541882023;6246.437820596168;6376.681165941777;6390.48876089921;6407;6435.549511534335;6736.797896063126;6742.730290788313;6746.123004009447;6747.257801641717;6749.156355455568;4334.609885110355;4407.757573333497;4435.600795928382;4436.645068394585;4441.089576636847;6422.678866056585;6456.386643268882;6462;6464.5798023128345;6466.191726034246;6293.905591416041;6294.244690637152;6295.937040629535;6307;6307.180066591313;6149.108379284889;6200.255969283535;6263.248410190807;6279.152314437492;6286.654234017173;6172.506199504119;6173.475254603409;6179.567430279837;6180.690965451619;6185;6307.96846015767;6311.90532142009;6318.652474113784;6319.684015799284;6321.146645203023;6066.939330606638;6138.1713468681155;6162.445379915829;6175.980963141032;6176 01:15:48 INFO - PROCESS | 27950 | |5;yui.html;762.1654288554031;776.7397921696235;842.1494290766326;844.2823599940052;876.9605367758451;12690.936545317272;12916.612501624943;12950.611481655553;12955.611331660042;12959.222446653195;11655.825162622546;11703.707407314821;11722.765544689122;11744;11763.176577639568;650.4113777031794;663.4128796015536;785.022646804726;804.6741069866684;807.4711064252924;806.173671986213;810.027966440274;811.111832543364;812.305478815613;813.4590497319275;694.0942070597868;845.750503601439;845.8435189489933;845.9915400846005;846.196113691992;693.7918624412681;695.544418405945;829.1294141151797;840.9075001749802;841.2008591837779;614.1034090228272;618.9535784816156;619.4517851701277;620.7920346683866;621.2886245249209;12444.937775311066;12456.688582785413;12522.060845436537;12523.311217883012;12523.624291271277;12270.570530031495;12493;12595.874041259653;12900.161489503153;13040.739185216242;9415.199708024826;9491.356548597605;9512.809743805085;9541.33210675253;10013.549390277454;3563.4120370138894;3576.8211589420685;3582.982085089558;3599.0642432967616;3717.5353080864893;46544.53455465436;46883.76558117187;46935.530644693456;47149.52850471486;48817.26774098356;9709.271804614682;10165.237607179492;10167.644132455329;10237.539310730886;10334.689959301233;18144;18158.09209539518;18171.63656726858;18197.90901045513;18226.544336391697;7018.438524917994;7077.433805295667;7108.36024757764;7127.679254433563;7141.143062832493;4112.856050038235;4211.241976444208;4228.23891699497;4244.87265382039;4289.849855255051;2946.5138252188576;2954.4829654810324;2975.5685425613165;2976.0922918509627;2986.25343664084;527.741406710709;547.1409886478191;550.6090675620275;551.4072372199821;565.1071307334402;533.0857579251602;605.3552966091099;617.6973283091253;670.0786418674322;675;7511.211322811027;7531.756810737393;7597.278258565428;7601.543907365576;7733.651985660659;501.67641870993003;632.8354627796806;677.8847595908708;680.6766785776716;697.5570512724355;3751.9812400938367;3781.4327850822046;3785.6782173515558;3911.061345277113;3918.8628398005935;55115.17327240095;55208;55224.72387638116;55286.17070743942;55341.723291383285;45144.3228351575;45734.54265457369;50127.49872501228;50571.74714126406;50654;43448.78275608665;43890.78054609706;44529.109417811465;44917.77541112273;44937.62967777364;8525.403221774664;8624.698135565224;8636.136386361313;8760.91239087601;8776.824463510566;34321.48517772186;34962.47556286708;35597.288054238255;35669.46495802513;35861.820690897424;44310.55689443064;44523.10953780971;46116;47349.28976065293;48905;10889.624216492912;11176.16178786578;11228.157888158585;11429.371384573928;11540.249883757864;12513.687157821127;12595.370231488572;12637.17858339205;12734.490620375082;12893.677658058248;11185.384803835866;11536.480858361561;11760.88239117598;12027.939860300643;12035;11138.33170009802;11163.665090047312;11409.828852567383;11727.530898763955;12516.561920332744;10870.673879783619;11219.71950701239;11316.20786544934;11620.186586938833;11685.474153663276;9803.362781419184;9904.702858914245;10084.69745907624;10198.133158681596;10322.948385258025;8996.55017249122;9442.339036267671;9444.197243234403;9510.992817660293;9876.901230987598 01:15:48 INFO - PROCESS | 27950 | __end_tp_report 01:15:48 INFO - PROCESS | 27950 | __start_cc_report 01:15:48 INFO - PROCESS | 27950 | _x_x_mozilla_cycle_collect,957 01:15:48 INFO - PROCESS | 27950 | __end_cc_report 01:15:48 INFO - PROCESS | 27950 | __startTimestamp1453886148398__endTimestamp 01:15:48 INFO - PROCESS | 27950 | 01:15:48 INFO - PROCESS | 27950 | ------- Summary: start ------- 01:15:48 INFO - PROCESS | 27950 | Number of tests: 6 01:15:48 INFO - PROCESS | 27950 | 01:15:48 INFO - PROCESS | 27950 | [#0] dojo.html Cycles:165 Average:5141.54 Median:5371.30 stddev:546.58 (10.2%) stddev-sans-first:524.36 01:15:48 INFO - PROCESS | 27950 | Values: 3103.8 3112.8 3157.6 3165.3 3180.4 4969.2 5044.4 5076.8 5078.2 5089.9 4932.5 5104.7 5169.6 5191.4 5196.5 4660.5 4681.9 4698.7 4814.2 4827.3 4749.6 4762.9 4784.9 4829.5 4869.5 4554.7 4641.5 4681.7 4792.4 4801.5 4723.9 4726.5 4726.5 4734.1 4775.4 4708.2 4713.0 4716.2 4728.1 4741.4 4959.2 5002.7 5068.1 5068.6 5107.0 5530.1 5566.4 5566.6 5574.7 5581.2 5498.4 5577.9 5587.1 5589.9 5590.6 5102.3 5159.5 5176.2 5177.2 5191.1 5622.6 5630.6 5651.6 5658.8 5675.7 5425.6 5427.2 5471.2 5473.9 5474.0 5425.9 5456.6 5551.4 5603.2 5659.0 5511.4 5524.0 5526.5 5540.3 5540.9 5459.4 5502.9 5522.6 5553.4 5606.2 4280.7 4341.4 4349.0 4361.7 4375.4 3859.1 3865.0 3870.8 3903.4 3909.2 5109.4 5136.5 5142.0 5149.9 5150.1 5452.8 5525.9 5555.7 5575.8 5605.7 5189.2 5189.4 5195.8 5196.6 5197.7 4784.7 4789.3 4794.9 4799.3 4842.3 5636.6 5722.4 5754.7 5775.7 5820.4 5408.7 5409.7 5424.2 5426.9 5439.5 5582.0 5596.2 5596.5 5599.0 5606.9 5403.2 5450.0 5461.8 5505.2 5531.1 5468.4 5490.9 5510.5 5511.8 5514.6 5304.3 5369.1 5371.3 5407.9 5453.6 5389.7 5419.0 5423.6 5429.2 5468.9 5350.7 5373.3 5376.1 5378.7 5378.8 5431.2 5464.0 5473.5 5476.6 5513.0 5308.8 5322.0 5360.5 5361.9 5415.8 01:15:48 INFO - PROCESS | 27950 | 01:15:48 INFO - PROCESS | 27950 | [#1] ext.html Cycles:180 Average:45564.72 Median:19142.07 stddev:77890.99 (406.9%) stddev-sans-first:78036.12 01:15:48 INFO - PROCESS | 27950 | Values: 535.2 548.3 558.1 564.9 565.3 28016.3 28496.7 35717.3 35748.5 35934.0 39513.2 40014.6 40042.8 40081.2 40151.8 8380.2 8495.0 8574.7 8576.1 8584.4 8282.7 8416.2 8425.8 8428.7 8463.2 8666.3 8737.3 8740.6 8741.1 8749.2 8480.2 8500.5 8543.4 8554.3 8558.4 8539.0 8664.7 8677.1 8677.7 8685.5 38499.8 38847.8 38900.8 38935.6 39046.8 3210.3 3289.6 3506.6 3665.9 3936.4 29118.3 29313.6 29412.0 30528.8 30539.0 3466.2 3491.8 3590.4 3611.1 3685.5 269611.0 270276.0 271260.0 271759.0 272542.0 51355.7 52328.0 57053.4 57668.4 59029.1 53013.2 53437.7 53524.0 53676.0 53735.0 13457.2 13524.8 13534.4 13539.5 13545.5 10558.0 10723.4 10750.9 10939.5 10999.3 18609.8 18704.8 18715.6 18766.6 18902.3 6689.9 7037.5 7043.1 7067.0 7082.2 848.9 872.7 926.1 1033.9 1036.1 28175.3 28294.9 28352.7 28576.0 28749.7 947.8 1031.6 1065.9 1110.0 1117.5 14643.6 14674.3 14740.6 14971.7 15014.2 318746.0 321532.0 321686.0 321835.0 322563.0 50783.5 50950.2 51044.7 51066.2 51131.2 1307.7 1323.2 1334.6 1335.8 1337.0 27055.2 27240.3 28237.4 28239.0 28276.4 46452.0 46965.8 46981.0 47007.8 47026.5 297316.0 297574.0 297705.0 298878.0 300209.0 27349.3 30889.8 31404.5 31587.8 31809.8 37957.4 40510.0 40594.2 41465.4 41483.4 34154.3 34565.8 34573.0 34792.3 35638.6 28080.0 32970.7 33725.5 34981.3 35272.6 32421.4 32424.4 32729.2 36097.3 36544.0 28107.9 28880.0 29731.4 30042.8 31575.5 22883.2 23625.9 24429.6 24526.0 24815.6 01:15:48 INFO - PROCESS | 27950 | 01:15:48 INFO - PROCESS | 27950 | [#2] jquery.html Cycles:180 Average:23257.13 Median:204799.50 stddev:66705.87 (32.6%) stddev-sans-first:66870.86 01:15:48 INFO - PROCESS | 27950 | Values: 364.9 366.4 368.3 368.6 369.4 13503.3 13604.6 15516.4 17010.7 18234.7 15138.8 15613.2 15620.6 15660.1 16781.0 5360.8 5550.3 5579.7 5582.7 5586.1 4068.9 4205.2 5507.3 5560.7 5854.3 5936.7 6136.4 6157.3 6166.0 6168.6 6180.4 6219.2 6239.2 6241.0 6249.4 5299.5 5467.5 5486.3 5491.5 5495.4 19528.5 19789.0 20310.9 20851.5 20879.7 1876.5 1992.2 2026.4 2137.8 2563.9 12900.2 13070.2 13079.7 13130.3 13217.8 1734.1 1740.0 1817.6 1822.6 1866.0 55149.0 55539.0 57816.4 57866.0 57950.4 9750.5 9958.2 10093.8 10097.4 10190.5 13202.6 13235.3 13313.2 13319.9 13330.4 7221.1 7237.4 7266.5 7268.7 7361.2 6782.2 6838.6 6843.8 6890.0 6897.7 5983.9 6022.8 6082.4 6125.3 6149.4 1676.9 1731.5 1739.7 1803.9 1806.7 894.7 923.5 994.3 1040.4 1045.2 15038.0 16331.6 16332.3 17504.7 17605.8 981.5 1000.1 1006.9 1023.5 1040.2 9140.0 10011.3 10036.5 10263.4 10370.6 334593.0 371376.0 383779.0 386204.0 533663.0 56055.4 63185.4 63787.4 64225.0 73893.0 1092.1 1115.6 1135.5 1139.1 1143.9 12066.5 14102.2 14500.6 14670.9 15008.5 29674.4 29859.6 30251.0 30317.4 30733.7 35609.5 38223.0 39569.6 39573.6 39824.8 7390.5 7582.9 7612.0 7703.0 7753.4 10267.9 10689.0 11171.5 11322.1 11474.8 7016.1 7055.7 7171.5 7308.0 7337.7 7538.7 7718.3 7749.0 7837.6 7847.3 7204.0 7254.3 7476.9 7891.8 8018.6 10045.9 10278.6 10303.9 10508.6 10527.8 7488.7 7652.6 7951.3 7959.2 8029.4 01:15:48 INFO - PROCESS | 27950 | 01:15:48 INFO - PROCESS | 27950 | [#3] mootools.html Cycles:180 Average:5474.39 Median:6320.10 stddev:2861.69 (45.3%) stddev-sans-first:2852.45 01:15:48 INFO - PROCESS | 27950 | Values: 1292.2 1444.8 1447.3 1583.1 1757.2 7101.5 7284.7 7731.5 7944.2 7966.1 7857.0 7880.6 7956.9 7957.0 7987.8 2004.7 2059.4 2297.5 2307.9 2317.0 2258.6 2328.1 2329.6 2329.7 2330.1 2161.8 2178.8 2256.2 2256.5 2256.7 2274.1 2292.3 2297.5 2298.9 2303.5 2262.5 2280.8 2283.7 2291.3 2292.7 7991.5 8133.7 8155.9 8158.9 8162.1 4625.8 4729.3 4750.1 4755.8 4758.0 2964.6 3087.4 3140.9 3141.7 3143.9 955.5 955.9 985.2 989.6 1002.7 10922.5 11014.8 11018.0 11035.3 11038.9 4071.1 4200.9 4236.5 4252.9 4258.4 8983.6 9160.0 9164.6 9168.4 9179.4 4828.9 4841.0 4841.8 4845.0 4846.9 4379.6 4440.6 4442.0 4458.1 4459.8 3327.7 3355.4 3491.1 3524.5 3594.0 1072.4 1078.5 1084.6 1091.0 1099.8 1218.7 1228.2 1251.0 1251.6 1262.5 7207.2 7303.1 7308.3 7377.0 7377.9 1096.1 1102.0 1106.9 1107.7 1135.0 5550.7 5645.7 5657.0 5658.3 5660.5 9245.9 9257.2 9446.1 9527.7 9560.7 9359.9 9427.8 9475.4 9492.3 9569.8 7304.0 7341.2 7445.7 7505.8 7506.4 6743.3 6786.7 6788.3 6793.7 6794.6 8248.7 8498.4 8525.3 8659.1 8663.0 8465.8 8505.1 8651.2 8677.7 8689.3 6893.7 7205.6 7241.4 7260.3 7260.4 6766.6 6909.0 7278.7 7407.8 7448.8 6896.2 7039.4 7054.3 7237.3 7258.6 6864.8 6908.6 6924.9 7024.8 7123.6 6899.3 7154.9 7162.9 7165.9 7168.7 6310.3 6311.7 6345.5 6357.8 6361.5 6281.5 6291.2 6309.8 6328.6 6335.9 01:15:48 INFO - PROCESS | 27950 | 01:15:48 INFO - PROCESS | 27950 | [#4] prototype.html Cycles:180 Average:5227.08 Median:5886.47 stddev:1570.22 (26.7%) stddev-sans-first:1530.92 01:15:48 INFO - PROCESS | 27950 | Values: 325.5 338.9 343.4 347.6 356.5 5731.2 5845.6 5869.9 5885.5 5904.6 5662.0 5784.0 5797.7 5799.2 5804.6 4545.5 4562.2 4564.3 4568.5 4569.3 4346.4 4430.9 4446.7 4519.2 4549.5 4472.1 4497.2 4504.0 4532.5 4541.6 4498.6 4519.8 4528.0 4529.3 4533.5 3981.8 3983.9 3987.0 3993.7 4007.6 5465.2 5590.0 5604.6 5615.2 5618.4 5176.2 5183.9 5185.8 5192.4 5194.6 5926.8 6187.1 6242.3 6257.7 6268.4 4232.8 4274.6 4326.4 4331.3 4362.1 6436.0 6492.6 6504.6 6505.7 6520.3 4477.4 4484.2 4485.8 4486.8 4488.5 4455.4 4519.8 4538.6 4539.3 4543.6 5172.3 5192.9 5202.9 5203.6 5210.9 6253.2 6264.2 6266.2 6268.5 6271.8 1582.7 1603.6 1604.0 1604.6 1606.7 1051.2 1064.7 1066.8 1087.0 1093.7 5866.9 5890.9 5891.5 5894.1 5898.8 6426.7 6428.2 6429.6 6431.8 6503.1 5883.3 5887.4 5889.3 5890.9 5891.3 3369.1 3496.3 3499.0 3500.1 3501.0 6747.3 6757.2 6763.6 6768.2 6768.3 6604.2 6604.5 6606.7 6610.7 6612.0 6563.4 6724.9 6731.1 6735.2 6740.6 6188.3 6309.8 6433.5 6460.7 6506.5 6246.4 6376.7 6390.5 6407.0 6435.5 6736.8 6742.7 6746.1 6747.3 6749.2 4334.6 4407.8 4435.6 4436.6 4441.1 6422.7 6456.4 6462.0 6464.6 6466.2 6293.9 6294.2 6295.9 6307.0 6307.2 6149.1 6200.3 6263.2 6279.2 6286.7 6172.5 6173.5 6179.6 6180.7 6185.0 6308.0 6311.9 6318.7 6319.7 6321.1 6066.9 6138.2 6162.4 6176.0 6176.0 01:15:48 INFO - PROCESS | 27950 | 01:15:48 INFO - PROCESS | 27950 | [#5] yui.html Cycles:180 Average:13526.09 Median:45439.43 stddev:15563.45 (34.3%) stddev-sans-first:15577.59 01:15:48 INFO - PROCESS | 27950 | Values: 762.2 776.7 842.1 844.3 877.0 12690.9 12916.6 12950.6 12955.6 12959.2 11655.8 11703.7 11722.8 11744.0 11763.2 650.4 663.4 785.0 804.7 807.5 806.2 810.0 811.1 812.3 813.5 694.1 845.8 845.8 846.0 846.2 693.8 695.5 829.1 840.9 841.2 614.1 619.0 619.5 620.8 621.3 12444.9 12456.7 12522.1 12523.3 12523.6 12270.6 12493.0 12595.9 12900.2 13040.7 9415.2 9491.4 9512.8 9541.3 10013.5 3563.4 3576.8 3583.0 3599.1 3717.5 46544.5 46883.8 46935.5 47149.5 48817.3 9709.3 10165.2 10167.6 10237.5 10334.7 18144.0 18158.1 18171.6 18197.9 18226.5 7018.4 7077.4 7108.4 7127.7 7141.1 4112.9 4211.2 4228.2 4244.9 4289.8 2946.5 2954.5 2975.6 2976.1 2986.3 527.7 547.1 550.6 551.4 565.1 533.1 605.4 617.7 670.1 675.0 7511.2 7531.8 7597.3 7601.5 7733.7 501.7 632.8 677.9 680.7 697.6 3752.0 3781.4 3785.7 3911.1 3918.9 55115.2 55208.0 55224.7 55286.2 55341.7 45144.3 45734.5 50127.5 50571.7 50654.0 43448.8 43890.8 44529.1 44917.8 44937.6 8525.4 8624.7 8636.1 8760.9 8776.8 34321.5 34962.5 35597.3 35669.5 35861.8 44310.6 44523.1 46116.0 47349.3 48905.0 10889.6 11176.2 11228.2 11429.4 11540.2 12513.7 12595.4 12637.2 12734.5 12893.7 11185.4 11536.5 11760.9 12027.9 12035.0 11138.3 11163.7 11409.8 11727.5 12516.6 10870.7 11219.7 11316.2 11620.2 11685.5 9803.4 9904.7 10084.7 10198.1 10322.9 8996.6 9442.3 9444.2 9511.0 9876.9 01:15:48 INFO - PROCESS | 27950 | -------- Summary: end -------- 01:15:48 INFO - PROCESS | 27950 | 01:15:49 INFO - TEST-INFO | 27950: exit 0 01:15:49 INFO - TEST-OK | dromaeo_css | took 1112760ms 01:15:49 INFO - TEST-START | kraken 01:15:49 INFO - operating with platform_type : linux_ 01:15:49 INFO - Initialising browser for kraken test... 01:15:49 INFO - TEST-INFO | started process 28148 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplsy5GI/profile http://localhost:42169/getInfo.html) 01:15:52 INFO - PROCESS | 28148 | __metrics Screen width/height:1600/1200 01:15:52 INFO - PROCESS | 28148 | colorDepth:24 01:15:52 INFO - PROCESS | 28148 | Browser inner width/height: 1024/697 01:15:52 INFO - PROCESS | 28148 | __metrics 01:15:52 INFO - PROCESS | 28148 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:15:52 INFO - PROCESS | 28148 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:15:53 INFO - TEST-INFO | 28148: exit 0 01:15:53 INFO - Browser initialized. 01:15:53 INFO - Running cycle 1/1 for kraken test... 01:15:54 INFO - TEST-INFO | started process 28230 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplsy5GI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:16:05 INFO - PROCESS | 28230 | RSS: Main: 148676608 01:16:05 INFO - PROCESS | 28230 | 01:16:08 INFO - PROCESS | 28230 | Cycle 1(1): loaded http://localhost:42169/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42169/tests/kraken/driver.html?testName=audio-beat-detection) 01:16:08 INFO - PROCESS | 28230 | RSS: Main: 186384384 01:16:08 INFO - PROCESS | 28230 | 01:16:11 INFO - PROCESS | 28230 | Cycle 1(1): loaded http://localhost:42169/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42169/tests/kraken/driver.html?testName=audio-dft) 01:16:12 INFO - PROCESS | 28230 | RSS: Main: 177049600 01:16:12 INFO - PROCESS | 28230 | 01:16:15 INFO - PROCESS | 28230 | Cycle 1(1): loaded http://localhost:42169/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42169/tests/kraken/driver.html?testName=audio-fft) 01:16:15 INFO - PROCESS | 28230 | RSS: Main: 162992128 01:16:15 INFO - PROCESS | 28230 | 01:16:17 INFO - PROCESS | 28230 | Cycle 1(1): loaded http://localhost:42169/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42169/tests/kraken/driver.html?testName=audio-oscillator) 01:16:18 INFO - PROCESS | 28230 | RSS: Main: 166440960 01:16:18 INFO - PROCESS | 28230 | 01:16:20 INFO - PROCESS | 28230 | Cycle 1(1): loaded http://localhost:42169/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42169/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:16:21 INFO - PROCESS | 28230 | RSS: Main: 166146048 01:16:21 INFO - PROCESS | 28230 | 01:16:23 INFO - PROCESS | 28230 | Cycle 1(1): loaded http://localhost:42169/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42169/tests/kraken/driver.html?testName=imaging-darkroom) 01:16:24 INFO - PROCESS | 28230 | RSS: Main: 168804352 01:16:24 INFO - PROCESS | 28230 | 01:16:27 INFO - PROCESS | 28230 | Cycle 1(1): loaded http://localhost:42169/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42169/tests/kraken/driver.html?testName=imaging-desaturate) 01:16:28 INFO - PROCESS | 28230 | RSS: Main: 170229760 01:16:28 INFO - PROCESS | 28230 | 01:16:31 INFO - PROCESS | 28230 | Cycle 1(1): loaded http://localhost:42169/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42169/tests/kraken/driver.html?testName=json-parse-financial) 01:16:31 INFO - PROCESS | 28230 | RSS: Main: 167940096 01:16:31 INFO - PROCESS | 28230 | 01:16:33 INFO - PROCESS | 28230 | Cycle 1(1): loaded http://localhost:42169/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42169/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:16:33 INFO - PROCESS | 28230 | RSS: Main: 180404224 01:16:33 INFO - PROCESS | 28230 | 01:16:35 INFO - PROCESS | 28230 | Cycle 1(1): loaded http://localhost:42169/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42169/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:16:36 INFO - PROCESS | 28230 | RSS: Main: 180895744 01:16:36 INFO - PROCESS | 28230 | 01:16:38 INFO - PROCESS | 28230 | Cycle 1(1): loaded http://localhost:42169/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42169/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:16:39 INFO - PROCESS | 28230 | RSS: Main: 186933248 01:16:39 INFO - PROCESS | 28230 | 01:16:41 INFO - PROCESS | 28230 | Cycle 1(1): loaded http://localhost:42169/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42169/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:16:42 INFO - PROCESS | 28230 | RSS: Main: 195932160 01:16:42 INFO - PROCESS | 28230 | 01:16:44 INFO - PROCESS | 28230 | Cycle 1(1): loaded http://localhost:42169/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42169/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:16:45 INFO - PROCESS | 28230 | RSS: Main: 194686976 01:16:45 INFO - PROCESS | 28230 | 01:16:46 INFO - PROCESS | 28230 | Cycle 1(1): loaded http://localhost:42169/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42169/tests/kraken/driver.html?testName=ai-astar) 01:16:47 INFO - PROCESS | 28230 | RSS: Main: 255897600 01:16:47 INFO - PROCESS | 28230 | 01:16:47 INFO - PROCESS | 28230 | __start_tp_report 01:16:47 INFO - PROCESS | 28230 | _x_x_mozilla_page_load 01:16:47 INFO - PROCESS | 28230 | _x_x_mozilla_page_load_details 01:16:47 INFO - PROCESS | 28230 | |i|pagename|runs| 01:16:47 INFO - PROCESS | 28230 | |0;ai-astar;111;112;104;109;110;110;111;111;105;109 01:16:47 INFO - PROCESS | 28230 | |1;audio-beat-detection;163;126;155;179;126;149;155;127;171;128 01:16:47 INFO - PROCESS | 28230 | |2;audio-dft;162;160;161;161;161;161;159;162;163;160 01:16:47 INFO - PROCESS | 28230 | |3;audio-fft;73;75;91;94;73;72;73;119;97;75 01:16:47 INFO - PROCESS | 28230 | |4;audio-oscillator;98;97;150;96;96;95;138;94;96;140 01:16:47 INFO - PROCESS | 28230 | |5;imaging-gaussian-blur;119;114;115;115;115;115;115;114;114;114 01:16:47 INFO - PROCESS | 28230 | |6;imaging-darkroom;146;146;146;146;146;145;147;146;145;145 01:16:47 INFO - PROCESS | 28230 | |7;imaging-desaturate;95;96;97;96;95;96;96;95;97;95 01:16:47 INFO - PROCESS | 28230 | |8;json-parse-financial;57;56;56;57;55;56;57;56;57;53 01:16:47 INFO - PROCESS | 28230 | |9;json-stringify-tinderbox;67;67;67;66;66;67;66;66;67;67 01:16:47 INFO - PROCESS | 28230 | |10;stanford-crypto-aes;82;83;83;82;82;83;90;89;83;83 01:16:47 INFO - PROCESS | 28230 | |11;stanford-crypto-ccm;117;117;114;114;114;115;128;126;117;123 01:16:47 INFO - PROCESS | 28230 | |12;stanford-crypto-pbkdf2;144;131;139;142;142;131;140;143;153;140 01:16:47 INFO - PROCESS | 28230 | |13;stanford-crypto-sha256-iterative;69;68;67;66;67;67;68;68;66;64 01:16:47 INFO - PROCESS | 28230 | __end_tp_report 01:16:47 INFO - PROCESS | 28230 | __start_cc_report 01:16:47 INFO - PROCESS | 28230 | _x_x_mozilla_cycle_collect,940 01:16:47 INFO - PROCESS | 28230 | __end_cc_report 01:16:47 INFO - PROCESS | 28230 | __startTimestamp1453886207062__endTimestamp 01:16:47 INFO - PROCESS | 28230 | 01:16:47 INFO - PROCESS | 28230 | ------- Summary: start ------- 01:16:47 INFO - PROCESS | 28230 | Number of tests: 14 01:16:47 INFO - PROCESS | 28230 | 01:16:47 INFO - PROCESS | 28230 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.50 stddev:2.66 (2.4%) stddev-sans-first:2.74 01:16:47 INFO - PROCESS | 28230 | Values: 111.0 112.0 104.0 109.0 110.0 110.0 111.0 111.0 105.0 109.0 01:16:47 INFO - PROCESS | 28230 | 01:16:47 INFO - PROCESS | 28230 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:155.00 stddev:20.06 (12.9%) stddev-sans-first:20.52 01:16:47 INFO - PROCESS | 28230 | Values: 163.0 126.0 155.0 179.0 126.0 149.0 155.0 127.0 171.0 128.0 01:16:47 INFO - PROCESS | 28230 | 01:16:47 INFO - PROCESS | 28230 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.15 (0.7%) stddev-sans-first:1.17 01:16:47 INFO - PROCESS | 28230 | Values: 162.0 160.0 161.0 161.0 161.0 161.0 159.0 162.0 163.0 160.0 01:16:47 INFO - PROCESS | 28230 | 01:16:47 INFO - PROCESS | 28230 | [#3] audio-fft Cycles:10 Average:84.20 Median:75.00 stddev:15.68 (20.9%) stddev-sans-first:16.09 01:16:47 INFO - PROCESS | 28230 | Values: 73.0 75.0 91.0 94.0 73.0 72.0 73.0 119.0 97.0 75.0 01:16:47 INFO - PROCESS | 28230 | 01:16:47 INFO - PROCESS | 28230 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:96.00 stddev:22.77 (23.7%) stddev-sans-first:23.73 01:16:47 INFO - PROCESS | 28230 | Values: 98.0 97.0 150.0 96.0 96.0 95.0 138.0 94.0 96.0 140.0 01:16:47 INFO - PROCESS | 28230 | 01:16:47 INFO - PROCESS | 28230 | [#5] imaging-gaussian-blur Cycles:10 Average:115.00 Median:115.00 stddev:1.49 (1.3%) stddev-sans-first:0.53 01:16:47 INFO - PROCESS | 28230 | Values: 119.0 114.0 115.0 115.0 115.0 115.0 115.0 114.0 114.0 114.0 01:16:47 INFO - PROCESS | 28230 | 01:16:47 INFO - PROCESS | 28230 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 01:16:47 INFO - PROCESS | 28230 | Values: 146.0 146.0 146.0 146.0 146.0 145.0 147.0 146.0 145.0 145.0 01:16:47 INFO - PROCESS | 28230 | 01:16:47 INFO - PROCESS | 28230 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 01:16:47 INFO - PROCESS | 28230 | Values: 95.0 96.0 97.0 96.0 95.0 96.0 96.0 95.0 97.0 95.0 01:16:47 INFO - PROCESS | 28230 | 01:16:47 INFO - PROCESS | 28230 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.50 stddev:1.25 (2.2%) stddev-sans-first:1.27 01:16:47 INFO - PROCESS | 28230 | Values: 57.0 56.0 56.0 57.0 55.0 56.0 57.0 56.0 57.0 53.0 01:16:47 INFO - PROCESS | 28230 | 01:16:47 INFO - PROCESS | 28230 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 01:16:47 INFO - PROCESS | 28230 | Values: 67.0 67.0 67.0 66.0 66.0 67.0 66.0 66.0 67.0 67.0 01:16:47 INFO - PROCESS | 28230 | 01:16:47 INFO - PROCESS | 28230 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:83.00 stddev:2.94 (3.5%) stddev-sans-first:3.03 01:16:47 INFO - PROCESS | 28230 | Values: 82.0 83.0 83.0 82.0 82.0 83.0 90.0 89.0 83.0 83.0 01:16:47 INFO - PROCESS | 28230 | 01:16:47 INFO - PROCESS | 28230 | [#11] stanford-crypto-ccm Cycles:10 Average:118.50 Median:117.00 stddev:5.23 (4.5%) stddev-sans-first:5.52 01:16:47 INFO - PROCESS | 28230 | Values: 117.0 117.0 114.0 114.0 114.0 115.0 128.0 126.0 117.0 123.0 01:16:47 INFO - PROCESS | 28230 | 01:16:47 INFO - PROCESS | 28230 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.50 Median:142.00 stddev:6.35 (4.5%) stddev-sans-first:6.60 01:16:47 INFO - PROCESS | 28230 | Values: 144.0 131.0 139.0 142.0 142.0 131.0 140.0 143.0 153.0 140.0 01:16:47 INFO - PROCESS | 28230 | 01:16:47 INFO - PROCESS | 28230 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.50 stddev:1.41 (2.1%) stddev-sans-first:1.30 01:16:47 INFO - PROCESS | 28230 | Values: 69.0 68.0 67.0 66.0 67.0 67.0 68.0 68.0 66.0 64.0 01:16:47 INFO - PROCESS | 28230 | -------- Summary: end -------- 01:16:47 INFO - PROCESS | 28230 | 01:16:47 INFO - TEST-INFO | 28230: exit 0 01:16:47 INFO - TEST-OK | kraken | took 58848ms 01:16:47 INFO - TEST-START | v8_7 01:16:47 INFO - operating with platform_type : linux_ 01:16:47 INFO - Initialising browser for v8_7 test... 01:16:47 INFO - TEST-INFO | started process 28480 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9gp4L1/profile http://localhost:42169/getInfo.html) 01:16:51 INFO - PROCESS | 28480 | __metrics Screen width/height:1600/1200 01:16:51 INFO - PROCESS | 28480 | colorDepth:24 01:16:51 INFO - PROCESS | 28480 | Browser inner width/height: 1024/697 01:16:51 INFO - PROCESS | 28480 | __metrics 01:16:51 INFO - PROCESS | 28480 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:16:51 INFO - PROCESS | 28480 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:16:52 INFO - TEST-INFO | 28480: exit 0 01:16:52 INFO - Browser initialized. 01:16:52 INFO - Running cycle 1/1 for v8_7 test... 01:16:53 INFO - TEST-INFO | started process 28565 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9gp4L1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:17:04 INFO - PROCESS | 28565 | RSS: Main: 148189184 01:17:04 INFO - PROCESS | 28565 | 01:17:27 INFO - PROCESS | 28565 | Cycle 1(1): loaded http://localhost:42169/tests/v8_7/run.html (next: http://localhost:42169/tests/v8_7/run.html) 01:17:27 INFO - PROCESS | 28565 | RSS: Main: 567365632 01:17:27 INFO - PROCESS | 28565 | 01:17:27 INFO - PROCESS | 28565 | __start_tp_report 01:17:27 INFO - PROCESS | 28565 | _x_x_mozilla_page_load 01:17:27 INFO - PROCESS | 28565 | _x_x_mozilla_page_load_details 01:17:27 INFO - PROCESS | 28565 | |i|pagename|runs| 01:17:27 INFO - PROCESS | 28565 | |0;Richards;167.3080140538732 01:17:27 INFO - PROCESS | 28565 | |1;DeltaBlue;189.60940462646948 01:17:27 INFO - PROCESS | 28565 | |2;Encrypt;272.92576419213975 01:17:27 INFO - PROCESS | 28565 | |3;Decrypt;5301.587301587301 01:17:27 INFO - PROCESS | 28565 | |4;RayTrace;2057.4948665297743 01:17:27 INFO - PROCESS | 28565 | |5;Earley;783.0853563038371 01:17:27 INFO - PROCESS | 28565 | |6;Boyer;12317.073170731708 01:17:27 INFO - PROCESS | 28565 | |7;RegExp;42562.5 01:17:27 INFO - PROCESS | 28565 | |8;Splay;573.3788395904437 01:17:27 INFO - PROCESS | 28565 | |9;NavierStokes;4822.115384615385 01:17:27 INFO - PROCESS | 28565 | __end_tp_report 01:17:27 INFO - PROCESS | 28565 | __startTimestamp1453886247531__endTimestamp 01:17:27 INFO - PROCESS | 28565 | 01:17:27 INFO - PROCESS | 28565 | ------- Summary: start ------- 01:17:27 INFO - PROCESS | 28565 | Number of tests: 10 01:17:27 INFO - PROCESS | 28565 | 01:17:27 INFO - PROCESS | 28565 | [#0] Richards Cycles:1 Average:167.31 Median:167.31 stddev:0.00 (0.0%) 01:17:27 INFO - PROCESS | 28565 | Values: 167.3 01:17:27 INFO - PROCESS | 28565 | 01:17:27 INFO - PROCESS | 28565 | [#1] DeltaBlue Cycles:1 Average:189.61 Median:189.61 stddev:0.00 (0.0%) 01:17:27 INFO - PROCESS | 28565 | Values: 189.6 01:17:27 INFO - PROCESS | 28565 | 01:17:27 INFO - PROCESS | 28565 | [#2] Encrypt Cycles:1 Average:272.93 Median:272.93 stddev:0.00 (0.0%) 01:17:27 INFO - PROCESS | 28565 | Values: 272.9 01:17:27 INFO - PROCESS | 28565 | 01:17:27 INFO - PROCESS | 28565 | [#3] Decrypt Cycles:1 Average:5301.59 Median:5301.59 stddev:0.00 (0.0%) 01:17:27 INFO - PROCESS | 28565 | Values: 5301.6 01:17:27 INFO - PROCESS | 28565 | 01:17:27 INFO - PROCESS | 28565 | [#4] RayTrace Cycles:1 Average:2057.49 Median:2057.49 stddev:0.00 (0.0%) 01:17:27 INFO - PROCESS | 28565 | Values: 2057.5 01:17:27 INFO - PROCESS | 28565 | 01:17:27 INFO - PROCESS | 28565 | [#5] Earley Cycles:1 Average:783.09 Median:783.09 stddev:0.00 (0.0%) 01:17:27 INFO - PROCESS | 28565 | Values: 783.1 01:17:27 INFO - PROCESS | 28565 | 01:17:27 INFO - PROCESS | 28565 | [#6] Boyer Cycles:1 Average:12317.07 Median:12317.07 stddev:0.00 (0.0%) 01:17:27 INFO - PROCESS | 28565 | Values: 12317.1 01:17:27 INFO - PROCESS | 28565 | 01:17:27 INFO - PROCESS | 28565 | [#7] RegExp Cycles:1 Average:42562.50 Median:42562.50 stddev:0.00 (0.0%) 01:17:27 INFO - PROCESS | 28565 | Values: 42562.5 01:17:27 INFO - PROCESS | 28565 | 01:17:27 INFO - PROCESS | 28565 | [#8] Splay Cycles:1 Average:573.38 Median:573.38 stddev:0.00 (0.0%) 01:17:27 INFO - PROCESS | 28565 | Values: 573.4 01:17:27 INFO - PROCESS | 28565 | 01:17:27 INFO - PROCESS | 28565 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 01:17:27 INFO - PROCESS | 28565 | Values: 4822.1 01:17:27 INFO - PROCESS | 28565 | -------- Summary: end -------- 01:17:27 INFO - PROCESS | 28565 | 01:17:28 INFO - TEST-INFO | 28565: exit 0 01:17:28 INFO - TEST-OK | v8_7 | took 40460ms 01:17:28 INFO - SUITE-END | took 1212s 01:17:28 INFO - Completed test suite (00:20:12) 01:17:28 INFO - Working with test: dromaeo_css 01:17:28 INFO - Generating results file: dromaeo_css 01:17:28 INFO - Working with test: kraken 01:17:28 INFO - Generating results file: kraken 01:17:28 INFO - javascript benchmark 01:17:28 INFO - Working with test: v8_7 01:17:28 INFO - Generating results file: v8_7 01:17:28 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:17:28 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 01:17:28 INFO - process_Request line: dromaeo_css 6762.14 graph.html#tests=[[72,63,35]] 01:17:28 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:17:28 INFO - process_Request line: kraken 1501.50 graph.html#tests=[[232,63,35]] 01:17:28 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:17:28 INFO - process_Request line: v8_7 18925.57 graph.html#tests=[[230,63,35]] 01:17:28 INFO - RETURN: dromaeo_css: 6762.14 01:17:28 INFO - RETURN: kraken: 1501.50 01:17:28 INFO - RETURN: v8_7: 18925.57 01:17:28 INFO - javascript benchmark 01:17:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3103.844807759612, 3112.8132312061266, 3157.6210854697424, 3165.2719874428867, 3180.363927214558, 4969.2049272116465, 5044.369453818273, 5076.847694569165, 5078.162103252964, 5089.923651145235, 4932.482089380608, 5104.6937183768905, 5169.638125331228, 5191.428942816287, 5196.454372290912, 4660.487346391894, 4681.929771053428, 4698.694584851991, 4814.229723244282, 4827.348307978431, 4749.596284315838, 4762.928556071662, 4784.856454306359, 4829.541193586621, 4869.464358920516, 4554.72671639701, 4641.466231383383, 4681.695689780154, 4792.424909010941, 4801.5438533339275, 4723.858284251478, 4726.456457507396, 4726.480087190406, 4734.147853386389, 4775.379200703921, 4708.176069187913, 4712.952870471286, 4716.221823399135, 4728.054389122155, 4741.383620129361, 4959.20652695567, 5002.6748261363255, 5068.062408454448, 5068.5691716204165, 5107.029664363796, 5530.0598898187, 5566.359868615121, 5566.582506312002, 5574.665520068768, 5581.2186293918885, 5498.395176530578, 5577.9163312550345, 5587.078132108198, 5589.916151257735, 5590.5527557795685, 5102.336696229503, 5159.458256883048, 5176.197689358156, 5177.223416487519, 5191.065608190562, 5622.550195984311, 5630.634008789498, 5651.632643878134, 5658.773649053992, 5675.744591493392, 5425.6202065855805, 5427.158790387496, 5471.23402723619, 5473.890522189534, 5474.0, 5425.9186112208345, 5456.563474921997, 5551.361593416728, 5603.187537806995, 5659.0, 5511.366192887869, 5524.0, 5526.530244929226, 5540.279763630702, 5540.9168862467095, 5459.426760190202, 5502.889942201214, 5522.5858060644805, 5553.389127196006, 5606.215129881738, 4280.700350975464, 4341.39220509129, 4348.978255108705, 4361.672874534423, 4375.387445757597, 3859.073822282688, 3864.9806750966627, 3870.767753934773, 3903.394973779069, 3909.159530700913, 5109.412417572027, 5136.486351364908, 5142.04872098663, 5149.871253218625, 5150.098732721834, 5452.754626041838, 5525.917111243334, 5555.749991250404, 5575.832725018256, 5605.747741351649, 5189.221616757441, 5189.4032186299055, 5195.766190521435, 5196.636235463481, 5197.7401129943355, 4784.6889952153, 4789.3294938708605, 4794.880127996758, 4799.256115302133, 4842.346283251786, 5636.60543761941, 5722.4277572242445, 5754.74103665336, 5775.711214439261, 5820.447057529528, 5408.729563521887, 5409.729513524387, 5424.2406063151975, 5426.945730542644, 5439.456054394529, 5582.0, 5596.244506991504, 5596.524295434933, 5598.972005140111, 5606.887862242814, 5403.162509810985, 5449.972750136224, 5461.781528738965, 5505.201745746925, 5531.0873705838085, 5468.398476167698, 5490.945090549043, 5510.476504732044, 5511.751971161227, 5514.61397702157, 5304.283921670525, 5369.1140961740875, 5371.301730774974, 5407.891842163056, 5453.563714902878, 5389.730513474232, 5419.0, 5423.647462914898, 5429.158480435539, 5468.863278417913, 5350.652207606493, 5373.328333958255, 5376.086065368819, 5378.677279363251, 5378.784848606012, 5431.212474191299, 5464.0, 5473.452654734495, 5476.6166368355425, 5512.972435137799, 5308.840734777963, 5322.042032434199, 5360.544353729821, 5361.946380536301, 5415.783368665209], "unit": "score", "name": "dojo.html", "value": 5107.6882388098375}, {"lowerIsBetter": false, "replicates": [535.1945322289955, 548.3255595617392, 558.1153871114284, 564.9180868774027, 565.2990292037873, 28016.299592510197, 28496.715032849665, 35717.2856542869, 35748.463773043426, 35934.0, 39513.20973580526, 40014.59985400145, 40042.79978600103, 40081.19837603254, 40151.799241003755, 8380.245777880005, 8495.0, 8574.657013719476, 8576.142385761435, 8584.442011269248, 8282.668693252293, 8416.242538171564, 8425.789355266106, 8428.704995325164, 8463.238308552229, 8666.263367613761, 8737.257333126692, 8740.562971851414, 8741.082186370435, 8749.16882896127, 8480.151984801532, 8500.532470714108, 8543.401961862672, 8554.315654747605, 8558.400911936167, 8538.957305213435, 8664.740057798275, 8677.088905664878, 8677.652893884237, 8685.478871267744, 38499.8075009626, 38847.8057609713, 38900.80549597234, 38935.610643893764, 39046.804765976274, 3210.325831575372, 3289.5723555937816, 3506.6493350664987, 3665.9266814663824, 3936.350502167139, 29118.27204319888, 29313.56029659557, 29412.0, 30528.84735576308, 30539.0, 3466.2201004773974, 3491.8428670709627, 3590.425531914881, 3611.0972256935765, 3685.5024571682748, 269611.0, 270276.0, 271260.0, 271759.0, 272542.0, 51355.74322128366, 52328.0, 57053.42946570481, 57668.423315766304, 59029.11456328158, 53013.204801928005, 53437.73281133569, 53524.0, 53676.0, 53735.0, 13457.192568445924, 13524.797128043087, 13534.390952407166, 13539.526116585872, 13545.45818167282, 10558.0, 10723.356598604109, 10750.94624526888, 10939.45302734876, 10999.34003959749, 18609.81390186108, 18704.81295187058, 18715.625687486176, 18766.624667506574, 18902.338418155297, 6689.919149318912, 7037.472189585802, 7043.084399028094, 7066.964665176642, 7082.220955694869, 848.8811566380712, 872.6727477196051, 926.0924294191595, 1033.943133127685, 1036.0623635609786, 28175.295617609314, 28294.85852570724, 28352.716472835422, 28576.0, 28749.712502874703, 947.8247422166145, 1031.63377001165, 1065.9200559958035, 1110.0287248657426, 1117.458032854065, 14643.56069317922, 14674.266286685623, 14740.557783266519, 14971.70056598862, 15014.24928753558, 318746.0, 321532.0, 321686.0, 321835.0, 322563.0, 50783.49216507788, 50950.23574646383, 51044.74477627588, 51066.23400648993, 51131.233031504555, 1307.6730817295677, 1323.1730168644597, 1334.6129622409587, 1335.826342575459, 1336.9866301336863, 27055.188344349703, 27240.318992025357, 28237.356629226968, 28239.0, 28276.43447131087, 46452.0, 46965.76517117529, 46981.0, 47007.76496117497, 47026.52973470221, 297316.0, 297574.0, 297705.0, 298878.0, 300209.0, 27349.316267092687, 30889.8455507721, 31404.528932066496, 31587.84206078955, 31809.840950795096, 37957.430638540995, 40510.0, 40594.1881162381, 41465.37801932913, 41483.37774933439, 34154.31691366109, 34565.82717086399, 34573.0, 34792.304153917285, 35638.64361356457, 28079.95911745259, 32970.67029329676, 33725.49411758777, 34981.30037399289, 35272.64727352796, 32421.35157296794, 32424.351512969137, 32729.18177045593, 36097.27805443929, 36544.0, 28107.859460702566, 28880.0, 29731.405371892008, 30042.849785750932, 31575.526367104972, 22883.199088031837, 23625.881870590536, 24429.633555496326, 24526.0, 24815.62776558317], "unit": "score", "name": "ext.html", "value": 17740.375744017714}, {"lowerIsBetter": false, "replicates": [364.94890715299846, 366.38081642024974, 368.26898606266565, 368.64609974424553, 369.3628490853277, 13503.25732084735, 13604.591862244148, 15516.379344826208, 17010.659786804274, 18234.726479102825, 15138.772918406232, 15613.21933903306, 15620.609484762886, 15660.060396376226, 16781.0, 5360.812371566996, 5550.333959924815, 5579.721013949286, 5582.692951887665, 5586.078297080977, 4068.8575899843513, 4205.243056249874, 5507.284053073095, 5560.6941618210985, 5854.268216472941, 5936.673482958436, 6136.386361363872, 6157.261128664567, 6165.982612868894, 6168.568200225986, 6180.412860778241, 6219.1915051043525, 6239.220097487814, 6241.0, 6249.437550620421, 5299.49654782795, 5467.480589344046, 5486.286782718261, 5491.450854914477, 5495.395506494322, 19528.51178720529, 19789.0, 20310.89844550768, 20851.478713032146, 20879.686804697943, 1876.5121068522146, 1992.1931617694856, 2026.422469596158, 2137.7969092936146, 2563.8718963655933, 12900.225986440844, 13070.215787052808, 13079.738405231938, 13130.343482825916, 13217.801732974012, 1734.141599908041, 1740.02047082906, 1817.6092140189924, 1822.571695651521, 1865.9533511662182, 55149.0, 55538.99999999959, 57816.421835781526, 57866.0, 57950.42049579535, 9750.463724495221, 9958.203343732484, 10093.848592271122, 10097.444640544694, 10190.541425635864, 13202.603921882359, 13235.338233088307, 13313.20120792736, 13319.866801331862, 13330.400131994083, 7221.061262035902, 7237.421006319481, 7266.527675701062, 7268.709251629875, 7361.190269070398, 6782.1861376635115, 6838.589684618839, 6843.760468383683, 6889.965550172217, 6897.689603967733, 5983.910241346383, 6022.789202377896, 6082.361352058058, 6125.295591007002, 6149.354317796657, 1676.8742344324226, 1731.480555833245, 1739.678159540489, 1803.9098045097955, 1806.719958406449, 894.6868595991481, 923.4643906534194, 994.2692121290845, 1040.370575801629, 1045.163868904873, 15038.0, 16331.591710207102, 16332.346706131859, 17504.737428938577, 17605.823941760675, 981.5424095218594, 1000.1049061090283, 1006.9496525173712, 1023.4729114506035, 1040.152275895143, 9140.0, 10011.349262297927, 10036.498175091216, 10263.435511046964, 10370.637027704144, 334593.0, 371376.0, 383779.0, 386204.0, 533663.0, 56055.43944560502, 63185.36814631887, 63787.36212637907, 64225.0, 73893.0, 1092.0662833277593, 1115.5649296774266, 1135.500379832871, 1139.1058019454854, 1143.89704926557, 12066.457009434422, 14102.224377659328, 14500.564983050524, 14670.926645367132, 15008.47470338533, 29674.406511870075, 29859.552106718853, 30251.0, 30317.393652127274, 30733.692663073976, 35609.49374022693, 38223.0, 39569.60430395774, 39573.60426395699, 39824.800875996596, 7390.482666213314, 7582.924170758221, 7611.961940190264, 7703.0, 7753.37972962173, 10267.94866025665, 10689.0, 11171.497282622138, 11322.094232461548, 11474.827877581676, 7016.122984626922, 7055.717771289296, 7171.533850299714, 7308.0, 7337.669804858688, 7538.736144234926, 7718.266764657348, 7748.957735227166, 7837.568933708472, 7847.254510821463, 7204.0, 7254.310840470147, 7476.850462990818, 7891.84216315659, 8018.599070046591, 10045.949770251102, 10278.588856445958, 10303.896961030294, 10508.579656813949, 10527.789164275588, 7488.700451981859, 7652.61736913141, 7951.284384405431, 7959.164287749702, 8029.357651387992], "unit": "score", "name": "jquery.html", "value": 8081.613940443368}, {"lowerIsBetter": false, "replicates": [1292.2311224821228, 1444.8338441079275, 1447.2980604406864, 1583.1292788966066, 1757.2180379731017, 7101.502894797366, 7284.745033923807, 7731.458797884144, 7944.165862584432, 7966.123726390092, 7856.96071519643, 7880.566568838712, 7956.920430795705, 7957.0, 7987.760367188979, 2004.7293615361957, 2059.4336557446672, 2297.4600968772324, 2307.938348359748, 2317.0268487235317, 2258.6499092640584, 2328.0687724910085, 2329.6272596384583, 2329.7320808107115, 2330.0563271874835, 2161.794629510194, 2178.814800741939, 2256.17649557911, 2256.5148493073984, 2256.717910261217, 2274.113095892595, 2292.255017119443, 2297.529006553661, 2298.9425264368356, 2303.4702018535745, 2262.5135595846973, 2280.8403411761183, 2283.680284760135, 2291.2667946257206, 2292.7019487466523, 7991.520508769434, 8133.674653013873, 8155.877661835078, 8158.918410815934, 8162.14297498766, 4625.7687115644085, 4729.290606409032, 4750.121227572876, 4755.762211889391, 4758.048390321949, 2964.584958105867, 3087.3825234952874, 3140.9214769630944, 3141.685831416863, 3143.8899638512544, 955.4506158958557, 955.9330846840654, 985.1527686189871, 989.5893204320271, 1002.7092143278513, 10922.508487118019, 11014.779704405866, 11018.0, 11035.282706624044, 11038.944805276002, 4071.1043570414463, 4200.915981680349, 4236.491621005499, 4252.87241382759, 4258.403823464718, 8983.55082245885, 9160.0, 9164.633414663473, 9168.44989300644, 9179.449233046038, 4828.855134345905, 4841.0, 4841.757912104381, 4845.0, 4846.854594362175, 4379.562043795659, 4440.62254708347, 4441.977790111094, 4458.130664520452, 4459.799309031101, 3327.6505966873615, 3355.379254837863, 3491.1446695559243, 3524.4713293006253, 3594.0475773919934, 1072.383379556758, 1078.4769386847372, 1084.5553323137476, 1090.9890901091046, 1099.8130317845985, 1218.7196944702769, 1228.1648479034343, 1250.9624711258678, 1251.5744646820124, 1262.4571434283162, 7207.207207207203, 7303.087114110736, 7308.269173082649, 7377.040984672066, 7377.88933166003, 1096.1231015187818, 1101.9614313499148, 1106.9003789658968, 1107.6510899066768, 1134.982975255372, 5550.69471179089, 5645.68948707825, 5656.971715141398, 5658.292713410824, 5660.490555849911, 9245.90754092464, 9257.166854983085, 9446.055394460636, 9527.714168574954, 9560.66537671192, 9359.906400935903, 9427.811443771223, 9475.384100033476, 9492.288078394147, 9569.760755981017, 7303.977443157962, 7341.155767086853, 7445.739399121005, 7505.812354691067, 7506.399488041053, 6743.325667433218, 6786.728530858711, 6788.321167883172, 6793.72825086991, 6794.626295553792, 8248.711295104642, 8498.405111642373, 8525.317974561896, 8659.13408659129, 8662.956685216534, 8465.83068338642, 8505.064442911398, 8651.178138076873, 8677.696280630147, 8689.348298877483, 6893.655317234018, 7205.639718014183, 7241.384482319062, 7260.346568808833, 7260.419166466776, 6766.560173588701, 6908.965455172692, 7278.6724597392185, 7407.777766667009, 7448.813779655552, 6896.241413444617, 7039.380942383178, 7054.259302773135, 7237.312455316736, 7258.600776957318, 6864.759733409307, 6908.620025898423, 6924.861502769816, 7024.789256322319, 7123.646507163622, 6899.310068993061, 7154.856902861809, 7162.89255661155, 7165.928340716735, 7168.713251469882, 6310.337414571404, 6311.652859092794, 6345.524085693683, 6357.809265722036, 6361.522885783677, 6281.528885333527, 6291.182146320949, 6309.810705678837, 6328.557001009885, 6335.90496142549], "unit": "score", "name": "mootools.html", "value": 4483.240085256548}, {"lowerIsBetter": false, "replicates": [325.5344856854698, 338.8542926541587, 343.359634282064, 347.5985237051206, 356.51691957397725, 5731.197632331467, 5845.5908086433965, 5869.911951320733, 5885.529157667382, 5904.6457212567275, 5662.0, 5783.971080144604, 5797.739101740422, 5799.159121927318, 5804.622699524528, 4545.499995000548, 4562.247229207185, 4564.292534657116, 4568.45178578571, 4569.268916973285, 4346.391505189276, 4430.867073987785, 4446.733196008234, 4519.186546421643, 4549.499555048942, 4472.060867217888, 4497.168023915569, 4503.977480112595, 4532.546745325458, 4541.636669066484, 4498.595126438636, 4519.84180553679, 4527.977360113211, 4529.2526733089, 4533.455985281755, 3981.7610943343493, 3983.9243404280683, 3987.003249187703, 3993.740406873573, 4007.5992400759983, 5465.180222966586, 5589.972050139764, 5604.607677462579, 5615.241942337773, 5618.381977982419, 5176.171812510018, 5183.922241166386, 5185.818496352647, 5192.402873669538, 5194.584433245332, 5926.792562260343, 6187.07193920911, 6242.313345531988, 6257.687115644199, 6268.435840774307, 4232.76719780412, 4274.593913578236, 4326.4159338489535, 4331.328644060176, 4362.062156636339, 6436.0, 6492.642904640243, 6504.577202481823, 6505.707243174022, 6520.250171230322, 4477.440319960005, 4484.215262329079, 4485.842995495142, 4486.820527178941, 4488.506264310923, 4455.420795296655, 4519.751413672214, 4538.591526762607, 4539.273716205457, 4543.636509079266, 5172.250023746611, 5192.92210616841, 5202.92195617066, 5203.635745497854, 5210.947890521046, 6253.187085678924, 6264.248290205204, 6266.154069200691, 6268.4671802897265, 6271.811845644638, 1582.6834633073431, 1603.559021269137, 1604.0375774535185, 1604.5587463447412, 1606.7429211326132, 1051.164324362134, 1064.685917654294, 1066.8133076711545, 1087.0162502934857, 1093.7265683579105, 5866.882662346815, 5890.882182356415, 5891.528677705774, 5894.086416605347, 5898.8230353089475, 6426.678666066678, 6428.19647544057, 6429.646369449725, 6431.807045788634, 6503.122078519434, 5883.294004719461, 5887.411258874164, 5889.322727886262, 5890.8821823563285, 5891.293044834647, 3369.107186595554, 3496.283261931298, 3499.0377646147513, 3500.054985153994, 3500.964990350115, 6747.257801641816, 6757.155355580552, 6763.560368576027, 6768.2216545097945, 6768.289329620417, 6604.174478190226, 6604.537682362285, 6606.735730570724, 6610.735570577219, 6611.966940165268, 6563.409293163638, 6724.899126513106, 6731.057651928734, 6735.191776986793, 6740.595564266159, 6188.257409110935, 6309.810705678837, 6433.5496515243485, 6460.709268082854, 6506.544541882023, 6246.437820596168, 6376.681165941777, 6390.48876089921, 6407.0, 6435.549511534335, 6736.797896063126, 6742.730290788313, 6746.123004009447, 6747.257801641717, 6749.156355455568, 4334.609885110355, 4407.757573333497, 4435.600795928382, 4436.645068394585, 4441.089576636847, 6422.678866056585, 6456.386643268882, 6462.0, 6464.5798023128345, 6466.191726034246, 6293.905591416041, 6294.244690637152, 6295.937040629535, 6307.0, 6307.180066591313, 6149.108379284889, 6200.255969283535, 6263.248410190807, 6279.152314437492, 6286.654234017173, 6172.506199504119, 6173.475254603409, 6179.567430279837, 6180.690965451619, 6185.0, 6307.96846015767, 6311.90532142009, 6318.652474113784, 6319.684015799284, 6321.146645203023, 6066.939330606638, 6138.1713468681155, 6162.445379915829, 6175.980963141032, 6176.0], "unit": "score", "name": "prototype.html", "value": 4721.7134854048945}, {"lowerIsBetter": false, "replicates": [762.1654288554031, 776.7397921696235, 842.1494290766326, 844.2823599940052, 876.9605367758451, 12690.936545317272, 12916.612501624943, 12950.611481655553, 12955.611331660042, 12959.222446653195, 11655.825162622546, 11703.707407314821, 11722.765544689122, 11744.0, 11763.176577639568, 650.4113777031794, 663.4128796015536, 785.022646804726, 804.6741069866684, 807.4711064252924, 806.173671986213, 810.027966440274, 811.111832543364, 812.305478815613, 813.4590497319275, 694.0942070597868, 845.750503601439, 845.8435189489933, 845.9915400846005, 846.196113691992, 693.7918624412681, 695.544418405945, 829.1294141151797, 840.9075001749802, 841.2008591837779, 614.1034090228272, 618.9535784816156, 619.4517851701277, 620.7920346683866, 621.2886245249209, 12444.937775311066, 12456.688582785413, 12522.060845436537, 12523.311217883012, 12523.624291271277, 12270.570530031495, 12493.0, 12595.874041259653, 12900.161489503153, 13040.739185216242, 9415.199708024826, 9491.356548597605, 9512.809743805085, 9541.33210675253, 10013.549390277454, 3563.4120370138894, 3576.8211589420685, 3582.982085089558, 3599.0642432967616, 3717.5353080864893, 46544.53455465436, 46883.76558117187, 46935.530644693456, 47149.52850471486, 48817.26774098356, 9709.271804614682, 10165.237607179492, 10167.644132455329, 10237.539310730886, 10334.689959301233, 18144.0, 18158.09209539518, 18171.63656726858, 18197.90901045513, 18226.544336391697, 7018.438524917994, 7077.433805295667, 7108.36024757764, 7127.679254433563, 7141.143062832493, 4112.856050038235, 4211.241976444208, 4228.23891699497, 4244.87265382039, 4289.849855255051, 2946.5138252188576, 2954.4829654810324, 2975.5685425613165, 2976.0922918509627, 2986.25343664084, 527.741406710709, 547.1409886478191, 550.6090675620275, 551.4072372199821, 565.1071307334402, 533.0857579251602, 605.3552966091099, 617.6973283091253, 670.0786418674322, 675.0, 7511.211322811027, 7531.756810737393, 7597.278258565428, 7601.543907365576, 7733.651985660659, 501.67641870993003, 632.8354627796806, 677.8847595908708, 680.6766785776716, 697.5570512724355, 3751.9812400938367, 3781.4327850822046, 3785.6782173515558, 3911.061345277113, 3918.8628398005935, 55115.17327240095, 55208.0, 55224.72387638116, 55286.17070743942, 55341.723291383285, 45144.3228351575, 45734.54265457369, 50127.49872501228, 50571.74714126406, 50654.0, 43448.78275608665, 43890.78054609706, 44529.109417811465, 44917.77541112273, 44937.62967777364, 8525.403221774664, 8624.698135565224, 8636.136386361313, 8760.91239087601, 8776.824463510566, 34321.48517772186, 34962.47556286708, 35597.288054238255, 35669.46495802513, 35861.820690897424, 44310.55689443064, 44523.10953780971, 46116.0, 47349.28976065293, 48905.0, 10889.624216492912, 11176.16178786578, 11228.157888158585, 11429.371384573928, 11540.249883757864, 12513.687157821127, 12595.370231488572, 12637.17858339205, 12734.490620375082, 12893.677658058248, 11185.384803835866, 11536.480858361561, 11760.88239117598, 12027.939860300643, 12035.0, 11138.33170009802, 11163.665090047312, 11409.828852567383, 11727.530898763955, 12516.561920332744, 10870.673879783619, 11219.71950701239, 11316.20786544934, 11620.186586938833, 11685.474153663276, 9803.362781419184, 9904.702858914245, 10084.69745907624, 10198.133158681596, 10322.948385258025, 8996.55017249122, 9442.339036267671, 9444.197243234403, 9510.992817660293, 9876.901230987598], "unit": "score", "name": "yui.html", "value": 6167.26971967319}], "name": "dromaeo_css", "value": 6762.145386820591}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 104.0, 109.0, 110.0, 110.0, 111.0, 111.0, 105.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.2}, {"lowerIsBetter": true, "replicates": [163.0, 126.0, 155.0, 179.0, 126.0, 149.0, 155.0, 127.0, 171.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 147.9}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 161.0, 161.0, 161.0, 161.0, 159.0, 162.0, 163.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 91.0, 94.0, 73.0, 72.0, 73.0, 119.0, 97.0, 75.0], "unit": "score", "name": "audio-fft", "value": 84.2}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 150.0, 96.0, 96.0, 95.0, 138.0, 94.0, 96.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [119.0, 114.0, 115.0, 115.0, 115.0, 115.0, 115.0, 114.0, 114.0, 114.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.0}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 97.0, 96.0, 95.0, 96.0, 96.0, 95.0, 97.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 56.0, 57.0, 55.0, 56.0, 57.0, 56.0, 57.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 66.0, 66.0, 67.0, 66.0, 66.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.6}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 83.0, 82.0, 82.0, 83.0, 90.0, 89.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 114.0, 114.0, 114.0, 115.0, 128.0, 126.0, 117.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.5}, {"lowerIsBetter": true, "replicates": [144.0, 131.0, 139.0, 142.0, 142.0, 131.0, 140.0, 143.0, 153.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.5}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 67.0, 66.0, 67.0, 67.0, 68.0, 68.0, 66.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1501.4999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.3080140538732], "unit": "score", "name": "Richards", "value": 211.00005399999995}, {"lowerIsBetter": false, "replicates": [189.60940462646948], "unit": "score", "name": "DeltaBlue", "value": 348.7063319999999}, {"lowerIsBetter": false, "replicates": [272.92576419213975], "unit": "score", "name": "Encrypt", "value": 975.2871839999998}, {"lowerIsBetter": false, "replicates": [5301.587301587301], "unit": "score", "name": "Decrypt", "value": 50.20779341317366}, {"lowerIsBetter": false, "replicates": [2057.4948665297743], "unit": "score", "name": "RayTrace", "value": 359.6553323353294}, {"lowerIsBetter": false, "replicates": [783.0853563038371], "unit": "score", "name": "Earley", "value": 851.0732510000003}, {"lowerIsBetter": false, "replicates": [12317.073170731708], "unit": "score", "name": "Boyer", "value": 54.108877227722786}, {"lowerIsBetter": false, "replicates": [42562.5], "unit": "score", "name": "RegExp", "value": 21.403465491923626}, {"lowerIsBetter": false, "replicates": [573.3788395904437], "unit": "score", "name": "Splay", "value": 142.1241845238095}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 18925.57281131576}]} 01:17:28 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "18925.57"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1501.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6762.14"}}} 01:17:28 INFO - Return code: 0 01:17:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 01:17:28 INFO - # TBPL SUCCESS # 01:17:28 INFO - Running post-action listener: _resource_record_post_action 01:17:28 INFO - Running post-run listener: _resource_record_post_run 01:17:29 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 16384; Write bytes: 538431488; Read time: 40; Write time: 554224 01:17:29 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236367872; Read time: 0; Write time: 325032 01:17:29 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 16384; Write bytes: 300859392; Read time: 40; Write time: 229044 01:17:29 INFO - Running post-run listener: _upload_blobber_files 01:17:29 INFO - Blob upload gear active. 01:17:29 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 01:17:29 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 01:17:29 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-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 01:17:29 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-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 01:17:30 INFO - (blobuploader) - INFO - Open directory for files ... 01:17:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 01:17:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:17:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:17:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:17:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:17:31 INFO - (blobuploader) - INFO - Done attempting. 01:17:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:17:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:17:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:17:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:17:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:17:32 INFO - (blobuploader) - INFO - Done attempting. 01:17:32 INFO - (blobuploader) - INFO - Iteration through files over. 01:17:32 INFO - Return code: 0 01:17:32 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 01:17:32 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 01:17:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c7f72352f62d486e47b97f8895f9dd022f5260063c4af040ab51968faee3f45c49b9b76646fd5f45e86c960d0110c04c8ad49fe32ffee77e3ddc550163e5ea7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/479ba82926b0ba006408804a394949acfc33eba8de1dc5edd30d5b7d6ef664bdc00debefaa5a8216231d224d3b490cc586b4fc05e88bbba8f2b99f5382eeef96"} 01:17:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 01:17:32 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 01:17:32 INFO - Contents: 01:17:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c7f72352f62d486e47b97f8895f9dd022f5260063c4af040ab51968faee3f45c49b9b76646fd5f45e86c960d0110c04c8ad49fe32ffee77e3ddc550163e5ea7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/479ba82926b0ba006408804a394949acfc33eba8de1dc5edd30d5b7d6ef664bdc00debefaa5a8216231d224d3b490cc586b4fc05e88bbba8f2b99f5382eeef96"} 01:17:32 INFO - Running post-run listener: copy_logs_to_upload_dir 01:17:32 INFO - Copying logs to upload dir... 01:17:32 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 01:17:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.077623 ========= master_lag: 0.32 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-01-27 01:17:32.320828) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-27 01:17:32.325642) ========= 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-1453881294.65609-1592859251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c7f72352f62d486e47b97f8895f9dd022f5260063c4af040ab51968faee3f45c49b9b76646fd5f45e86c960d0110c04c8ad49fe32ffee77e3ddc550163e5ea7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/479ba82926b0ba006408804a394949acfc33eba8de1dc5edd30d5b7d6ef664bdc00debefaa5a8216231d224d3b490cc586b4fc05e88bbba8f2b99f5382eeef96"} build_url:https://queue.taskcluster.net/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011344 build_url: 'https://queue.taskcluster.net/v1/task/LF1zluz4QYWo_LFuaGAnFg/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c7f72352f62d486e47b97f8895f9dd022f5260063c4af040ab51968faee3f45c49b9b76646fd5f45e86c960d0110c04c8ad49fe32ffee77e3ddc550163e5ea7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/479ba82926b0ba006408804a394949acfc33eba8de1dc5edd30d5b7d6ef664bdc00debefaa5a8216231d224d3b490cc586b4fc05e88bbba8f2b99f5382eeef96"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-27 01:17:32.350444) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 01:17:32.350762) ========= 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-1453881294.65609-1592859251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 01:17:32.404106) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-27 01:17:32.404425) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-27 01:17:32.404709) ========= ========= Total master_lag: 0.54 =========