builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-023 starttime: 1455750247.07 results: success (0) buildid: 20160217122128 builduid: 4330a056edc24fadb9e71fa999016b1a revision: af7fadb8663cb15d57a717ae0815aed8eef23043 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 15:04:07.074469) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 15:04:07.074978) ========= ========= Started set props: basedir (results: 0, elapsed: 2 secs) (at 2016-02-17 15:04:07.075272) ========= 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=6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006397 basedir: '/builds/slave/test-pgo' ========= master_lag: 2.54 ========= ========= Finished set props: basedir (results: 0, elapsed: 2 secs) (at 2016-02-17 15:04:09.617629) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-02-17 15:04:09.617976) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-02-17 15:04:10.967102) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 15:04:10.967507) ========= 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=6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004620 ========= master_lag: 0.17 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 15:04:11.145756) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 15:04:11.146023) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 15:04:11.146376) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 15:04:11.146638) ========= 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=6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-17 15:04:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 77.7M=0s 2016-02-17 15:04:12 (77.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.319665 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 15:04:11.497276) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 15:04:11.497548) ========= 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=6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018801 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 15:04:11.550222) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 15:04:11.550516) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev af7fadb8663cb15d57a717ae0815aed8eef23043 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev af7fadb8663cb15d57a717ae0815aed8eef23043 --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=6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-17 15:04:12,880 truncating revision to first 12 chars 2016-02-17 15:04:12,880 Setting DEBUG logging. 2016-02-17 15:04:12,880 attempt 1/10 2016-02-17 15:04:12,880 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/af7fadb8663c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-17 15:04:13,174 unpacking tar archive at: mozilla-aurora-af7fadb8663c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.581240 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 15:04:12.141174) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 15:04:12.141466) ========= echo af7fadb8663cb15d57a717ae0815aed8eef23043 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'af7fadb8663cb15d57a717ae0815aed8eef23043'] 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=6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False af7fadb8663cb15d57a717ae0815aed8eef23043 program finished with exit code 0 elapsedTime=0.003300 script_repo_revision: 'af7fadb8663cb15d57a717ae0815aed8eef23043' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 15:04:12.192254) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 15:04:12.192562) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 15:04:12.207445) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-02-17 15:04:12.207821) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:04:13 INFO - MultiFileLogger online at 20160217 15:04:13 in /builds/slave/test-pgo 15:04:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:04:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:04:13 INFO - {'append_to_log': False, 15:04:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:04:13 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:04:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:04:13 INFO - 'branch': 'Mozilla-Aurora', 15:04:13 INFO - 'buildbot_json_path': 'buildprops.json', 15:04:13 INFO - 'config_files': ('talos/linux_config.py',), 15:04:13 INFO - 'default_actions': ('clobber', 15:04:13 INFO - 'read-buildbot-config', 15:04:13 INFO - 'download-and-extract', 15:04:13 INFO - 'populate-webroot', 15:04:13 INFO - 'create-virtualenv', 15:04:13 INFO - 'install', 15:04:13 INFO - 'run-tests'), 15:04:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:04:13 INFO - 'download_minidump_stackwalk': True, 15:04:13 INFO - 'download_symbols': 'ondemand', 15:04:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:04:13 INFO - 'tooltool.py': '/tools/tooltool.py', 15:04:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:04:13 INFO - '/tools/misc-python/virtualenv.py')}, 15:04:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:04:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:04:13 INFO - 'installer_path': 'installer.exe', 15:04:13 INFO - 'log_level': 'info', 15:04:13 INFO - 'log_name': 'talos', 15:04:13 INFO - 'log_to_console': True, 15:04:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:04:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:04:13 INFO - 'opt_config_files': (), 15:04:13 INFO - 'pip_index': False, 15:04:13 INFO - 'sps_profile': False, 15:04:13 INFO - 'sps_profile_interval': 0, 15:04:13 INFO - 'suite': 'dromaeojs-e10s', 15:04:13 INFO - 'system_bits': '32', 15:04:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:04:13 INFO - 'title': 'talos-linux64-ix-023', 15:04:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:04:13 INFO - 'use_talos_json': True, 15:04:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:04:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:04:13 INFO - 'work_dir': 'build'} 15:04:13 INFO - ##### 15:04:13 INFO - ##### Running clobber step. 15:04:13 INFO - ##### 15:04:13 INFO - Running pre-action listener: _resource_record_pre_action 15:04:13 INFO - Running main action method: clobber 15:04:13 INFO - rmtree: /builds/slave/test-pgo/build 15:04:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:04:14 INFO - Running post-action listener: _resource_record_post_action 15:04:14 INFO - ##### 15:04:14 INFO - ##### Running read-buildbot-config step. 15:04:14 INFO - ##### 15:04:14 INFO - Running pre-action listener: _resource_record_pre_action 15:04:14 INFO - Running main action method: read_buildbot_config 15:04:14 INFO - Using buildbot properties: 15:04:14 INFO - { 15:04:14 INFO - "project": "", 15:04:14 INFO - "product": "firefox", 15:04:14 INFO - "script_repo_revision": "production", 15:04:14 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 15:04:14 INFO - "repository": "", 15:04:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 15:04:14 INFO - "buildid": "20160217122128", 15:04:14 INFO - "pgo_build": "True", 15:04:14 INFO - "basedir": "/builds/slave/test-pgo", 15:04:14 INFO - "buildnumber": 131, 15:04:14 INFO - "slavename": "talos-linux64-ix-023", 15:04:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:04:14 INFO - "platform": "ubuntu64_hw", 15:04:14 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:04:14 INFO - "branch": "mozilla-aurora", 15:04:14 INFO - "repo_path": "releases/mozilla-aurora", 15:04:14 INFO - "revision": "af7fadb8663cb15d57a717ae0815aed8eef23043", 15:04:14 INFO - "stage_platform": "linux64-pgo", 15:04:14 INFO - "builduid": "4330a056edc24fadb9e71fa999016b1a", 15:04:14 INFO - "slavebuilddir": "test" 15:04:14 INFO - } 15:04:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 15:04:14 INFO - Running post-action listener: _resource_record_post_action 15:04:14 INFO - ##### 15:04:14 INFO - ##### Running download-and-extract step. 15:04:14 INFO - ##### 15:04:14 INFO - Running pre-action listener: _resource_record_pre_action 15:04:14 INFO - Running main action method: download_and_extract 15:04:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:04:14 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')]} 15:04:14 INFO - https://queue.taskcluster.net/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:04:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/test_packages.json 15:04:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/test_packages.json 15:04:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:04:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:04:16 INFO - Downloaded 1448 bytes. 15:04:16 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:04:16 INFO - Using the following test package requirements: 15:04:16 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 15:04:16 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 15:04:16 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:04:16 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 15:04:16 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:04:16 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 15:04:16 INFO - u'jsshell-linux-x86_64.zip'], 15:04:16 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 15:04:16 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:04:16 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 15:04:16 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 15:04:16 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:04:16 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 15:04:16 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:04:16 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 15:04:16 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:04:16 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 15:04:16 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 15:04:16 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:04:16 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:04:16 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')]} 15:04:16 INFO - https://queue.taskcluster.net/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:04:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 15:04:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 15:04:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 15:04:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:04:18 INFO - Downloaded 23073616 bytes. 15:04:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 15:04:18 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 15:04:19 INFO - Return code: 0 15:04:19 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:19 INFO - https://queue.taskcluster.net/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:04:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 15:04:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 15:04:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 15:04:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:04:23 INFO - Downloaded 23073616 bytes. 15:04:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 15:04:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 15:04:25 INFO - Return code: 0 15:04:25 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')]} 15:04:25 INFO - https://queue.taskcluster.net/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:04:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 15:04:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 15:04:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 15:04:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:04:26 INFO - Downloaded 10706572 bytes. 15:04:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 15:04:26 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 15:04:26 INFO - Return code: 0 15:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:26 INFO - https://queue.taskcluster.net/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:04:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 15:04:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 15:04:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 15:04:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:04:28 INFO - Downloaded 59961449 bytes. 15:04:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 15:04:28 INFO - mkdir: /builds/slave/test-pgo/properties 15:04:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:04:28 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:04:28 INFO - Contents: 15:04:28 INFO - build_url:https://queue.taskcluster.net/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 15:04:29 INFO - Running post-action listener: _resource_record_post_action 15:04:29 INFO - Running post-action listener: set_extra_try_arguments 15:04:29 INFO - ##### 15:04:29 INFO - ##### Running populate-webroot step. 15:04:29 INFO - ##### 15:04:29 INFO - Running pre-action listener: _resource_record_pre_action 15:04:29 INFO - Running main action method: populate_webroot 15:04:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:04:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:04:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:04:29 INFO - '--tppagecycles', 15:04:29 INFO - '7'], 15:04:29 INFO - 'tests': ['tsvgm']}}, 15:04:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:04:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:04:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:04:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:04:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:04:29 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:04:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:04:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:04:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:04:29 INFO - 'talos_options': ['--e10s'], 15:04:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:04:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:04:29 INFO - 'tests': ['damp', 'tps']}, 15:04:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:04:29 INFO - 'talos_options': ['--e10s'], 15:04:29 INFO - 'tests': ['damp', 'tps']}, 15:04:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:04:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:04:29 INFO - 'other': {'tests': ['a11yr', 15:04:29 INFO - 'ts_paint', 15:04:29 INFO - 'tpaint', 15:04:29 INFO - 'sessionrestore', 15:04:29 INFO - 'sessionrestore_no_auto_restore']}, 15:04:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:04:29 INFO - 'tests': ['a11yr', 15:04:29 INFO - 'ts_paint', 15:04:29 INFO - 'tpaint', 15:04:29 INFO - 'sessionrestore', 15:04:29 INFO - 'sessionrestore_no_auto_restore']}, 15:04:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:04:29 INFO - 'tests': ['a11yr', 15:04:29 INFO - 'ts_paint', 15:04:29 INFO - 'tpaint', 15:04:29 INFO - 'sessionrestore', 15:04:29 INFO - 'sessionrestore_no_auto_restore']}, 15:04:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:04:29 INFO - 'tests': ['a11yr', 15:04:29 INFO - 'ts_paint', 15:04:29 INFO - 'tpaint', 15:04:29 INFO - 'sessionrestore', 15:04:29 INFO - 'sessionrestore_no_auto_restore']}, 15:04:29 INFO - 'other_l64': {'tests': ['a11yr', 15:04:29 INFO - 'ts_paint', 15:04:29 INFO - 'tpaint', 15:04:29 INFO - 'sessionrestore', 15:04:29 INFO - 'sessionrestore_no_auto_restore']}, 15:04:29 INFO - 'other_nol64': {'tests': ['a11yr', 15:04:29 INFO - 'ts_paint', 15:04:29 INFO - 'tpaint', 15:04:29 INFO - 'sessionrestore', 15:04:29 INFO - 'sessionrestore_no_auto_restore']}, 15:04:29 INFO - 'svgr': {'tests': ['tsvgx', 15:04:29 INFO - 'tsvgr_opacity', 15:04:29 INFO - 'tart', 15:04:29 INFO - 'tscrollx', 15:04:29 INFO - 'cart']}, 15:04:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:04:29 INFO - 'tests': ['tsvgx', 15:04:29 INFO - 'tsvgr_opacity', 15:04:29 INFO - 'tart', 15:04:29 INFO - 'tscrollx', 15:04:29 INFO - 'cart']}, 15:04:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:04:29 INFO - 'tests': ['tp5o']}, 15:04:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:04:29 INFO - 'talos_options': ['--e10s'], 15:04:29 INFO - 'tests': ['tp5o']}, 15:04:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:04:29 INFO - 'talos_options': ['--xperf_path', 15:04:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:04:29 INFO - 'tests': ['tp5n']}, 15:04:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:04:29 INFO - 'talos_options': ['--e10s', 15:04:29 INFO - '--xperf_path', 15:04:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:04:29 INFO - 'tests': ['tp5n']}}, 15:04:29 INFO - 'talos.zip': {'path': '', 15:04:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:04:29 INFO - Running post-action listener: _resource_record_post_action 15:04:29 INFO - ##### 15:04:29 INFO - ##### Running create-virtualenv step. 15:04:29 INFO - ##### 15:04:29 INFO - Running pre-action listener: _resource_record_pre_action 15:04:29 INFO - Running main action method: create_virtualenv 15:04:29 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:04:29 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 15:04:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:04:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:04:29 INFO - Using real prefix '/usr' 15:04:29 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:04:29 INFO - Installing distribute.............................................................................................................................................................................................done. 15:04:31 INFO - Installing pip.................done. 15:04:31 INFO - Return code: 0 15:04:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:31 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 0x7f1333d5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd95230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe277f0>, '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 0xd932d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd93760>, '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': '6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431', '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 15:04:31 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 15:04:31 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 15:04:31 INFO - Using env: {'DISPLAY': ':0', 15:04:31 INFO - 'HOME': '/home/cltbld', 15:04:31 INFO - 'LANG': 'en_US.UTF-8', 15:04:31 INFO - 'LANGUAGE': 'en_US:en', 15:04:31 INFO - 'LOGNAME': 'cltbld', 15:04:31 INFO - 'MAIL': '/var/mail/cltbld', 15:04:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:31 INFO - 'MOZ_NO_REMOTE': '1', 15:04:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:04:31 INFO - 'NO_EM_RESTART': '1', 15:04:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:04:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:04:31 INFO - 'PWD': '/builds/slave/test-pgo', 15:04:31 INFO - 'SHELL': '/bin/bash', 15:04:31 INFO - 'SHLVL': '1', 15:04:31 INFO - 'TERM': 'linux', 15:04:31 INFO - 'TMOUT': '86400', 15:04:31 INFO - 'USER': 'cltbld', 15:04:31 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431', 15:04:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:31 INFO - '_': '/tools/buildbot/bin/python'} 15:04:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:32 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 15:04:32 INFO - Cleaning up... 15:04:32 INFO - Return code: 0 15:04:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:04: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')]} 15:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04: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')]} 15:04:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:32 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 0x7f1333d5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd95230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe277f0>, '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 0xd932d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd93760>, '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': '6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431', '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 15:04:32 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 15:04:32 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 15:04:32 INFO - Using env: {'DISPLAY': ':0', 15:04:32 INFO - 'HOME': '/home/cltbld', 15:04:32 INFO - 'LANG': 'en_US.UTF-8', 15:04:32 INFO - 'LANGUAGE': 'en_US:en', 15:04:32 INFO - 'LOGNAME': 'cltbld', 15:04:32 INFO - 'MAIL': '/var/mail/cltbld', 15:04:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:32 INFO - 'MOZ_NO_REMOTE': '1', 15:04:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:04:32 INFO - 'NO_EM_RESTART': '1', 15:04:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:04:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:04:32 INFO - 'PWD': '/builds/slave/test-pgo', 15:04:32 INFO - 'SHELL': '/bin/bash', 15:04:32 INFO - 'SHLVL': '1', 15:04:32 INFO - 'TERM': 'linux', 15:04:32 INFO - 'TMOUT': '86400', 15:04:32 INFO - 'USER': 'cltbld', 15:04:32 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431', 15:04:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:32 INFO - '_': '/tools/buildbot/bin/python'} 15:04:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:32 INFO - Downloading/unpacking psutil>=0.7.1 15:04:32 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 15:04:32 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 15:04:32 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 15:04:32 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 15:04:32 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 15:04:32 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 15:04:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:04:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:04:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:04:34 INFO - Installing collected packages: psutil 15:04:34 INFO - Running setup.py install for psutil 15:04:34 INFO - building 'psutil._psutil_linux' extension 15:04:34 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 15:04:34 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 15:04:34 INFO - building 'psutil._psutil_posix' extension 15:04:34 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 15:04:34 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 15:04:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:04:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:04:34 INFO - Successfully installed psutil 15:04:34 INFO - Cleaning up... 15:04:34 INFO - Return code: 0 15:04:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:34 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 0x7f1333d5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd95230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe277f0>, '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 0xd932d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd93760>, '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': '6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431', '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 15:04:34 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 15:04:34 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 15:04:34 INFO - Using env: {'DISPLAY': ':0', 15:04:34 INFO - 'HOME': '/home/cltbld', 15:04:34 INFO - 'LANG': 'en_US.UTF-8', 15:04:34 INFO - 'LANGUAGE': 'en_US:en', 15:04:34 INFO - 'LOGNAME': 'cltbld', 15:04:34 INFO - 'MAIL': '/var/mail/cltbld', 15:04:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:34 INFO - 'MOZ_NO_REMOTE': '1', 15:04:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:04:34 INFO - 'NO_EM_RESTART': '1', 15:04:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:04:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:04:34 INFO - 'PWD': '/builds/slave/test-pgo', 15:04:34 INFO - 'SHELL': '/bin/bash', 15:04:34 INFO - 'SHLVL': '1', 15:04:34 INFO - 'TERM': 'linux', 15:04:34 INFO - 'TMOUT': '86400', 15:04:34 INFO - 'USER': 'cltbld', 15:04:34 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431', 15:04:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:34 INFO - '_': '/tools/buildbot/bin/python'} 15:04:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:04:34 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 15:04:34 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 15:04:34 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 15:04:34 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 15:04:34 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 15:04:34 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 15:04:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:04:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:04:36 INFO - Installing collected packages: mozsystemmonitor 15:04:36 INFO - Running setup.py install for mozsystemmonitor 15:04:36 INFO - Successfully installed mozsystemmonitor 15:04:36 INFO - Cleaning up... 15:04:36 INFO - Return code: 0 15:04:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:04:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1333d5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd95230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe277f0>, '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 0xd932d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd93760>, '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': '6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431', '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 15:04:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 15:04:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:04:36 INFO - Using env: {'DISPLAY': ':0', 15:04:36 INFO - 'HOME': '/home/cltbld', 15:04:36 INFO - 'LANG': 'en_US.UTF-8', 15:04:36 INFO - 'LANGUAGE': 'en_US:en', 15:04:36 INFO - 'LOGNAME': 'cltbld', 15:04:36 INFO - 'MAIL': '/var/mail/cltbld', 15:04:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:36 INFO - 'MOZ_NO_REMOTE': '1', 15:04:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:04:36 INFO - 'NO_EM_RESTART': '1', 15:04:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:04:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:04:36 INFO - 'PWD': '/builds/slave/test-pgo', 15:04:36 INFO - 'SHELL': '/bin/bash', 15:04:36 INFO - 'SHLVL': '1', 15:04:36 INFO - 'TERM': 'linux', 15:04:36 INFO - 'TMOUT': '86400', 15:04:36 INFO - 'USER': 'cltbld', 15:04:36 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431', 15:04:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:36 INFO - '_': '/tools/buildbot/bin/python'} 15:04:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:37 INFO - Downloading/unpacking blobuploader==1.2.4 15:04:37 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 15:04:37 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 15:04:37 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 15:04:37 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 15:04:37 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 15:04:37 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 15:04:38 INFO - Downloading blobuploader-1.2.4.tar.gz 15:04:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:04:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:04:39 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 15:04:39 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 15:04:39 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 15:04:39 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 15:04:39 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 15:04:39 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 15:04:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:04:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:04:39 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 15:04:39 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 15:04:39 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 15:04:39 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 15:04:39 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 15:04:39 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 15:04:39 INFO - Downloading docopt-0.6.1.tar.gz 15:04:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:04:39 INFO - Installing collected packages: blobuploader, requests, docopt 15:04:39 INFO - Running setup.py install for blobuploader 15:04:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:04:39 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:04:39 INFO - Running setup.py install for requests 15:04:40 INFO - Running setup.py install for docopt 15:04:40 INFO - Successfully installed blobuploader requests docopt 15:04:40 INFO - Cleaning up... 15:04:40 INFO - Return code: 0 15:04:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:04: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')]} 15:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04: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')]} 15:04:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:40 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 0x7f1333d5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd95230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe277f0>, '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 0xd932d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd93760>, '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': '6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431', '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 15:04:40 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 15:04:40 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 15:04:40 INFO - Using env: {'DISPLAY': ':0', 15:04:40 INFO - 'HOME': '/home/cltbld', 15:04:40 INFO - 'LANG': 'en_US.UTF-8', 15:04:40 INFO - 'LANGUAGE': 'en_US:en', 15:04:40 INFO - 'LOGNAME': 'cltbld', 15:04:40 INFO - 'MAIL': '/var/mail/cltbld', 15:04:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:40 INFO - 'MOZ_NO_REMOTE': '1', 15:04:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:04:40 INFO - 'NO_EM_RESTART': '1', 15:04:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:04:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:04:40 INFO - 'PWD': '/builds/slave/test-pgo', 15:04:40 INFO - 'SHELL': '/bin/bash', 15:04:40 INFO - 'SHLVL': '1', 15:04:40 INFO - 'TERM': 'linux', 15:04:40 INFO - 'TMOUT': '86400', 15:04:40 INFO - 'USER': 'cltbld', 15:04:40 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431', 15:04:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:40 INFO - '_': '/tools/buildbot/bin/python'} 15:04:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:04:40 INFO - Running setup.py (path:/tmp/pip-9kFDnV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:04:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:04:40 INFO - Running setup.py (path:/tmp/pip-AHpK91-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:04:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:04:40 INFO - Running setup.py (path:/tmp/pip-KH5hI1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:04:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:04:40 INFO - Running setup.py (path:/tmp/pip-yi2ohw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:04:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:04:40 INFO - Running setup.py (path:/tmp/pip-Gy1yUH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:04:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:04:40 INFO - Running setup.py (path:/tmp/pip-mR3G97-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:04:41 INFO - Running setup.py (path:/tmp/pip-f583O6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:04:41 INFO - Running setup.py (path:/tmp/pip-eu5Nll-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:04:41 INFO - Running setup.py (path:/tmp/pip-QBG7bz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:04:41 INFO - Running setup.py (path:/tmp/pip-XzbsGt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:04:41 INFO - Running setup.py (path:/tmp/pip-88ujdo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:04:41 INFO - Running setup.py (path:/tmp/pip-EZoDwk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:04:41 INFO - Running setup.py (path:/tmp/pip-UxPeiv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:04:41 INFO - Running setup.py (path:/tmp/pip-o48QbY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:04:41 INFO - Running setup.py (path:/tmp/pip-PpTJEf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:04:41 INFO - Running setup.py (path:/tmp/pip-hG1Rz4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:04:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:04:41 INFO - Running setup.py (path:/tmp/pip-14VvKY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:04:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:04:41 INFO - Running setup.py install for manifestparser 15:04:41 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:04:41 INFO - Running setup.py install for mozcrash 15:04:42 INFO - Running setup.py install for mozdebug 15:04:42 INFO - Running setup.py install for mozdevice 15:04:42 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:04:42 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:04:42 INFO - Running setup.py install for mozfile 15:04:42 INFO - Running setup.py install for mozhttpd 15:04:42 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:04:42 INFO - Running setup.py install for mozinfo 15:04:42 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:04:42 INFO - Running setup.py install for mozInstall 15:04:42 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:04:42 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:04:42 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:04:42 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:04:42 INFO - Running setup.py install for mozleak 15:04:42 INFO - Running setup.py install for mozlog 15:04:42 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:04:42 INFO - Running setup.py install for moznetwork 15:04:42 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:04:42 INFO - Running setup.py install for mozprocess 15:04:43 INFO - Running setup.py install for mozprofile 15:04:43 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:04:43 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:04:43 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:04:43 INFO - Running setup.py install for mozrunner 15:04:43 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:04:43 INFO - Running setup.py install for mozscreenshot 15:04:43 INFO - Running setup.py install for moztest 15:04:43 INFO - Running setup.py install for mozversion 15:04:43 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:04:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:04:43 INFO - Cleaning up... 15:04:43 INFO - Return code: 0 15:04:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:43 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 0x7f1333d5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd95230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe277f0>, '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 0xd932d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd93760>, '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': '6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431', '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 15:04:43 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 15:04:43 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 15:04:43 INFO - Using env: {'DISPLAY': ':0', 15:04:43 INFO - 'HOME': '/home/cltbld', 15:04:43 INFO - 'LANG': 'en_US.UTF-8', 15:04:43 INFO - 'LANGUAGE': 'en_US:en', 15:04:43 INFO - 'LOGNAME': 'cltbld', 15:04:43 INFO - 'MAIL': '/var/mail/cltbld', 15:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:43 INFO - 'MOZ_NO_REMOTE': '1', 15:04:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:04:43 INFO - 'NO_EM_RESTART': '1', 15:04:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:04:43 INFO - 'PWD': '/builds/slave/test-pgo', 15:04:43 INFO - 'SHELL': '/bin/bash', 15:04:43 INFO - 'SHLVL': '1', 15:04:43 INFO - 'TERM': 'linux', 15:04:43 INFO - 'TMOUT': '86400', 15:04:43 INFO - 'USER': 'cltbld', 15:04:43 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431', 15:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:43 INFO - '_': '/tools/buildbot/bin/python'} 15:04:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:04:43 INFO - Running setup.py (path:/tmp/pip-_fPvhF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:04:43 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)) 15:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:04:43 INFO - Running setup.py (path:/tmp/pip-BhJ_k_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:04:43 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)) 15:04:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:04:43 INFO - Running setup.py (path:/tmp/pip-exno67-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:04:44 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)) 15:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:04:44 INFO - Running setup.py (path:/tmp/pip-2U4wEi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:04:44 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)) 15:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:04:44 INFO - Running setup.py (path:/tmp/pip-aEgP7s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:04:44 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)) 15:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:04:44 INFO - Running setup.py (path:/tmp/pip-NEpJdr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:04:44 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)) 15:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:04:44 INFO - Running setup.py (path:/tmp/pip-NAdCVa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:04:44 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)) 15:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:04:44 INFO - Running setup.py (path:/tmp/pip-zINhE0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:04:44 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)) 15:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:04:44 INFO - Running setup.py (path:/tmp/pip-iouent-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:04:44 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)) 15:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:04:44 INFO - Running setup.py (path:/tmp/pip-nomgbr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:04:44 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)) 15:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:04:44 INFO - Running setup.py (path:/tmp/pip-bQ7EYS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:04:44 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)) 15:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:04:44 INFO - Running setup.py (path:/tmp/pip-1lYNhG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:04:44 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)) 15:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:04:44 INFO - Running setup.py (path:/tmp/pip-hJolFZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:04:44 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)) 15:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:04:44 INFO - Running setup.py (path:/tmp/pip-wfYBKd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:04:44 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)) 15:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:04:44 INFO - Running setup.py (path:/tmp/pip-KNEfGe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:04:44 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)) 15:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:04:44 INFO - Running setup.py (path:/tmp/pip-_csm8d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:04:44 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)) 15:04:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:04:44 INFO - Running setup.py (path:/tmp/pip-SjOwsa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:04:45 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)) 15:04:45 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)) 15:04:45 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)) 15:04:45 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)) 15:04:45 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)) 15:04:45 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)) 15:04:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:04: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 15:04: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 15:04: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 15:04: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 15:04: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 15:04: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 15:04:46 INFO - Downloading blessings-1.6.tar.gz 15:04:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:04:46 INFO - Installing collected packages: blessings 15:04:46 INFO - Running setup.py install for blessings 15:04:47 INFO - Successfully installed blessings 15:04:47 INFO - Cleaning up... 15:04:47 INFO - Return code: 0 15:04:47 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:04:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:04:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:04:47 INFO - Reading from file tmpfile_stdout 15:04:47 INFO - Current package versions: 15:04:47 INFO - argparse == 1.2.1 15:04:47 INFO - blessings == 1.6 15:04:47 INFO - blobuploader == 1.2.4 15:04:47 INFO - docopt == 0.6.1 15:04:47 INFO - manifestparser == 1.1 15:04:47 INFO - mozInstall == 1.12 15:04:47 INFO - mozcrash == 0.16 15:04:47 INFO - mozdebug == 0.1 15:04:47 INFO - mozdevice == 0.48 15:04:47 INFO - mozfile == 1.2 15:04:47 INFO - mozhttpd == 0.7 15:04:47 INFO - mozinfo == 0.9 15:04:47 INFO - mozleak == 0.1 15:04:47 INFO - mozlog == 3.1 15:04:47 INFO - moznetwork == 0.27 15:04:47 INFO - mozprocess == 0.22 15:04:47 INFO - mozprofile == 0.28 15:04:47 INFO - mozrunner == 6.11 15:04:47 INFO - mozscreenshot == 0.1 15:04:47 INFO - mozsystemmonitor == 0.0 15:04:47 INFO - moztest == 0.7 15:04:47 INFO - mozversion == 1.4 15:04:47 INFO - psutil == 3.1.1 15:04:47 INFO - requests == 1.2.3 15:04:47 INFO - wsgiref == 0.1.2 15:04:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:47 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 0x7f1333d5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd95230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe277f0>, '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 0xd932d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd93760>, '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': '6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431', '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 15:04:47 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 15:04:47 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 15:04:47 INFO - Using env: {'DISPLAY': ':0', 15:04:47 INFO - 'HOME': '/home/cltbld', 15:04:47 INFO - 'LANG': 'en_US.UTF-8', 15:04:47 INFO - 'LANGUAGE': 'en_US:en', 15:04:47 INFO - 'LOGNAME': 'cltbld', 15:04:47 INFO - 'MAIL': '/var/mail/cltbld', 15:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:47 INFO - 'MOZ_NO_REMOTE': '1', 15:04:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:04:47 INFO - 'NO_EM_RESTART': '1', 15:04:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:04:47 INFO - 'PWD': '/builds/slave/test-pgo', 15:04:47 INFO - 'SHELL': '/bin/bash', 15:04:47 INFO - 'SHLVL': '1', 15:04:47 INFO - 'TERM': 'linux', 15:04:47 INFO - 'TMOUT': '86400', 15:04:47 INFO - 'USER': 'cltbld', 15:04:47 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431', 15:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:47 INFO - '_': '/tools/buildbot/bin/python'} 15:04:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:47 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)) 15:04:47 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)) 15:04:47 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)) 15:04:47 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)) 15:04:47 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)) 15:04:47 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)) 15:04:47 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)) 15:04:47 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)) 15:04:47 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)) 15:04:47 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)) 15:04:47 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)) 15:04:47 INFO - Cleaning up... 15:04:47 INFO - Return code: 0 15:04:47 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1333d5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd95230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe277f0>, '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 0xd932d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd93760>, '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': '6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431', '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 15:04:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 15:04:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:04:47 INFO - Using env: {'DISPLAY': ':0', 15:04:47 INFO - 'HOME': '/home/cltbld', 15:04:47 INFO - 'LANG': 'en_US.UTF-8', 15:04:47 INFO - 'LANGUAGE': 'en_US:en', 15:04:47 INFO - 'LOGNAME': 'cltbld', 15:04:47 INFO - 'MAIL': '/var/mail/cltbld', 15:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:47 INFO - 'MOZ_NO_REMOTE': '1', 15:04:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:04:47 INFO - 'NO_EM_RESTART': '1', 15:04:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:04:47 INFO - 'PWD': '/builds/slave/test-pgo', 15:04:47 INFO - 'SHELL': '/bin/bash', 15:04:47 INFO - 'SHLVL': '1', 15:04:47 INFO - 'TERM': 'linux', 15:04:47 INFO - 'TMOUT': '86400', 15:04:47 INFO - 'USER': 'cltbld', 15:04:47 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431', 15:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:47 INFO - '_': '/tools/buildbot/bin/python'} 15:04:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:47 INFO - Downloading/unpacking jsonschema 15:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:04:49 INFO - Downloading/unpacking functools32 (from jsonschema) 15:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:49 INFO - Downloading functools32-3.2.3-2.tar.gz 15:04:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:04:49 INFO - warning: no files found matching '*.txt' 15:04:49 INFO - no previously-included directories found matching 'build' 15:04:49 INFO - no previously-included directories found matching 'dist' 15:04:49 INFO - no previously-included directories found matching '.git*' 15:04:49 INFO - Installing collected packages: jsonschema, functools32 15:04:49 INFO - Running setup.py install for functools32 15:04:49 INFO - warning: no files found matching '*.txt' 15:04:49 INFO - no previously-included directories found matching 'build' 15:04:49 INFO - no previously-included directories found matching 'dist' 15:04:49 INFO - no previously-included directories found matching '.git*' 15:04:49 INFO - Successfully installed jsonschema functools32 15:04:49 INFO - Cleaning up... 15:04:50 INFO - Return code: 0 15:04:50 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1333d5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd95230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe277f0>, '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 0xd932d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd93760>, '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': '6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431', '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 15:04:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 15:04:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:04:50 INFO - Using env: {'DISPLAY': ':0', 15:04:50 INFO - 'HOME': '/home/cltbld', 15:04:50 INFO - 'LANG': 'en_US.UTF-8', 15:04:50 INFO - 'LANGUAGE': 'en_US:en', 15:04:50 INFO - 'LOGNAME': 'cltbld', 15:04:50 INFO - 'MAIL': '/var/mail/cltbld', 15:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:50 INFO - 'MOZ_NO_REMOTE': '1', 15:04:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:04:50 INFO - 'NO_EM_RESTART': '1', 15:04:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:04:50 INFO - 'PWD': '/builds/slave/test-pgo', 15:04:50 INFO - 'SHELL': '/bin/bash', 15:04:50 INFO - 'SHLVL': '1', 15:04:50 INFO - 'TERM': 'linux', 15:04:50 INFO - 'TMOUT': '86400', 15:04:50 INFO - 'USER': 'cltbld', 15:04:50 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431', 15:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:50 INFO - '_': '/tools/buildbot/bin/python'} 15:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:50 INFO - Downloading/unpacking flake8 15:04: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 15:04: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 15:04: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 15:04: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 15:04: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 15:04: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 15:04:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:04:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:04:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:04:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:04:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:04:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:04:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:04:52 INFO - no previously-included directories found matching 'docs/_build' 15:04:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:04:52 INFO - Running setup.py install for pep8 15:04:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:04:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:04:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:04:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:04:52 INFO - no previously-included directories found matching 'docs/_build' 15:04:52 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:04:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:04:52 INFO - Cleaning up... 15:04:52 INFO - Return code: 0 15:04:52 INFO - Running post-action listener: _resource_record_post_action 15:04:52 INFO - Running post-action listener: _start_resource_monitoring 15:04:53 INFO - Starting resource monitoring. 15:04:53 INFO - ##### 15:04:53 INFO - ##### Running install step. 15:04:53 INFO - ##### 15:04:53 INFO - Running pre-action listener: _resource_record_pre_action 15:04:53 INFO - Running main action method: install 15:04:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:04:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:04:53 INFO - Reading from file tmpfile_stdout 15:04:53 INFO - Detecting whether we're running mozinstall >=1.0... 15:04:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:04:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:04:53 INFO - Reading from file tmpfile_stdout 15:04:53 INFO - Output received: 15:04:53 INFO - Usage: mozinstall [options] installer 15:04:53 INFO - Options: 15:04:53 INFO - -h, --help show this help message and exit 15:04:53 INFO - -d DEST, --destination=DEST 15:04:53 INFO - Directory to install application into. [default: 15:04:53 INFO - "/builds/slave/test-pgo"] 15:04:53 INFO - --app=APP Application being installed. [default: firefox] 15:04:53 INFO - mkdir: /builds/slave/test-pgo/build/application 15:04:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 15:04:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 15:05:08 INFO - Reading from file tmpfile_stdout 15:05:08 INFO - Output received: 15:05:08 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:05:08 INFO - Running post-action listener: _resource_record_post_action 15:05:08 INFO - ##### 15:05:08 INFO - ##### Running run-tests step. 15:05:08 INFO - ##### 15:05:08 INFO - Running pre-action listener: _resource_record_pre_action 15:05:08 INFO - Running main action method: run_tests 15:05:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:05:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:05:08 INFO - Python 2.7.3 15:05:08 INFO - Return code: 0 15:05:08 INFO - grabbing minidump binary from tooltool 15:05:08 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')]} 15:05:08 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 0xe277f0>, '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 0xd932d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd93760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:05:08 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 15:05:08 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 15:05:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:05:08 INFO - Return code: 0 15:05:08 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:05:08 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:05:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:05:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:05:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:05:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 15:05:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 15:05:09 INFO - Return code: 0 15:05:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 15:05:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:05:09 INFO - Using env: {'DISPLAY': ':0', 15:05:09 INFO - 'HOME': '/home/cltbld', 15:05:09 INFO - 'LANG': 'en_US.UTF-8', 15:05:09 INFO - 'LANGUAGE': 'en_US:en', 15:05:09 INFO - 'LOGNAME': 'cltbld', 15:05:09 INFO - 'MAIL': '/var/mail/cltbld', 15:05:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:05:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:09 INFO - 'MOZ_NO_REMOTE': '1', 15:05:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:05:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:05:09 INFO - 'NO_EM_RESTART': '1', 15:05:09 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:05:09 INFO - 'PWD': '/builds/slave/test-pgo', 15:05:09 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:05:09 INFO - 'SHELL': '/bin/bash', 15:05:09 INFO - 'SHLVL': '1', 15:05:09 INFO - 'TERM': 'linux', 15:05:09 INFO - 'TMOUT': '86400', 15:05:09 INFO - 'USER': 'cltbld', 15:05:09 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431', 15:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:09 INFO - '_': '/tools/buildbot/bin/python'} 15:05:09 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:05:09 INFO - mozversion application_buildid: 20160217122128 15:05:09 INFO - mozversion application_changeset: af7fadb8663cb15d57a717ae0815aed8eef23043 15:05:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:05:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:05:09 INFO - mozversion application_name: Firefox 15:05:09 INFO - mozversion application_remotingname: firefox-dev 15:05:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:05:09 INFO - mozversion application_vendor: Mozilla 15:05:09 INFO - mozversion application_version: 46.0a2 15:05:09 INFO - mozversion platform_buildid: 20160217122128 15:05:09 INFO - mozversion platform_changeset: af7fadb8663cb15d57a717ae0815aed8eef23043 15:05:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:05:09 INFO - mozversion platform_version: 46.0a2 15:05:09 INFO - using testdate: 1455750309 15:05:09 INFO - actual date: 1455750309 15:05:09 INFO - starting webserver on 'localhost:51624' 15:05:09 INFO - SUITE-START | Running 3 tests 15:05:09 INFO - TEST-START | dromaeo_css 15:05:09 INFO - operating with platform_type : linux_ 15:05:09 INFO - Initialising browser for dromaeo_css test... 15:05:09 INFO - TEST-INFO | started process 24544 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuQSulg/profile http://localhost:51624/getInfo.html) 15:05:12 INFO - PROCESS | 24544 | 15:05:12 INFO - PROCESS | 24544 | (process:24621): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:05:13 INFO - PROCESS | 24544 | __metrics Screen width/height:1600/1200 15:05:13 INFO - PROCESS | 24544 | colorDepth:24 15:05:13 INFO - PROCESS | 24544 | Browser inner width/height: 1024/697 15:05:13 INFO - PROCESS | 24544 | __metrics 15:05:14 INFO - TEST-INFO | 24544: exit 0 15:05:14 INFO - Browser initialized. 15:05:14 INFO - Running cycle 1/1 for dromaeo_css test... 15:05:14 INFO - TEST-INFO | started process 24670 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuQSulg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:05:16 INFO - PROCESS | 24670 | 15:05:16 INFO - PROCESS | 24670 | (process:24732): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:05:26 INFO - PROCESS | 24670 | RSS: Main: 141889536 15:05:26 INFO - PROCESS | 24670 | 15:06:16 INFO - PROCESS | 24670 | 1455750376188 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] 15:08:23 INFO - PROCESS | 24670 | Cycle 1(1): loaded http://localhost:51624/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51624/tests/dromaeo/cssquery-ext.html) 15:08:24 INFO - PROCESS | 24670 | RSS: Main: 146231296 15:08:24 INFO - PROCESS | 24670 | 15:11:26 INFO - PROCESS | 24670 | Cycle 1(1): loaded http://localhost:51624/tests/dromaeo/cssquery-ext.html (next: http://localhost:51624/tests/dromaeo/cssquery-jquery.html) 15:11:27 INFO - PROCESS | 24670 | RSS: Main: 144887808 15:11:27 INFO - PROCESS | 24670 | 15:14:28 INFO - PROCESS | 24670 | Cycle 1(1): loaded http://localhost:51624/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51624/tests/dromaeo/cssquery-mootools.html) 15:14:29 INFO - PROCESS | 24670 | RSS: Main: 144314368 15:14:29 INFO - PROCESS | 24670 | 15:17:31 INFO - PROCESS | 24670 | Cycle 1(1): loaded http://localhost:51624/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51624/tests/dromaeo/cssquery-prototype.html) 15:17:31 INFO - PROCESS | 24670 | RSS: Main: 143454208 15:17:31 INFO - PROCESS | 24670 | 15:20:34 INFO - PROCESS | 24670 | Cycle 1(1): loaded http://localhost:51624/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51624/tests/dromaeo/cssquery-yui.html) 15:20:34 INFO - PROCESS | 24670 | RSS: Main: 143855616 15:20:34 INFO - PROCESS | 24670 | 15:23:36 INFO - PROCESS | 24670 | Cycle 1(1): loaded http://localhost:51624/tests/dromaeo/cssquery-yui.html (next: http://localhost:51624/tests/dromaeo/cssquery-dojo.html) 15:23:37 INFO - PROCESS | 24670 | RSS: Main: 146935808 15:23:37 INFO - PROCESS | 24670 | 15:23:37 INFO - PROCESS | 24670 | __start_tp_report 15:23:37 INFO - PROCESS | 24670 | _x_x_mozilla_page_load 15:23:37 INFO - PROCESS | 24670 | _x_x_mozilla_page_load_details 15:23:37 INFO - PROCESS | 24670 | |i|pagename|runs| 15:23:37 INFO - PROCESS | 24670 | |0;dojo.html;3302.1909632140128;3331.533585298059;3349.899503014907;3353.9329213415726;3361.865525378985;5361.222622719708;5392.110301800203;5436.891262174754;5439.755211015504;5463.808766693167;5406.54044406226;5424.538914192299;5429.782808687658;5431.34823821142;5454.263674403955;4972.825951091712;4988.551030407262;5058.696478211301;5077.060743762398;5115.693058416488;4865.927011094819;5019.397672279313;5033.144365457881;5033.723145227011;5094.337736094321;5058.038972595214;5080.59355251579;5110.463401342861;5119.12974794284;5130.256112863633;5038.596912247048;5042.571381432546;5048.141815891289;5059.620528460343;5082.3138876251605;4852.320675105488;4891.095147397743;4933.827316043921;4972.055309491185;4978.701277923336;5245.26566280721;5250.238715386286;5280.419153893069;5287.735613219324;5292.179712144623;5855.180274761537;5876.177335173036;5876.735546900357;5881.617694849821;5887.0286402743495;5688.744006519716;5855.355910849803;5861.589688721791;5906.350301466835;5917.8816423671715;5466.988607107698;5471.452854714536;5482.753276102585;5483.506484416422;5487.807926722586;5892.882142357214;5946.137810017523;5947.197128387699;5958.64248145104;5975.581709280395;5623.409541998031;5672.234248376416;5749.683767392834;5795.072788353843;5824.825255242349;5807.651540907559;5820.708964551755;5847.9415205848245;5852.912206316909;5868.38381969887;5689.6586204827845;5761.971190144022;5766.452187042224;5780.075187969905;5809.215755872903;5741.282339707536;5783.8554036149435;5789.565782566325;5851.093080572433;5886.94113058864;4441.533638967861;4446.021875187454;4460.553944605514;4479.70881892676;4494.887627809331;3957.742746721454;4032.6370626643743;4035.3745169498775;4037.3943908413385;4061.411095391152;5524;5566.081596536607;5570.944290557042;5605.887882242332;5640.633358831663;5833.445822646841;5954.225950626391;5956.255468066492;5958;5968.015277479168;5470.507654311131;5548.639338442988;5559.360673522597;5571.247881535941;5578.860528486739;5067.847964561069;5076.568491678175;5102.540771330598;5106.336176297132;5119.232115182753;6047.78832740852;6070.2108725865355;6073.696315184223;6081.148639190517;6084.0265557511475;5715.742791574472;5803.332616749128;5866.6186697864505;5884.794032208938;5959.314678811992;6013.488853447331;6020.668863212565;6026.668533230714;6030;6034.064719968412;5742.971285143548;5783.710814459176;5789.681567513827;5798.913016304675;5800.390958949419;5727.312722473163;5742.913856292243;5902.173695682522;5966.880662386815;5983.820485385445;5683.460071293221;5689.374168841507;5699.1451282306325;5707.743151558107;5712.400197979152;5564.666120032811;5631.971840140773;5635.759438322899;5685.744141513559;5699.116636921284;5551.111822108443;5552.389237183826;5579.218909352613;5663.57523185771;5682.119271512922;5647.858803529944;5686.943130568641;5693.060644993529;5707.400722924033;5720.856978575569;5465.562754979672;5519.448055194448;5535.501804837584;5549.889002220014;5571.08077167279 15:23:37 INFO - PROCESS | 24670 | |1;ext.html;476.69729721626777;555.1977392667595;556.2157358125045;596.3976383852311;606.4572207873953;31769.205769855766;40494.39258411123;40658.39012414816;40804.59195408045;40873.99999999996;43491.34762978558;43861.56138438622;44212.11575768491;44358.112837743225;44387.55612443874;8889.199972002518;9035.277177825757;9087.136722011399;9097;9126.954365228165;8902.73291801247;9039.683611073613;9077;9111.043340449256;9117.133872282122;9070.138336857988;9124.178823905848;9129;9151.267898568098;9184.58669359877;8995.100489951017;9090.863637045417;9114.043025482295;9131.315151363608;9138.177564019237;8931.19619234272;9068.138526839939;9089.181973622406;9106.317026222994;9118.772030699285;45017.549824501664;45032.54967450316;45475.54524454746;45480.545194547965;45495.09009819818;3677.154254521475;3713.8885833425043;3929.620526347339;4204.5375008749015;4374.868753937387;33835.492467613;33918;33922.151946201295;34080.147996300046;34666.82666586651;4317.7193482423545;4351.390805287262;4407.713498622579;4449.043455657017;4455.420795296591;293566;294642;295596;487576;492542;68537.65731171412;69073.65463172752;69451.65274173596;69499;69509.30490695129;73583.63208183924;73867.63066184742;73996.26003740002;74208.62895685487;74313.25686743172;17405.303787848345;17721.202545885466;17740.11299435023;17743.73384399235;17806.554836129202;13329.400176991865;13364.665883352995;13387;13395.732085358239;13398.531051413154;22450.214242501435;22540.887295563745;22760.31719048398;22772.20297289587;22774.544509109724;8611.440256383315;8674.175953284428;8711.695090671923;8890.86663700045;8916.242119419921;1085.7502774361783;1094.8138816401072;1137.090327737823;1189.238887112249;1200.789861774186;27670;27698.5845212322;27924.72075279262;27989.44021119607;28109.578356324673;1148.1561052626314;1178.3165763856941;1184.09416796151;1235.7713822942605;1268.7906495428335;15168.544943651708;15801.288941997638;15939;16063.437779677888;16397.180140992903;451250;502736;503894;504657;941262;57566.424335756106;58463.415365845794;58720.412795871496;58843.70578147082;59104.704476478204;1390.8539603341706;1476.5422718957157;1494.1632685696045;1506.0511877517094;1509.1624148597414;30578;31175.37649246957;31797.36405271928;32236.19409514781;33651.326973460884;52567.474325256255;52866;52980.20529692135;53038.46961530335;53068.469315306356;285956;287596;287902;288009;288362;35860.103497412776;36070.8196459016;36085.45871811872;36297.27405451823;36561;48515;48557.75721121372;48740.512594873595;48754.26868596903;49971;41055.178896422505;41718.37422438726;42184.36723449212;42206;42308.788456057526;41565.79217103895;42223.366649500895;42256;42262.57737422586;42383.36424953566;45787;46675.29987050265;46791.532084678714;47552.762236188595;47848.282275766585;39324.606753932094;40065.39901901532;40137.39793903035;40617.79691101644;40702.38946415865;27617.171484855488;28004.719952800213;28303.858480707466;28463.288417788892;28472.430551389272 15:23:37 INFO - PROCESS | 24670 | |2;jquery.html;372.0605471185257;374.71147216643203;377.92819364320775;382.867910570853;390.5411141908257;14257.029108018454;16226.432074877383;17228.3108675653;19385.515362115955;19414.029298535068;10929;11361.147913906449;11372.147088968319;16163.838361616381;16650.417235396762;5078.289039534468;5255.527002569768;5266.131088370415;5279.445658205891;5700.515456186208;5666.914996275059;5748.051571490699;5765.1928729977835;5771.336296325913;5777.59556831022;5215.973920130394;5407.459254074601;5409.188621706756;5419.701916394597;5643.379228284885;5339.06566350889;5353.9196912046355;5423.566114710814;5714.628549144292;5724.398938111522;5389.083855744533;5500.532454741352;5509.421510741355;5523.088690366085;5526.834194974157;12761.872381276162;13096.410661520255;13201.141925774795;13239.271840048794;13321.800172997413;2234.430220293831;2265.29775769512;2278.8605697151424;2335.7736691897258;2410.192585483865;10050.346727462764;10163.441010744406;11247.156463265288;13318.533851315158;13747.656308592264;1895.5829717462136;1947.6396866579728;1966.223341779989;2047.3017790141655;2053.1889903488186;58397.7080114601;59333.40666593365;59788.70105649487;59956;60284.698576507275;10704.678859634223;10856.620018299322;10883.074938630305;10991.450427478594;11000.944995274973;14451.421943122157;14476.34856431463;14498.275086245645;14517.419303227964;14561.708765824837;7945.920540794634;8110;8220.095789463154;8285.50286982783;8345.123762004901;7954.323882469939;8003.399745019147;8029.237222463857;8092.231238032377;8094.433389662667;4429.313456414261;4770.403699537558;4782.234842425195;4791.161546729309;4821.927671084936;1761.779777527809;1845.9907700461413;1860.57206842427;1914.6693048331554;1952.66804643211;463.55267167183155;1055.4089709762557;1084.5336505302637;1142.2689478733616;1179.7345597240724;10461.163106951577;10773.83839242412;11014.39420831846;11108.389038602954;11278.7180320491;468.8031026968681;475.39862074475815;477.5654154719258;486.25602827673714;499.9275105109739;5514.283143191359;5953.880922381528;6063.605865618809;6088.360722124113;6103.633781973096;645051;646498;652359;692657;696314;68669.31330686629;69729;76322;77839.22160778433;79340;1186.9228500147462;1211.0916812390708;1228.8648248692637;1239.69007748063;1249.3066348176667;15590.766138507704;15849.128297943724;15984;16209.756853647441;16327.836721633106;33450.330993380485;34176;35565.46651800173;35680.64319356773;35735.10662233465;41181.382279265235;42570.787146064074;43287.783561082;43658.34512482379;45546.54453455423;7371.48399612022;7708.576028318496;7749.147593764568;7757.68969241224;7854.450188486751;10537.367757934548;11314.886851131383;11505.57035541306;11791.587294444653;12076.335801531;9987.350822196535;10336.896631033593;10338.793224135325;10626.574937002433;10696.89303106959;10047.497625118862;10058.899411006088;10174.186065114922;10275.280730348804;10362.326448780805;9951.800963980824;10135;10476.580936762444;10520.263581549218;10706.839397409201;7287.1984081752025;7304.452166087671;7633.770986870402;7874.094479134973;7887.84224315522;9856.901430985885;10146.847797283195;10379.532921018723;10489.108425783894;10540 15:23:37 INFO - PROCESS | 24670 | |3;mootools.html;1488.9702205955882;1583.060750580539;1833.358324586394;1918.3189967561507;1959.0694420150421;7788.649510772015;8022.638981245844;8213.91786082139;8392.790180245496;8396.16038396161;8518.488890666564;8529.402941794076;8552.91447085529;8608;8636.352273579476;2432.4162201071704;2440.1825388494876;2440.7681270279386;2452.350127216289;2469.8518088914634;2357.281029286076;2368.348704106367;2384.833061685683;2385.42749740062;2392.4616961183683;2368.928932132039;2372.4543355028354;2383.9046438142454;2407.7592240775957;2431.5744744669614;2424.066734307287;2451.227863223097;2456.57010023247;2461.716902556211;2464;2384.8449850759644;2424.151546958568;2428.077330614355;2433.0997530913496;2433.8661373624445;8308;8335.916640833575;8372.372072094617;8396.580170991487;8419.45273557223;4989.351384320052;5102.081625307444;5114.897702045975;5118.718470484122;5183.922241166386;3189.4259033373983;3208.470602350609;3211.5985501812274;3265.9346813063607;3279.8360081995806;1052.5474046160148;1059.3432072115338;1097.8902109789037;1135.7558125003081;1159.2291126400933;11819;11827.881721182765;11899.821502677467;11929.94035029828;11947.283163010161;4285.721428107163;4326.762028088422;4364.083542456056;4413.3821265022925;4422.204003279377;9355.29835262358;9371.250299975985;9373.437593744397;9384;9418.29362797793;4974.328465657162;4982.950170498321;4994.450610432849;4996.7001979881325;5015.924761128513;4528.298113792367;4538.818447262139;4540.545945405499;4543.9776050389055;4551.4765801932535;3620.818959052037;3651.598324184338;3701.1487357907295;3705.295993761231;3718.3678774607843;1077.2997551591527;1092.6012005618052;1099.0767755085767;1099.543689368903;1103.7351035751362;1146.2835727670206;1152.5159433037977;1163.2962057954815;1192.505110379183;1211.6122840690894;7905.802354941173;7945.205479452008;7975.042994840656;7986.960065199637;8039.5176289422825;1216.0514798457218;1218.366449446283;1224.7917853964848;1231.7536492701495;1233.3648171191844;6204.81385558434;6206.472449841724;6271.122042913996;6285.057241413824;6311.211098612674;10077.748056298651;10445.373277603368;10491.370517768959;10500.264981451377;10523.84214236787;9519.143277104955;10371.63699270537;10381.532831022621;10457.895421045845;10510.054095131474;7847.803804904923;7880.448368614257;7945.64244608994;7967.760967170994;8007.079185893696;7735.922640773745;7789.4157938155995;7836.451448398558;7889.171636978264;7894.171112033154;8642.178992995656;8970.147835955573;8974.326925480746;9204.631814727336;9226.953865230631;8898.911010889808;8991.41555798871;9009.684661036832;9019;9053.502057386908;7113.146422429341;7187;7215.567065976058;7255;7256.673449694882;7529.322360987538;7620.504667196615;7627.961860190663;7658.808529786577;7705.422093343133;7289.4168466523615;7535.321821035914;7598.620068996639;7605.619719013916;7632.656530456032;6739.59562426256;6811.114555108003;7208.27917208275;7341.155767086853;7413.66638501258;7295.124585049828;7318.231585683639;7346.706131754884;7346.742863999734;7365.926340736738;6717.966410167918;6730.091437655854;6740;6748.527603067738;6780.627065511247;6680.365365290289;6711.664416779044;6744.325567443217;6747.730090796314;6879.965600171967 15:23:37 INFO - PROCESS | 24670 | |4;prototype.html;344.55724394153503;353.57394339820513;359.51645037424686;361.1747157744554;364.59165734377484;6209.596376235541;6371.299157092728;6387.457066149377;6399.488040956724;6430.035494675801;6204.255489341285;6279.15231443755;6303.716332765025;6304.432601065914;6339.334369891164;4826.9034619307595;4853.805847766085;4859.684120532172;4860.586850117745;4877.341558889558;4892.168331383673;4893;4895.5838753705975;4903;4908.484609116045;4753.572178503934;4832.1543729847135;4844.854654360375;4849.442314133867;4849.975750121244;4814.807407703687;4822.445418776851;4832.975835120802;4843.273508973647;4853.611711063142;4053.736507127057;4151.46031015969;4255.1064276501975;4259.552746961586;4262.637675797561;5877.206577112078;5957.344692083867;5972.283326000865;5976.342602313742;6001.339852616209;5664.235328230678;5673.120666296731;5674.177244299553;5680.829575112753;5692.146178073281;6654.48078253138;6675.6662166891465;6734.595924244561;6737.595744255312;6760.459163266927;4730.266808644631;4733.195356789354;4742.9525704742855;4753.263244197155;4757.666963312569;6971.6165610891385;6973.79078627642;6978.616176110312;6983.790486285419;6988.37104660583;4867.415910090812;4900.754962251873;4906.58294045003;4907.337509436252;4917.262410638433;4841.515848415131;4956.083124621957;4961.5534601886;4964.90070198594;4971.1549036663855;5664.68844213564;5670.376258611549;5677;5681;5689.6586204827845;6736.629485378351;6743.190817101881;6747.966260168668;6750.953602191668;6770.593764374054;1695.8440859679285;1714.7427885817228;1724.6895558799285;1727.1968534631458;1730.576008877808;1120.1318977792114;1137.38581166171;1145.1583086431467;1153.7923173828624;1160.5647882044234;6463.515236357292;6467.708953097122;6482.481401487869;6485.3514648534765;6487.318831522716;6933.37599616037;6937.098177236927;6985.26654701249;6987.231404545496;6987.231404545496;6349.46029587481;6396.744130234832;6432.356764323624;6437.581557198767;6468.708908099053;3649.2883887641656;3758.567764707094;3762.548494180716;3787.715921305913;3795.8671446499793;7060.682269297894;7118.074650295532;7228.96385518069;7276.818079548054;7313.780586582411;7138.393236574845;7174.210836807947;7187.496875218789;7217.170025447036;7252.093488313961;7043.894341584881;7205.639718013974;7239.31226533489;7258.491905566665;7284.417246620258;6989.720411183495;7003.124609423822;7056.470764692771;7057.576545407292;7058.082449281561;6849.486288528281;6857.7256909723055;6923.065386172802;6932.653367331714;6940.7917762467205;7109.75115870942;7220.89168662481;7235.457340699363;7235.565866048054;7277.59973201479;4932.506749325183;4933.112039832721;4933.1613625683;4942.3080768693135;4960.454350021422;6976.162860456778;6983.127109111361;7019.262977387505;7019.964900175466;7028.332308430691;6668.933310667026;6790.490713196431;6863.07348507965;6868;6871.622060786704;6847.726090956306;6852.5545839522265;6853.897191542231;6857.348551887562;6857.657117144223;6607.900881486686;6731.158605174353;6733.091032710718;6735.595864248161;6750;6861;6862.245153033262;6872.244053154049;6877.2091209509545;6877.724891004304;6672.199336079701;6693.732250709917;6696.1629796275465;6710.16122984627;6714.764983225564 15:23:37 INFO - PROCESS | 24670 | |5;yui.html;747.0848210941593;798.5607915646394;881.3081730841287;899.3389858454037;926.2034650200831;14198.787018194735;14292.356843942021;14383.64040898978;14401;14401.567952961403;13652.317384130778;13753.79369309461;13756.10585311954;13769.449222031131;13781.173129612205;744.7840126363349;756.6595032235489;898.3397203055749;908.3686837647821;912.589334799343;892.8392889279927;904.8371293167228;910.6903652758061;913.3743385780762;916.7753900294438;657.8848701477223;660.3858411677162;663.1213641924445;664.1167247560757;666.070831190489;655.0076633899646;661.6526323680058;664.51158398577;666.1007639686409;666.6633350158163;496.3596959921697;499.66772096555746;503.41100911933125;504.46526681717495;508.27063164358896;12441.937790311082;12483;12508.937455312756;12592.937035314857;12732.299723515296;13346.265955372548;13676;13683.609366076469;13934.442622295095;14040.789388159084;11059.557617695282;11131.833022504668;11243.887561124448;11410.315381077078;11473;3909.198614284065;3945.6251656092627;3958.0302825807576;3963.762174269524;3964.365701487748;53656.463435365535;54412.72793636007;54610.45389546093;55168.44831551673;55289.72355138198;10645.78708425827;10689.358638481715;10808.729781755519;11030;11086.556537738561;18369.173387197607;18433;18453.7231941521;18568.350107746162;18593.047729988157;7563.432742544332;7584.393248540104;7637.809054773675;7710.7686769397005;7806.804829879298;4319.8488052918;4339.913201736011;4375.860463734282;4376.671749618791;4379.321205213197;3131.3267647455905;3136.8431578421446;3145.402373549018;3154.526820976826;3158.431482333156;568.3378863623832;579.0445764488543;583.2825624481911;583.9503642190376;586.2525280267607;534.7967772246521;554.431707499816;580.7415700013538;652.6247407740568;743.5241445474901;8905.643774248958;9606.087421694929;9645.614175433044;9670.613175473043;9722.854157187649;530.5728888244922;562.7636392715069;711.8683043636944;731.8024133484035;744.9664765085585;4182.372644103409;4488.147252022105;4512.368268442355;4695.24876019842;4711.104890070944;56928.43071569314;56940.14589781156;57355.71322143362;57368.13947790786;57863.13205301924;51811;52205.21692174621;52576.474235257156;53033.734831326365;53072;48471.5152848467;48828.267575986385;49849.99999999927;50254.74872625613;51175.23237151446;8984.46093234408;9378.765530861783;9388.202002829836;9475.952620236854;9631;34245.657543425245;35738;36928.26143477062;37066.790565688876;37209.069773255884;48388.758056209495;48599.5140048595;48743.26885096797;48834.511654883;49304.01391972212;11937.641870743544;11994.700132496757;12038.939805300917;12044.277343359427;12099.697507562381;13141.145825521311;13425.530106446227;13578.86421135776;13629.318534073454;13845.930770346084;11673.883261167619;11898.107641927063;11956.043516518832;12107.636770896886;12610.36948152607;11907.285562866256;12055.984892648936;12404.56584019555;12786.61640150797;12863.421146048264;10560.524776385235;11534.192606517463;12138.332391718188;12323.075769317158;13015.544455944375;9731.708048758548;9908.702738917844;10177.592896284363;10321.845172322572;10353.119984801075;10039.339575012482;10381.53283102247;10444.947775261378;10733.624323148651;10806.783864322826 15:23:37 INFO - PROCESS | 24670 | __end_tp_report 15:23:37 INFO - PROCESS | 24670 | __start_cc_report 15:23:37 INFO - PROCESS | 24670 | _x_x_mozilla_cycle_collect,299 15:23:37 INFO - PROCESS | 24670 | __end_cc_report 15:23:37 INFO - PROCESS | 24670 | __startTimestamp1455751417196__endTimestamp 15:23:37 INFO - PROCESS | 24670 | 15:23:37 INFO - PROCESS | 24670 | ------- Summary: start ------- 15:23:37 INFO - PROCESS | 24670 | Number of tests: 6 15:23:37 INFO - PROCESS | 24670 | 15:23:37 INFO - PROCESS | 24670 | [#0] dojo.html Cycles:165 Average:5432.77 Median:5605.89 stddev:585.19 (10.4%) stddev-sans-first:562.61 15:23:37 INFO - PROCESS | 24670 | Values: 3302.2 3331.5 3349.9 3353.9 3361.9 5361.2 5392.1 5436.9 5439.8 5463.8 5406.5 5424.5 5429.8 5431.3 5454.3 4972.8 4988.6 5058.7 5077.1 5115.7 4865.9 5019.4 5033.1 5033.7 5094.3 5058.0 5080.6 5110.5 5119.1 5130.3 5038.6 5042.6 5048.1 5059.6 5082.3 4852.3 4891.1 4933.8 4972.1 4978.7 5245.3 5250.2 5280.4 5287.7 5292.2 5855.2 5876.2 5876.7 5881.6 5887.0 5688.7 5855.4 5861.6 5906.4 5917.9 5467.0 5471.5 5482.8 5483.5 5487.8 5892.9 5946.1 5947.2 5958.6 5975.6 5623.4 5672.2 5749.7 5795.1 5824.8 5807.7 5820.7 5847.9 5852.9 5868.4 5689.7 5762.0 5766.5 5780.1 5809.2 5741.3 5783.9 5789.6 5851.1 5886.9 4441.5 4446.0 4460.6 4479.7 4494.9 3957.7 4032.6 4035.4 4037.4 4061.4 5524.0 5566.1 5570.9 5605.9 5640.6 5833.4 5954.2 5956.3 5958.0 5968.0 5470.5 5548.6 5559.4 5571.2 5578.9 5067.8 5076.6 5102.5 5106.3 5119.2 6047.8 6070.2 6073.7 6081.1 6084.0 5715.7 5803.3 5866.6 5884.8 5959.3 6013.5 6020.7 6026.7 6030.0 6034.1 5743.0 5783.7 5789.7 5798.9 5800.4 5727.3 5742.9 5902.2 5966.9 5983.8 5683.5 5689.4 5699.1 5707.7 5712.4 5564.7 5632.0 5635.8 5685.7 5699.1 5551.1 5552.4 5579.2 5663.6 5682.1 5647.9 5686.9 5693.1 5707.4 5720.9 5465.6 5519.4 5535.5 5549.9 5571.1 15:23:37 INFO - PROCESS | 24670 | 15:23:37 INFO - PROCESS | 24670 | [#1] ext.html Cycles:180 Average:59410.41 Median:42346.08 stddev:119654.38 (282.6%) stddev-sans-first:119908.22 15:23:37 INFO - PROCESS | 24670 | Values: 476.7 555.2 556.2 596.4 606.5 31769.2 40494.4 40658.4 40804.6 40874.0 43491.3 43861.6 44212.1 44358.1 44387.6 8889.2 9035.3 9087.1 9097.0 9127.0 8902.7 9039.7 9077.0 9111.0 9117.1 9070.1 9124.2 9129.0 9151.3 9184.6 8995.1 9090.9 9114.0 9131.3 9138.2 8931.2 9068.1 9089.2 9106.3 9118.8 45017.5 45032.5 45475.5 45480.5 45495.1 3677.2 3713.9 3929.6 4204.5 4374.9 33835.5 33918.0 33922.2 34080.1 34666.8 4317.7 4351.4 4407.7 4449.0 4455.4 293566.0 294642.0 295596.0 487576.0 492542.0 68537.7 69073.7 69451.7 69499.0 69509.3 73583.6 73867.6 73996.3 74208.6 74313.3 17405.3 17721.2 17740.1 17743.7 17806.6 13329.4 13364.7 13387.0 13395.7 13398.5 22450.2 22540.9 22760.3 22772.2 22774.5 8611.4 8674.2 8711.7 8890.9 8916.2 1085.8 1094.8 1137.1 1189.2 1200.8 27670.0 27698.6 27924.7 27989.4 28109.6 1148.2 1178.3 1184.1 1235.8 1268.8 15168.5 15801.3 15939.0 16063.4 16397.2 451250.0 502736.0 503894.0 504657.0 941262.0 57566.4 58463.4 58720.4 58843.7 59104.7 1390.9 1476.5 1494.2 1506.1 1509.2 30578.0 31175.4 31797.4 32236.2 33651.3 52567.5 52866.0 52980.2 53038.5 53068.5 285956.0 287596.0 287902.0 288009.0 288362.0 35860.1 36070.8 36085.5 36297.3 36561.0 48515.0 48557.8 48740.5 48754.3 49971.0 41055.2 41718.4 42184.4 42206.0 42308.8 41565.8 42223.4 42256.0 42262.6 42383.4 45787.0 46675.3 46791.5 47552.8 47848.3 39324.6 40065.4 40137.4 40617.8 40702.4 27617.2 28004.7 28303.9 28463.3 28472.4 15:23:37 INFO - PROCESS | 24670 | 15:23:37 INFO - PROCESS | 24670 | [#2] jquery.html Cycles:180 Average:31054.19 Median:18053.58 stddev:108937.94 (603.4%) stddev-sans-first:109219.17 15:23:37 INFO - PROCESS | 24670 | Values: 372.1 374.7 377.9 382.9 390.5 14257.0 16226.4 17228.3 19385.5 19414.0 10929.0 11361.1 11372.1 16163.8 16650.4 5078.3 5255.5 5266.1 5279.4 5700.5 5666.9 5748.1 5765.2 5771.3 5777.6 5216.0 5407.5 5409.2 5419.7 5643.4 5339.1 5353.9 5423.6 5714.6 5724.4 5389.1 5500.5 5509.4 5523.1 5526.8 12761.9 13096.4 13201.1 13239.3 13321.8 2234.4 2265.3 2278.9 2335.8 2410.2 10050.3 10163.4 11247.2 13318.5 13747.7 1895.6 1947.6 1966.2 2047.3 2053.2 58397.7 59333.4 59788.7 59956.0 60284.7 10704.7 10856.6 10883.1 10991.5 11000.9 14451.4 14476.3 14498.3 14517.4 14561.7 7945.9 8110.0 8220.1 8285.5 8345.1 7954.3 8003.4 8029.2 8092.2 8094.4 4429.3 4770.4 4782.2 4791.2 4821.9 1761.8 1846.0 1860.6 1914.7 1952.7 463.6 1055.4 1084.5 1142.3 1179.7 10461.2 10773.8 11014.4 11108.4 11278.7 468.8 475.4 477.6 486.3 499.9 5514.3 5953.9 6063.6 6088.4 6103.6 645051.0 646498.0 652359.0 692657.0 696314.0 68669.3 69729.0 76322.0 77839.2 79340.0 1186.9 1211.1 1228.9 1239.7 1249.3 15590.8 15849.1 15984.0 16209.8 16327.8 33450.3 34176.0 35565.5 35680.6 35735.1 41181.4 42570.8 43287.8 43658.3 45546.5 7371.5 7708.6 7749.1 7757.7 7854.5 10537.4 11314.9 11505.6 11791.6 12076.3 9987.4 10336.9 10338.8 10626.6 10696.9 10047.5 10058.9 10174.2 10275.3 10362.3 9951.8 10135.0 10476.6 10520.3 10706.8 7287.2 7304.5 7633.8 7874.1 7887.8 9856.9 10146.8 10379.5 10489.1 10540.0 15:23:37 INFO - PROCESS | 24670 | 15:23:37 INFO - PROCESS | 24670 | [#3] mootools.html Cycles:180 Average:5823.63 Median:5108.49 stddev:3060.44 (59.9%) stddev-sans-first:3051.69 15:23:37 INFO - PROCESS | 24670 | Values: 1489.0 1583.1 1833.4 1918.3 1959.1 7788.6 8022.6 8213.9 8392.8 8396.2 8518.5 8529.4 8552.9 8608.0 8636.4 2432.4 2440.2 2440.8 2452.4 2469.9 2357.3 2368.3 2384.8 2385.4 2392.5 2368.9 2372.5 2383.9 2407.8 2431.6 2424.1 2451.2 2456.6 2461.7 2464.0 2384.8 2424.2 2428.1 2433.1 2433.9 8308.0 8335.9 8372.4 8396.6 8419.5 4989.4 5102.1 5114.9 5118.7 5183.9 3189.4 3208.5 3211.6 3265.9 3279.8 1052.5 1059.3 1097.9 1135.8 1159.2 11819.0 11827.9 11899.8 11929.9 11947.3 4285.7 4326.8 4364.1 4413.4 4422.2 9355.3 9371.3 9373.4 9384.0 9418.3 4974.3 4983.0 4994.5 4996.7 5015.9 4528.3 4538.8 4540.5 4544.0 4551.5 3620.8 3651.6 3701.1 3705.3 3718.4 1077.3 1092.6 1099.1 1099.5 1103.7 1146.3 1152.5 1163.3 1192.5 1211.6 7905.8 7945.2 7975.0 7987.0 8039.5 1216.1 1218.4 1224.8 1231.8 1233.4 6204.8 6206.5 6271.1 6285.1 6311.2 10077.7 10445.4 10491.4 10500.3 10523.8 9519.1 10371.6 10381.5 10457.9 10510.1 7847.8 7880.4 7945.6 7967.8 8007.1 7735.9 7789.4 7836.5 7889.2 7894.2 8642.2 8970.1 8974.3 9204.6 9227.0 8898.9 8991.4 9009.7 9019.0 9053.5 7113.1 7187.0 7215.6 7255.0 7256.7 7529.3 7620.5 7628.0 7658.8 7705.4 7289.4 7535.3 7598.6 7605.6 7632.7 6739.6 6811.1 7208.3 7341.2 7413.7 7295.1 7318.2 7346.7 7346.7 7365.9 6718.0 6730.1 6740.0 6748.5 6780.6 6680.4 6711.7 6744.3 6747.7 6880.0 15:23:37 INFO - PROCESS | 24670 | 15:23:37 INFO - PROCESS | 24670 | [#4] prototype.html Cycles:180 Average:5668.35 Median:6414.76 stddev:1705.15 (26.6%) stddev-sans-first:1662.45 15:23:37 INFO - PROCESS | 24670 | Values: 344.6 353.6 359.5 361.2 364.6 6209.6 6371.3 6387.5 6399.5 6430.0 6204.3 6279.2 6303.7 6304.4 6339.3 4826.9 4853.8 4859.7 4860.6 4877.3 4892.2 4893.0 4895.6 4903.0 4908.5 4753.6 4832.2 4844.9 4849.4 4850.0 4814.8 4822.4 4833.0 4843.3 4853.6 4053.7 4151.5 4255.1 4259.6 4262.6 5877.2 5957.3 5972.3 5976.3 6001.3 5664.2 5673.1 5674.2 5680.8 5692.1 6654.5 6675.7 6734.6 6737.6 6760.5 4730.3 4733.2 4743.0 4753.3 4757.7 6971.6 6973.8 6978.6 6983.8 6988.4 4867.4 4900.8 4906.6 4907.3 4917.3 4841.5 4956.1 4961.6 4964.9 4971.2 5664.7 5670.4 5677.0 5681.0 5689.7 6736.6 6743.2 6748.0 6751.0 6770.6 1695.8 1714.7 1724.7 1727.2 1730.6 1120.1 1137.4 1145.2 1153.8 1160.6 6463.5 6467.7 6482.5 6485.4 6487.3 6933.4 6937.1 6985.3 6987.2 6987.2 6349.5 6396.7 6432.4 6437.6 6468.7 3649.3 3758.6 3762.5 3787.7 3795.9 7060.7 7118.1 7229.0 7276.8 7313.8 7138.4 7174.2 7187.5 7217.2 7252.1 7043.9 7205.6 7239.3 7258.5 7284.4 6989.7 7003.1 7056.5 7057.6 7058.1 6849.5 6857.7 6923.1 6932.7 6940.8 7109.8 7220.9 7235.5 7235.6 7277.6 4932.5 4933.1 4933.2 4942.3 4960.5 6976.2 6983.1 7019.3 7020.0 7028.3 6668.9 6790.5 6863.1 6868.0 6871.6 6847.7 6852.6 6853.9 6857.3 6857.7 6607.9 6731.2 6733.1 6735.6 6750.0 6861.0 6862.2 6872.2 6877.2 6877.7 6672.2 6693.7 6696.2 6710.2 6714.8 15:23:37 INFO - PROCESS | 24670 | 15:23:37 INFO - PROCESS | 24670 | [#5] yui.html Cycles:180 Average:14595.48 Median:4603.81 stddev:16829.41 (365.6%) stddev-sans-first:16844.49 15:23:37 INFO - PROCESS | 24670 | Values: 747.1 798.6 881.3 899.3 926.2 14198.8 14292.4 14383.6 14401.0 14401.6 13652.3 13753.8 13756.1 13769.4 13781.2 744.8 756.7 898.3 908.4 912.6 892.8 904.8 910.7 913.4 916.8 657.9 660.4 663.1 664.1 666.1 655.0 661.7 664.5 666.1 666.7 496.4 499.7 503.4 504.5 508.3 12441.9 12483.0 12508.9 12592.9 12732.3 13346.3 13676.0 13683.6 13934.4 14040.8 11059.6 11131.8 11243.9 11410.3 11473.0 3909.2 3945.6 3958.0 3963.8 3964.4 53656.5 54412.7 54610.5 55168.4 55289.7 10645.8 10689.4 10808.7 11030.0 11086.6 18369.2 18433.0 18453.7 18568.4 18593.0 7563.4 7584.4 7637.8 7710.8 7806.8 4319.8 4339.9 4375.9 4376.7 4379.3 3131.3 3136.8 3145.4 3154.5 3158.4 568.3 579.0 583.3 584.0 586.3 534.8 554.4 580.7 652.6 743.5 8905.6 9606.1 9645.6 9670.6 9722.9 530.6 562.8 711.9 731.8 745.0 4182.4 4488.1 4512.4 4695.2 4711.1 56928.4 56940.1 57355.7 57368.1 57863.1 51811.0 52205.2 52576.5 53033.7 53072.0 48471.5 48828.3 49850.0 50254.7 51175.2 8984.5 9378.8 9388.2 9476.0 9631.0 34245.7 35738.0 36928.3 37066.8 37209.1 48388.8 48599.5 48743.3 48834.5 49304.0 11937.6 11994.7 12038.9 12044.3 12099.7 13141.1 13425.5 13578.9 13629.3 13845.9 11673.9 11898.1 11956.0 12107.6 12610.4 11907.3 12056.0 12404.6 12786.6 12863.4 10560.5 11534.2 12138.3 12323.1 13015.5 9731.7 9908.7 10177.6 10321.8 10353.1 10039.3 10381.5 10444.9 10733.6 10806.8 15:23:37 INFO - PROCESS | 24670 | -------- Summary: end -------- 15:23:37 INFO - PROCESS | 24670 | 15:23:37 INFO - TEST-INFO | 24670: exit 0 15:23:37 INFO - TEST-OK | dromaeo_css | took 1108201ms 15:23:37 INFO - TEST-START | kraken 15:23:37 INFO - operating with platform_type : linux_ 15:23:37 INFO - Initialising browser for kraken test... 15:23:37 INFO - TEST-INFO | started process 24915 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIa0iK7/profile http://localhost:51624/getInfo.html) 15:23:41 INFO - PROCESS | 24915 | 15:23:41 INFO - PROCESS | 24915 | (process:24992): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:23:42 INFO - PROCESS | 24915 | __metrics Screen width/height:1600/1200 15:23:42 INFO - PROCESS | 24915 | colorDepth:24 15:23:42 INFO - PROCESS | 24915 | Browser inner width/height: 1024/697 15:23:42 INFO - PROCESS | 24915 | __metrics 15:23:43 INFO - TEST-INFO | 24915: exit 0 15:23:43 INFO - Browser initialized. 15:23:43 INFO - Running cycle 1/1 for kraken test... 15:23:43 INFO - TEST-INFO | started process 25041 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIa0iK7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:23:44 INFO - PROCESS | 25041 | 15:23:44 INFO - PROCESS | 25041 | (process:25103): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:23:55 INFO - PROCESS | 25041 | RSS: Main: 141410304 15:23:55 INFO - PROCESS | 25041 | 15:23:57 INFO - PROCESS | 25041 | Cycle 1(1): loaded http://localhost:51624/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51624/tests/kraken/driver.html?testName=audio-beat-detection) 15:23:58 INFO - PROCESS | 25041 | RSS: Main: 146214912 15:23:58 INFO - PROCESS | 25041 | 15:24:00 INFO - PROCESS | 25041 | Cycle 1(1): loaded http://localhost:51624/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51624/tests/kraken/driver.html?testName=audio-dft) 15:24:01 INFO - PROCESS | 25041 | RSS: Main: 146022400 15:24:01 INFO - PROCESS | 25041 | 15:24:04 INFO - PROCESS | 25041 | Cycle 1(1): loaded http://localhost:51624/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51624/tests/kraken/driver.html?testName=audio-fft) 15:24:04 INFO - PROCESS | 25041 | RSS: Main: 146026496 15:24:04 INFO - PROCESS | 25041 | 15:24:06 INFO - PROCESS | 25041 | Cycle 1(1): loaded http://localhost:51624/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51624/tests/kraken/driver.html?testName=audio-oscillator) 15:24:07 INFO - PROCESS | 25041 | RSS: Main: 145203200 15:24:07 INFO - PROCESS | 25041 | 15:24:09 INFO - PROCESS | 25041 | Cycle 1(1): loaded http://localhost:51624/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51624/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:24:10 INFO - PROCESS | 25041 | RSS: Main: 145096704 15:24:10 INFO - PROCESS | 25041 | 15:24:13 INFO - PROCESS | 25041 | Cycle 1(1): loaded http://localhost:51624/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51624/tests/kraken/driver.html?testName=imaging-darkroom) 15:24:13 INFO - PROCESS | 25041 | RSS: Main: 147189760 15:24:13 INFO - PROCESS | 25041 | 15:24:17 INFO - PROCESS | 25041 | Cycle 1(1): loaded http://localhost:51624/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51624/tests/kraken/driver.html?testName=imaging-desaturate) 15:24:17 INFO - PROCESS | 25041 | RSS: Main: 147820544 15:24:17 INFO - PROCESS | 25041 | 15:24:20 INFO - PROCESS | 25041 | Cycle 1(1): loaded http://localhost:51624/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51624/tests/kraken/driver.html?testName=json-parse-financial) 15:24:21 INFO - PROCESS | 25041 | RSS: Main: 144977920 15:24:21 INFO - PROCESS | 25041 | 15:24:22 INFO - PROCESS | 25041 | Cycle 1(1): loaded http://localhost:51624/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51624/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:24:23 INFO - PROCESS | 25041 | RSS: Main: 145989632 15:24:23 INFO - PROCESS | 25041 | 15:24:24 INFO - PROCESS | 25041 | Cycle 1(1): loaded http://localhost:51624/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51624/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:24:25 INFO - PROCESS | 25041 | RSS: Main: 146976768 15:24:25 INFO - PROCESS | 25041 | 15:24:27 INFO - PROCESS | 25041 | Cycle 1(1): loaded http://localhost:51624/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51624/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:24:28 INFO - PROCESS | 25041 | RSS: Main: 147451904 15:24:28 INFO - PROCESS | 25041 | 15:24:30 INFO - PROCESS | 25041 | Cycle 1(1): loaded http://localhost:51624/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51624/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:24:31 INFO - PROCESS | 25041 | RSS: Main: 146743296 15:24:31 INFO - PROCESS | 25041 | 15:24:33 INFO - PROCESS | 25041 | Cycle 1(1): loaded http://localhost:51624/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51624/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:24:34 INFO - PROCESS | 25041 | RSS: Main: 146644992 15:24:34 INFO - PROCESS | 25041 | 15:24:35 INFO - PROCESS | 25041 | Cycle 1(1): loaded http://localhost:51624/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51624/tests/kraken/driver.html?testName=ai-astar) 15:24:36 INFO - PROCESS | 25041 | RSS: Main: 147881984 15:24:36 INFO - PROCESS | 25041 | 15:24:36 INFO - PROCESS | 25041 | __start_tp_report 15:24:36 INFO - PROCESS | 25041 | _x_x_mozilla_page_load 15:24:36 INFO - PROCESS | 25041 | _x_x_mozilla_page_load_details 15:24:36 INFO - PROCESS | 25041 | |i|pagename|runs| 15:24:36 INFO - PROCESS | 25041 | |0;ai-astar;112;105;109;111;112;121;110;114;111;111 15:24:36 INFO - PROCESS | 25041 | |1;audio-beat-detection;157;129;159;165;129;151;153;128;161;128 15:24:36 INFO - PROCESS | 25041 | |2;audio-dft;162;162;162;163;162;161;162;163;165;162 15:24:36 INFO - PROCESS | 25041 | |3;audio-fft;76;75;76;165;73;73;75;73;170;76 15:24:36 INFO - PROCESS | 25041 | |4;audio-oscillator;96;96;140;95;95;95;138;95;96;135 15:24:36 INFO - PROCESS | 25041 | |5;imaging-gaussian-blur;110;110;110;109;110;110;110;109;110;110 15:24:36 INFO - PROCESS | 25041 | |6;imaging-darkroom;148;147;147;147;148;148;147;147;147;146 15:24:36 INFO - PROCESS | 25041 | |7;imaging-desaturate;96;96;97;96;97;97;97;96;98;97 15:24:36 INFO - PROCESS | 25041 | |8;json-parse-financial;58;59;56;55;60;55;55;54;54;53 15:24:36 INFO - PROCESS | 25041 | |9;json-stringify-tinderbox;65;64;64;65;64;65;65;65;65;65 15:24:36 INFO - PROCESS | 25041 | |10;stanford-crypto-aes;81;83;83;89;82;85;84;82;91;83 15:24:36 INFO - PROCESS | 25041 | |11;stanford-crypto-ccm;111;116;109;121;118;112;115;112;121;122 15:24:36 INFO - PROCESS | 25041 | |12;stanford-crypto-pbkdf2;150;148;140;140;139;147;139;141;152;137 15:24:36 INFO - PROCESS | 25041 | |13;stanford-crypto-sha256-iterative;65;67;65;68;66;69;65;65;66;66 15:24:36 INFO - PROCESS | 25041 | __end_tp_report 15:24:36 INFO - PROCESS | 25041 | __start_cc_report 15:24:36 INFO - PROCESS | 25041 | _x_x_mozilla_cycle_collect,723 15:24:36 INFO - PROCESS | 25041 | __end_cc_report 15:24:36 INFO - PROCESS | 25041 | __startTimestamp1455751476098__endTimestamp 15:24:36 INFO - PROCESS | 25041 | 15:24:36 INFO - PROCESS | 25041 | ------- Summary: start ------- 15:24:36 INFO - PROCESS | 25041 | Number of tests: 14 15:24:36 INFO - PROCESS | 25041 | 15:24:36 INFO - PROCESS | 25041 | [#0] ai-astar Cycles:10 Average:111.60 Median:111.50 stddev:4.06 (3.6%) stddev-sans-first:4.30 15:24:36 INFO - PROCESS | 25041 | Values: 112.0 105.0 109.0 111.0 112.0 121.0 110.0 114.0 111.0 111.0 15:24:36 INFO - PROCESS | 25041 | 15:24:36 INFO - PROCESS | 25041 | [#1] audio-beat-detection Cycles:10 Average:146.00 Median:155.00 stddev:15.55 (10.0%) stddev-sans-first:15.97 15:24:36 INFO - PROCESS | 25041 | Values: 157.0 129.0 159.0 165.0 129.0 151.0 153.0 128.0 161.0 128.0 15:24:36 INFO - PROCESS | 25041 | 15:24:36 INFO - PROCESS | 25041 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 15:24:36 INFO - PROCESS | 25041 | Values: 162.0 162.0 162.0 163.0 162.0 161.0 162.0 163.0 165.0 162.0 15:24:36 INFO - PROCESS | 25041 | 15:24:36 INFO - PROCESS | 25041 | [#3] audio-fft Cycles:10 Average:93.20 Median:75.00 stddev:39.20 (52.3%) stddev-sans-first:41.08 15:24:36 INFO - PROCESS | 25041 | Values: 76.0 75.0 76.0 165.0 73.0 73.0 75.0 73.0 170.0 76.0 15:24:36 INFO - PROCESS | 25041 | 15:24:36 INFO - PROCESS | 25041 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:95.00 stddev:20.44 (21.5%) stddev-sans-first:21.21 15:24:36 INFO - PROCESS | 25041 | Values: 96.0 96.0 140.0 95.0 95.0 95.0 138.0 95.0 96.0 135.0 15:24:36 INFO - PROCESS | 25041 | 15:24:36 INFO - PROCESS | 25041 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:24:36 INFO - PROCESS | 25041 | Values: 110.0 110.0 110.0 109.0 110.0 110.0 110.0 109.0 110.0 110.0 15:24:36 INFO - PROCESS | 25041 | 15:24:36 INFO - PROCESS | 25041 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 15:24:36 INFO - PROCESS | 25041 | Values: 148.0 147.0 147.0 147.0 148.0 148.0 147.0 147.0 147.0 146.0 15:24:36 INFO - PROCESS | 25041 | 15:24:36 INFO - PROCESS | 25041 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 15:24:36 INFO - PROCESS | 25041 | Values: 96.0 96.0 97.0 96.0 97.0 97.0 97.0 96.0 98.0 97.0 15:24:36 INFO - PROCESS | 25041 | 15:24:36 INFO - PROCESS | 25041 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:55.50 stddev:2.33 (4.2%) stddev-sans-first:2.35 15:24:36 INFO - PROCESS | 25041 | Values: 58.0 59.0 56.0 55.0 60.0 55.0 55.0 54.0 54.0 53.0 15:24:36 INFO - PROCESS | 25041 | 15:24:36 INFO - PROCESS | 25041 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 15:24:36 INFO - PROCESS | 25041 | Values: 65.0 64.0 64.0 65.0 64.0 65.0 65.0 65.0 65.0 65.0 15:24:36 INFO - PROCESS | 25041 | 15:24:36 INFO - PROCESS | 25041 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.50 stddev:3.23 (3.9%) stddev-sans-first:3.20 15:24:36 INFO - PROCESS | 25041 | Values: 81.0 83.0 83.0 89.0 82.0 85.0 84.0 82.0 91.0 83.0 15:24:36 INFO - PROCESS | 25041 | 15:24:36 INFO - PROCESS | 25041 | [#11] stanford-crypto-ccm Cycles:10 Average:115.70 Median:117.00 stddev:4.67 (4.0%) stddev-sans-first:4.63 15:24:36 INFO - PROCESS | 25041 | Values: 111.0 116.0 109.0 121.0 118.0 112.0 115.0 112.0 121.0 122.0 15:24:36 INFO - PROCESS | 25041 | 15:24:36 INFO - PROCESS | 25041 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.30 Median:144.00 stddev:5.38 (3.7%) stddev-sans-first:5.13 15:24:36 INFO - PROCESS | 25041 | Values: 150.0 148.0 140.0 140.0 139.0 147.0 139.0 141.0 152.0 137.0 15:24:36 INFO - PROCESS | 25041 | 15:24:36 INFO - PROCESS | 25041 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:1.40 (2.1%) stddev-sans-first:1.41 15:24:36 INFO - PROCESS | 25041 | Values: 65.0 67.0 65.0 68.0 66.0 69.0 65.0 65.0 66.0 66.0 15:24:36 INFO - PROCESS | 25041 | -------- Summary: end -------- 15:24:36 INFO - PROCESS | 25041 | 15:24:36 INFO - TEST-INFO | 25041: exit 0 15:24:37 INFO - TEST-OK | kraken | took 59223ms 15:24:37 INFO - TEST-START | v8_7 15:24:37 INFO - operating with platform_type : linux_ 15:24:37 INFO - Initialising browser for v8_7 test... 15:24:37 INFO - TEST-INFO | started process 25331 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5nY0aT/profile http://localhost:51624/getInfo.html) 15:24:40 INFO - PROCESS | 25331 | 15:24:40 INFO - PROCESS | 25331 | (process:25409): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:24:41 INFO - PROCESS | 25331 | __metrics Screen width/height:1600/1200 15:24:41 INFO - PROCESS | 25331 | colorDepth:24 15:24:41 INFO - PROCESS | 25331 | Browser inner width/height: 1024/697 15:24:41 INFO - PROCESS | 25331 | __metrics 15:24:42 INFO - TEST-INFO | 25331: exit 0 15:24:42 INFO - Browser initialized. 15:24:42 INFO - Running cycle 1/1 for v8_7 test... 15:24:42 INFO - TEST-INFO | started process 25458 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5nY0aT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:24:43 INFO - PROCESS | 25458 | 15:24:43 INFO - PROCESS | 25458 | (process:25519): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:24:53 INFO - PROCESS | 25458 | RSS: Main: 141320192 15:24:53 INFO - PROCESS | 25458 | 15:25:16 INFO - PROCESS | 25458 | Cycle 1(1): loaded http://localhost:51624/tests/v8_7/run.html (next: http://localhost:51624/tests/v8_7/run.html) 15:25:16 INFO - PROCESS | 25458 | RSS: Main: 145121280 15:25:16 INFO - PROCESS | 25458 | 15:25:16 INFO - PROCESS | 25458 | __start_tp_report 15:25:16 INFO - PROCESS | 25458 | _x_x_mozilla_page_load 15:25:16 INFO - PROCESS | 25458 | _x_x_mozilla_page_load_details 15:25:16 INFO - PROCESS | 25458 | |i|pagename|runs| 15:25:16 INFO - PROCESS | 25458 | |0;Richards;167.22408026755852 15:25:16 INFO - PROCESS | 25458 | |1;DeltaBlue;170.1837985023826 15:25:16 INFO - PROCESS | 25458 | |2;Encrypt;279.9552071668533 15:25:16 INFO - PROCESS | 25458 | |3;Decrypt;5229.166666666667 15:25:16 INFO - PROCESS | 25458 | |4;RayTrace;934.5794392523364 15:25:16 INFO - PROCESS | 25458 | |5;Earley;566.8934240362812 15:25:16 INFO - PROCESS | 25458 | |6;Boyer;11122.222222222223 15:25:16 INFO - PROCESS | 25458 | |7;RegExp;38980.769230769234 15:25:16 INFO - PROCESS | 25458 | |8;Splay;509.683995922528 15:25:16 INFO - PROCESS | 25458 | |9;NavierStokes;4835.748792270531 15:25:16 INFO - PROCESS | 25458 | __end_tp_report 15:25:16 INFO - PROCESS | 25458 | __startTimestamp1455751516582__endTimestamp 15:25:16 INFO - PROCESS | 25458 | 15:25:16 INFO - PROCESS | 25458 | ------- Summary: start ------- 15:25:16 INFO - PROCESS | 25458 | Number of tests: 10 15:25:16 INFO - PROCESS | 25458 | 15:25:16 INFO - PROCESS | 25458 | [#0] Richards Cycles:1 Average:167.22 Median:167.22 stddev:0.00 (0.0%) 15:25:16 INFO - PROCESS | 25458 | Values: 167.2 15:25:16 INFO - PROCESS | 25458 | 15:25:16 INFO - PROCESS | 25458 | [#1] DeltaBlue Cycles:1 Average:170.18 Median:170.18 stddev:0.00 (0.0%) 15:25:16 INFO - PROCESS | 25458 | Values: 170.2 15:25:16 INFO - PROCESS | 25458 | 15:25:16 INFO - PROCESS | 25458 | [#2] Encrypt Cycles:1 Average:279.96 Median:279.96 stddev:0.00 (0.0%) 15:25:16 INFO - PROCESS | 25458 | Values: 280.0 15:25:16 INFO - PROCESS | 25458 | 15:25:16 INFO - PROCESS | 25458 | [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 15:25:16 INFO - PROCESS | 25458 | Values: 5229.2 15:25:16 INFO - PROCESS | 25458 | 15:25:16 INFO - PROCESS | 25458 | [#4] RayTrace Cycles:1 Average:934.58 Median:934.58 stddev:0.00 (0.0%) 15:25:16 INFO - PROCESS | 25458 | Values: 934.6 15:25:16 INFO - PROCESS | 25458 | 15:25:16 INFO - PROCESS | 25458 | [#5] Earley Cycles:1 Average:566.89 Median:566.89 stddev:0.00 (0.0%) 15:25:16 INFO - PROCESS | 25458 | Values: 566.9 15:25:16 INFO - PROCESS | 25458 | 15:25:16 INFO - PROCESS | 25458 | [#6] Boyer Cycles:1 Average:11122.22 Median:11122.22 stddev:0.00 (0.0%) 15:25:16 INFO - PROCESS | 25458 | Values: 11122.2 15:25:16 INFO - PROCESS | 25458 | 15:25:16 INFO - PROCESS | 25458 | [#7] RegExp Cycles:1 Average:38980.77 Median:38980.77 stddev:0.00 (0.0%) 15:25:16 INFO - PROCESS | 25458 | Values: 38980.8 15:25:16 INFO - PROCESS | 25458 | 15:25:16 INFO - PROCESS | 25458 | [#8] Splay Cycles:1 Average:509.68 Median:509.68 stddev:0.00 (0.0%) 15:25:16 INFO - PROCESS | 25458 | Values: 509.7 15:25:16 INFO - PROCESS | 25458 | 15:25:16 INFO - PROCESS | 25458 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 15:25:16 INFO - PROCESS | 25458 | Values: 4835.7 15:25:16 INFO - PROCESS | 25458 | -------- Summary: end -------- 15:25:16 INFO - PROCESS | 25458 | 15:25:17 INFO - TEST-INFO | 25458: exit 0 15:25:17 INFO - TEST-OK | v8_7 | took 40373ms 15:25:17 INFO - SUITE-END | took 1207s 15:25:17 INFO - Completed test suite (00:20:07) 15:25:17 INFO - Working with test: dromaeo_css 15:25:17 INFO - Generating results file: dromaeo_css 15:25:17 INFO - Working with test: kraken 15:25:17 INFO - Generating results file: kraken 15:25:17 INFO - javascript benchmark 15:25:17 INFO - Working with test: v8_7 15:25:17 INFO - Generating results file: v8_7 15:25:17 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:25:17 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 15:25:17 INFO - process_Request line: dromaeo_css 7252.61 graph.html#tests=[[72,52,43]] 15:25:17 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:25:17 INFO - process_Request line: kraken 1505.10 graph.html#tests=[[232,52,43]] 15:25:17 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:25:17 INFO - process_Request line: v8_7 22016.38 graph.html#tests=[[230,52,43]] 15:25:17 INFO - RETURN: dromaeo_css: 7252.61 15:25:17 INFO - RETURN: kraken: 1505.10 15:25:17 INFO - RETURN: v8_7: 22016.38 15:25:17 INFO - javascript benchmark 15:25:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3302.1909632140128, 3331.533585298059, 3349.899503014907, 3353.9329213415726, 3361.865525378985, 5361.222622719708, 5392.110301800203, 5436.891262174754, 5439.755211015504, 5463.808766693167, 5406.54044406226, 5424.538914192299, 5429.782808687658, 5431.34823821142, 5454.263674403955, 4972.825951091712, 4988.551030407262, 5058.696478211301, 5077.060743762398, 5115.693058416488, 4865.927011094819, 5019.397672279313, 5033.144365457881, 5033.723145227011, 5094.337736094321, 5058.038972595214, 5080.59355251579, 5110.463401342861, 5119.12974794284, 5130.256112863633, 5038.596912247048, 5042.571381432546, 5048.141815891289, 5059.620528460343, 5082.3138876251605, 4852.320675105488, 4891.095147397743, 4933.827316043921, 4972.055309491185, 4978.701277923336, 5245.26566280721, 5250.238715386286, 5280.419153893069, 5287.735613219324, 5292.179712144623, 5855.180274761537, 5876.177335173036, 5876.735546900357, 5881.617694849821, 5887.0286402743495, 5688.744006519716, 5855.355910849803, 5861.589688721791, 5906.350301466835, 5917.8816423671715, 5466.988607107698, 5471.452854714536, 5482.753276102585, 5483.506484416422, 5487.807926722586, 5892.882142357214, 5946.137810017523, 5947.197128387699, 5958.64248145104, 5975.581709280395, 5623.409541998031, 5672.234248376416, 5749.683767392834, 5795.072788353843, 5824.825255242349, 5807.651540907559, 5820.708964551755, 5847.9415205848245, 5852.912206316909, 5868.38381969887, 5689.6586204827845, 5761.971190144022, 5766.452187042224, 5780.075187969905, 5809.215755872903, 5741.282339707536, 5783.8554036149435, 5789.565782566325, 5851.093080572433, 5886.94113058864, 4441.533638967861, 4446.021875187454, 4460.553944605514, 4479.70881892676, 4494.887627809331, 3957.742746721454, 4032.6370626643743, 4035.3745169498775, 4037.3943908413385, 4061.411095391152, 5524.0, 5566.081596536607, 5570.944290557042, 5605.887882242332, 5640.633358831663, 5833.445822646841, 5954.225950626391, 5956.255468066492, 5958.0, 5968.015277479168, 5470.507654311131, 5548.639338442988, 5559.360673522597, 5571.247881535941, 5578.860528486739, 5067.847964561069, 5076.568491678175, 5102.540771330598, 5106.336176297132, 5119.232115182753, 6047.78832740852, 6070.2108725865355, 6073.696315184223, 6081.148639190517, 6084.0265557511475, 5715.742791574472, 5803.332616749128, 5866.6186697864505, 5884.794032208938, 5959.314678811992, 6013.488853447331, 6020.668863212565, 6026.668533230714, 6030.0, 6034.064719968412, 5742.971285143548, 5783.710814459176, 5789.681567513827, 5798.913016304675, 5800.390958949419, 5727.312722473163, 5742.913856292243, 5902.173695682522, 5966.880662386815, 5983.820485385445, 5683.460071293221, 5689.374168841507, 5699.1451282306325, 5707.743151558107, 5712.400197979152, 5564.666120032811, 5631.971840140773, 5635.759438322899, 5685.744141513559, 5699.116636921284, 5551.111822108443, 5552.389237183826, 5579.218909352613, 5663.57523185771, 5682.119271512922, 5647.858803529944, 5686.943130568641, 5693.060644993529, 5707.400722924033, 5720.856978575569, 5465.562754979672, 5519.448055194448, 5535.501804837584, 5549.889002220014, 5571.08077167279], "unit": "score", "name": "dojo.html", "value": 5396.033206952814}, {"lowerIsBetter": false, "replicates": [476.69729721626777, 555.1977392667595, 556.2157358125045, 596.3976383852311, 606.4572207873953, 31769.205769855766, 40494.39258411123, 40658.39012414816, 40804.59195408045, 40873.99999999996, 43491.34762978558, 43861.56138438622, 44212.11575768491, 44358.112837743225, 44387.55612443874, 8889.199972002518, 9035.277177825757, 9087.136722011399, 9097.0, 9126.954365228165, 8902.73291801247, 9039.683611073613, 9077.0, 9111.043340449256, 9117.133872282122, 9070.138336857988, 9124.178823905848, 9129.0, 9151.267898568098, 9184.58669359877, 8995.100489951017, 9090.863637045417, 9114.043025482295, 9131.315151363608, 9138.177564019237, 8931.19619234272, 9068.138526839939, 9089.181973622406, 9106.317026222994, 9118.772030699285, 45017.549824501664, 45032.54967450316, 45475.54524454746, 45480.545194547965, 45495.09009819818, 3677.154254521475, 3713.8885833425043, 3929.620526347339, 4204.5375008749015, 4374.868753937387, 33835.492467613, 33918.0, 33922.151946201295, 34080.147996300046, 34666.82666586651, 4317.7193482423545, 4351.390805287262, 4407.713498622579, 4449.043455657017, 4455.420795296591, 293566.0, 294642.0, 295596.0, 487576.0, 492542.0, 68537.65731171412, 69073.65463172752, 69451.65274173596, 69499.0, 69509.30490695129, 73583.63208183924, 73867.63066184742, 73996.26003740002, 74208.62895685487, 74313.25686743172, 17405.303787848345, 17721.202545885466, 17740.11299435023, 17743.73384399235, 17806.554836129202, 13329.400176991865, 13364.665883352995, 13387.0, 13395.732085358239, 13398.531051413154, 22450.214242501435, 22540.887295563745, 22760.31719048398, 22772.20297289587, 22774.544509109724, 8611.440256383315, 8674.175953284428, 8711.695090671923, 8890.86663700045, 8916.242119419921, 1085.7502774361783, 1094.8138816401072, 1137.090327737823, 1189.238887112249, 1200.789861774186, 27670.0, 27698.5845212322, 27924.72075279262, 27989.44021119607, 28109.578356324673, 1148.1561052626314, 1178.3165763856941, 1184.09416796151, 1235.7713822942605, 1268.7906495428335, 15168.544943651708, 15801.288941997638, 15939.0, 16063.437779677888, 16397.180140992903, 451250.0, 502736.0, 503894.0, 504657.0, 941262.0, 57566.424335756106, 58463.415365845794, 58720.412795871496, 58843.70578147082, 59104.704476478204, 1390.8539603341706, 1476.5422718957157, 1494.1632685696045, 1506.0511877517094, 1509.1624148597414, 30578.0, 31175.37649246957, 31797.36405271928, 32236.19409514781, 33651.326973460884, 52567.474325256255, 52866.0, 52980.20529692135, 53038.46961530335, 53068.469315306356, 285956.0, 287596.0, 287902.0, 288009.0, 288362.0, 35860.103497412776, 36070.8196459016, 36085.45871811872, 36297.27405451823, 36561.0, 48515.0, 48557.75721121372, 48740.512594873595, 48754.26868596903, 49971.0, 41055.178896422505, 41718.37422438726, 42184.36723449212, 42206.0, 42308.788456057526, 41565.79217103895, 42223.366649500895, 42256.0, 42262.57737422586, 42383.36424953566, 45787.0, 46675.29987050265, 46791.532084678714, 47552.762236188595, 47848.282275766585, 39324.606753932094, 40065.39901901532, 40137.39793903035, 40617.79691101644, 40702.38946415865, 27617.171484855488, 28004.719952800213, 28303.858480707466, 28463.288417788892, 28472.430551389272], "unit": "score", "name": "ext.html", "value": 20928.291401196584}, {"lowerIsBetter": false, "replicates": [372.0605471185257, 374.71147216643203, 377.92819364320775, 382.867910570853, 390.5411141908257, 14257.029108018454, 16226.432074877383, 17228.3108675653, 19385.515362115955, 19414.029298535068, 10929.0, 11361.147913906449, 11372.147088968319, 16163.838361616381, 16650.417235396762, 5078.289039534468, 5255.527002569768, 5266.131088370415, 5279.445658205891, 5700.515456186208, 5666.914996275059, 5748.051571490699, 5765.1928729977835, 5771.336296325913, 5777.59556831022, 5215.973920130394, 5407.459254074601, 5409.188621706756, 5419.701916394597, 5643.379228284885, 5339.06566350889, 5353.9196912046355, 5423.566114710814, 5714.628549144292, 5724.398938111522, 5389.083855744533, 5500.532454741352, 5509.421510741355, 5523.088690366085, 5526.834194974157, 12761.872381276162, 13096.410661520255, 13201.141925774795, 13239.271840048794, 13321.800172997413, 2234.430220293831, 2265.29775769512, 2278.8605697151424, 2335.7736691897258, 2410.192585483865, 10050.346727462764, 10163.441010744406, 11247.156463265288, 13318.533851315158, 13747.656308592264, 1895.5829717462136, 1947.6396866579728, 1966.223341779989, 2047.3017790141655, 2053.1889903488186, 58397.7080114601, 59333.40666593365, 59788.70105649487, 59956.0, 60284.698576507275, 10704.678859634223, 10856.620018299322, 10883.074938630305, 10991.450427478594, 11000.944995274973, 14451.421943122157, 14476.34856431463, 14498.275086245645, 14517.419303227964, 14561.708765824837, 7945.920540794634, 8110.0, 8220.095789463154, 8285.50286982783, 8345.123762004901, 7954.323882469939, 8003.399745019147, 8029.237222463857, 8092.231238032377, 8094.433389662667, 4429.313456414261, 4770.403699537558, 4782.234842425195, 4791.161546729309, 4821.927671084936, 1761.779777527809, 1845.9907700461413, 1860.57206842427, 1914.6693048331554, 1952.66804643211, 463.55267167183155, 1055.4089709762557, 1084.5336505302637, 1142.2689478733616, 1179.7345597240724, 10461.163106951577, 10773.83839242412, 11014.39420831846, 11108.389038602954, 11278.7180320491, 468.8031026968681, 475.39862074475815, 477.5654154719258, 486.25602827673714, 499.9275105109739, 5514.283143191359, 5953.880922381528, 6063.605865618809, 6088.360722124113, 6103.633781973096, 645051.0, 646498.0, 652359.0, 692657.0, 696314.0, 68669.31330686629, 69729.0, 76322.0, 77839.22160778433, 79340.0, 1186.9228500147462, 1211.0916812390708, 1228.8648248692637, 1239.69007748063, 1249.3066348176667, 15590.766138507704, 15849.128297943724, 15984.0, 16209.756853647441, 16327.836721633106, 33450.330993380485, 34176.0, 35565.46651800173, 35680.64319356773, 35735.10662233465, 41181.382279265235, 42570.787146064074, 43287.783561082, 43658.34512482379, 45546.54453455423, 7371.48399612022, 7708.576028318496, 7749.147593764568, 7757.68969241224, 7854.450188486751, 10537.367757934548, 11314.886851131383, 11505.57035541306, 11791.587294444653, 12076.335801531, 9987.350822196535, 10336.896631033593, 10338.793224135325, 10626.574937002433, 10696.89303106959, 10047.497625118862, 10058.899411006088, 10174.186065114922, 10275.280730348804, 10362.326448780805, 9951.800963980824, 10135.0, 10476.580936762444, 10520.263581549218, 10706.839397409201, 7287.1984081752025, 7304.452166087671, 7633.770986870402, 7874.094479134973, 7887.84224315522, 9856.901430985885, 10146.847797283195, 10379.532921018723, 10489.108425783894, 10540.0], "unit": "score", "name": "jquery.html", "value": 8127.1656140769055}, {"lowerIsBetter": false, "replicates": [1488.9702205955882, 1583.060750580539, 1833.358324586394, 1918.3189967561507, 1959.0694420150421, 7788.649510772015, 8022.638981245844, 8213.91786082139, 8392.790180245496, 8396.16038396161, 8518.488890666564, 8529.402941794076, 8552.91447085529, 8608.0, 8636.352273579476, 2432.4162201071704, 2440.1825388494876, 2440.7681270279386, 2452.350127216289, 2469.8518088914634, 2357.281029286076, 2368.348704106367, 2384.833061685683, 2385.42749740062, 2392.4616961183683, 2368.928932132039, 2372.4543355028354, 2383.9046438142454, 2407.7592240775957, 2431.5744744669614, 2424.066734307287, 2451.227863223097, 2456.57010023247, 2461.716902556211, 2464.0, 2384.8449850759644, 2424.151546958568, 2428.077330614355, 2433.0997530913496, 2433.8661373624445, 8308.0, 8335.916640833575, 8372.372072094617, 8396.580170991487, 8419.45273557223, 4989.351384320052, 5102.081625307444, 5114.897702045975, 5118.718470484122, 5183.922241166386, 3189.4259033373983, 3208.470602350609, 3211.5985501812274, 3265.9346813063607, 3279.8360081995806, 1052.5474046160148, 1059.3432072115338, 1097.8902109789037, 1135.7558125003081, 1159.2291126400933, 11819.0, 11827.881721182765, 11899.821502677467, 11929.94035029828, 11947.283163010161, 4285.721428107163, 4326.762028088422, 4364.083542456056, 4413.3821265022925, 4422.204003279377, 9355.29835262358, 9371.250299975985, 9373.437593744397, 9384.0, 9418.29362797793, 4974.328465657162, 4982.950170498321, 4994.450610432849, 4996.7001979881325, 5015.924761128513, 4528.298113792367, 4538.818447262139, 4540.545945405499, 4543.9776050389055, 4551.4765801932535, 3620.818959052037, 3651.598324184338, 3701.1487357907295, 3705.295993761231, 3718.3678774607843, 1077.2997551591527, 1092.6012005618052, 1099.0767755085767, 1099.543689368903, 1103.7351035751362, 1146.2835727670206, 1152.5159433037977, 1163.2962057954815, 1192.505110379183, 1211.6122840690894, 7905.802354941173, 7945.205479452008, 7975.042994840656, 7986.960065199637, 8039.5176289422825, 1216.0514798457218, 1218.366449446283, 1224.7917853964848, 1231.7536492701495, 1233.3648171191844, 6204.81385558434, 6206.472449841724, 6271.122042913996, 6285.057241413824, 6311.211098612674, 10077.748056298651, 10445.373277603368, 10491.370517768959, 10500.264981451377, 10523.84214236787, 9519.143277104955, 10371.63699270537, 10381.532831022621, 10457.895421045845, 10510.054095131474, 7847.803804904923, 7880.448368614257, 7945.64244608994, 7967.760967170994, 8007.079185893696, 7735.922640773745, 7789.4157938155995, 7836.451448398558, 7889.171636978264, 7894.171112033154, 8642.178992995656, 8970.147835955573, 8974.326925480746, 9204.631814727336, 9226.953865230631, 8898.911010889808, 8991.41555798871, 9009.684661036832, 9019.0, 9053.502057386908, 7113.146422429341, 7187.0, 7215.567065976058, 7255.0, 7256.673449694882, 7529.322360987538, 7620.504667196615, 7627.961860190663, 7658.808529786577, 7705.422093343133, 7289.4168466523615, 7535.321821035914, 7598.620068996639, 7605.619719013916, 7632.656530456032, 6739.59562426256, 6811.114555108003, 7208.27917208275, 7341.155767086853, 7413.66638501258, 7295.124585049828, 7318.231585683639, 7346.706131754884, 7346.742863999734, 7365.926340736738, 6717.966410167918, 6730.091437655854, 6740.0, 6748.527603067738, 6780.627065511247, 6680.365365290289, 6711.664416779044, 6744.325567443217, 6747.730090796314, 6879.965600171967], "unit": "score", "name": "mootools.html", "value": 4765.894893307183}, {"lowerIsBetter": false, "replicates": [344.55724394153503, 353.57394339820513, 359.51645037424686, 361.1747157744554, 364.59165734377484, 6209.596376235541, 6371.299157092728, 6387.457066149377, 6399.488040956724, 6430.035494675801, 6204.255489341285, 6279.15231443755, 6303.716332765025, 6304.432601065914, 6339.334369891164, 4826.9034619307595, 4853.805847766085, 4859.684120532172, 4860.586850117745, 4877.341558889558, 4892.168331383673, 4893.0, 4895.5838753705975, 4903.0, 4908.484609116045, 4753.572178503934, 4832.1543729847135, 4844.854654360375, 4849.442314133867, 4849.975750121244, 4814.807407703687, 4822.445418776851, 4832.975835120802, 4843.273508973647, 4853.611711063142, 4053.736507127057, 4151.46031015969, 4255.1064276501975, 4259.552746961586, 4262.637675797561, 5877.206577112078, 5957.344692083867, 5972.283326000865, 5976.342602313742, 6001.339852616209, 5664.235328230678, 5673.120666296731, 5674.177244299553, 5680.829575112753, 5692.146178073281, 6654.48078253138, 6675.6662166891465, 6734.595924244561, 6737.595744255312, 6760.459163266927, 4730.266808644631, 4733.195356789354, 4742.9525704742855, 4753.263244197155, 4757.666963312569, 6971.6165610891385, 6973.79078627642, 6978.616176110312, 6983.790486285419, 6988.37104660583, 4867.415910090812, 4900.754962251873, 4906.58294045003, 4907.337509436252, 4917.262410638433, 4841.515848415131, 4956.083124621957, 4961.5534601886, 4964.90070198594, 4971.1549036663855, 5664.68844213564, 5670.376258611549, 5677.0, 5681.0, 5689.6586204827845, 6736.629485378351, 6743.190817101881, 6747.966260168668, 6750.953602191668, 6770.593764374054, 1695.8440859679285, 1714.7427885817228, 1724.6895558799285, 1727.1968534631458, 1730.576008877808, 1120.1318977792114, 1137.38581166171, 1145.1583086431467, 1153.7923173828624, 1160.5647882044234, 6463.515236357292, 6467.708953097122, 6482.481401487869, 6485.3514648534765, 6487.318831522716, 6933.37599616037, 6937.098177236927, 6985.26654701249, 6987.231404545496, 6987.231404545496, 6349.46029587481, 6396.744130234832, 6432.356764323624, 6437.581557198767, 6468.708908099053, 3649.2883887641656, 3758.567764707094, 3762.548494180716, 3787.715921305913, 3795.8671446499793, 7060.682269297894, 7118.074650295532, 7228.96385518069, 7276.818079548054, 7313.780586582411, 7138.393236574845, 7174.210836807947, 7187.496875218789, 7217.170025447036, 7252.093488313961, 7043.894341584881, 7205.639718013974, 7239.31226533489, 7258.491905566665, 7284.417246620258, 6989.720411183495, 7003.124609423822, 7056.470764692771, 7057.576545407292, 7058.082449281561, 6849.486288528281, 6857.7256909723055, 6923.065386172802, 6932.653367331714, 6940.7917762467205, 7109.75115870942, 7220.89168662481, 7235.457340699363, 7235.565866048054, 7277.59973201479, 4932.506749325183, 4933.112039832721, 4933.1613625683, 4942.3080768693135, 4960.454350021422, 6976.162860456778, 6983.127109111361, 7019.262977387505, 7019.964900175466, 7028.332308430691, 6668.933310667026, 6790.490713196431, 6863.07348507965, 6868.0, 6871.622060786704, 6847.726090956306, 6852.5545839522265, 6853.897191542231, 6857.348551887562, 6857.657117144223, 6607.900881486686, 6731.158605174353, 6733.091032710718, 6735.595864248161, 6750.0, 6861.0, 6862.245153033262, 6872.244053154049, 6877.2091209509545, 6877.724891004304, 6672.199336079701, 6693.732250709917, 6696.1629796275465, 6710.16122984627, 6714.764983225564], "unit": "score", "name": "prototype.html", "value": 5111.951680203149}, {"lowerIsBetter": false, "replicates": [747.0848210941593, 798.5607915646394, 881.3081730841287, 899.3389858454037, 926.2034650200831, 14198.787018194735, 14292.356843942021, 14383.64040898978, 14401.0, 14401.567952961403, 13652.317384130778, 13753.79369309461, 13756.10585311954, 13769.449222031131, 13781.173129612205, 744.7840126363349, 756.6595032235489, 898.3397203055749, 908.3686837647821, 912.589334799343, 892.8392889279927, 904.8371293167228, 910.6903652758061, 913.3743385780762, 916.7753900294438, 657.8848701477223, 660.3858411677162, 663.1213641924445, 664.1167247560757, 666.070831190489, 655.0076633899646, 661.6526323680058, 664.51158398577, 666.1007639686409, 666.6633350158163, 496.3596959921697, 499.66772096555746, 503.41100911933125, 504.46526681717495, 508.27063164358896, 12441.937790311082, 12483.0, 12508.937455312756, 12592.937035314857, 12732.299723515296, 13346.265955372548, 13676.0, 13683.609366076469, 13934.442622295095, 14040.789388159084, 11059.557617695282, 11131.833022504668, 11243.887561124448, 11410.315381077078, 11473.0, 3909.198614284065, 3945.6251656092627, 3958.0302825807576, 3963.762174269524, 3964.365701487748, 53656.463435365535, 54412.72793636007, 54610.45389546093, 55168.44831551673, 55289.72355138198, 10645.78708425827, 10689.358638481715, 10808.729781755519, 11030.0, 11086.556537738561, 18369.173387197607, 18433.0, 18453.7231941521, 18568.350107746162, 18593.047729988157, 7563.432742544332, 7584.393248540104, 7637.809054773675, 7710.7686769397005, 7806.804829879298, 4319.8488052918, 4339.913201736011, 4375.860463734282, 4376.671749618791, 4379.321205213197, 3131.3267647455905, 3136.8431578421446, 3145.402373549018, 3154.526820976826, 3158.431482333156, 568.3378863623832, 579.0445764488543, 583.2825624481911, 583.9503642190376, 586.2525280267607, 534.7967772246521, 554.431707499816, 580.7415700013538, 652.6247407740568, 743.5241445474901, 8905.643774248958, 9606.087421694929, 9645.614175433044, 9670.613175473043, 9722.854157187649, 530.5728888244922, 562.7636392715069, 711.8683043636944, 731.8024133484035, 744.9664765085585, 4182.372644103409, 4488.147252022105, 4512.368268442355, 4695.24876019842, 4711.104890070944, 56928.43071569314, 56940.14589781156, 57355.71322143362, 57368.13947790786, 57863.13205301924, 51811.0, 52205.21692174621, 52576.474235257156, 53033.734831326365, 53072.0, 48471.5152848467, 48828.267575986385, 49849.99999999927, 50254.74872625613, 51175.23237151446, 8984.46093234408, 9378.765530861783, 9388.202002829836, 9475.952620236854, 9631.0, 34245.657543425245, 35738.0, 36928.26143477062, 37066.790565688876, 37209.069773255884, 48388.758056209495, 48599.5140048595, 48743.26885096797, 48834.511654883, 49304.01391972212, 11937.641870743544, 11994.700132496757, 12038.939805300917, 12044.277343359427, 12099.697507562381, 13141.145825521311, 13425.530106446227, 13578.86421135776, 13629.318534073454, 13845.930770346084, 11673.883261167619, 11898.107641927063, 11956.043516518832, 12107.636770896886, 12610.36948152607, 11907.285562866256, 12055.984892648936, 12404.56584019555, 12786.61640150797, 12863.421146048264, 10560.524776385235, 11534.192606517463, 12138.332391718188, 12323.075769317158, 13015.544455944375, 9731.708048758548, 9908.702738917844, 10177.592896284363, 10321.845172322572, 10353.119984801075, 10039.339575012482, 10381.53283102247, 10444.947775261378, 10733.624323148651, 10806.783864322826], "unit": "score", "name": "yui.html", "value": 6508.054933929127}], "name": "dromaeo_css", "value": 7252.615989446465}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 105.0, 109.0, 111.0, 112.0, 121.0, 110.0, 114.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [157.0, 129.0, 159.0, 165.0, 129.0, 151.0, 153.0, 128.0, 161.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 146.0}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 163.0, 162.0, 161.0, 162.0, 163.0, 165.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 76.0, 165.0, 73.0, 73.0, 75.0, 73.0, 170.0, 76.0], "unit": "score", "name": "audio-fft", "value": 93.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 140.0, 95.0, 95.0, 95.0, 138.0, 95.0, 96.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 108.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 97.0, 97.0, 97.0, 96.0, 98.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 56.0, 55.0, 60.0, 55.0, 55.0, 54.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.9}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.7}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 83.0, 89.0, 82.0, 85.0, 84.0, 82.0, 91.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.3}, {"lowerIsBetter": true, "replicates": [111.0, 116.0, 109.0, 121.0, 118.0, 112.0, 115.0, 112.0, 121.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.7}, {"lowerIsBetter": true, "replicates": [150.0, 148.0, 140.0, 140.0, 139.0, 147.0, 139.0, 141.0, 152.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.3}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 65.0, 68.0, 66.0, 69.0, 65.0, 65.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.2}], "name": "kraken", "value": 1505.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.22408026755852], "unit": "score", "name": "Richards", "value": 211.10596}, {"lowerIsBetter": false, "replicates": [170.1837985023826], "unit": "score", "name": "DeltaBlue", "value": 388.5093679999998}, {"lowerIsBetter": false, "replicates": [279.9552071668533], "unit": "score", "name": "Encrypt", "value": 950.7985320000004}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [934.5794392523364], "unit": "score", "name": "RayTrace", "value": 791.7882300000002}, {"lowerIsBetter": false, "replicates": [566.8934240362812], "unit": "score", "name": "Earley", "value": 1175.6407319999996}, {"lowerIsBetter": false, "replicates": [11122.222222222223], "unit": "score", "name": "Boyer", "value": 59.92174825174829}, {"lowerIsBetter": false, "replicates": [38980.769230769234], "unit": "score", "name": "RegExp", "value": 23.370113468179557}, {"lowerIsBetter": false, "replicates": [509.683995922528], "unit": "score", "name": "Splay", "value": 159.88534200000007}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 22016.37755455516}]} 15:25:17 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "22016.38"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1505.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7252.61"}}} 15:25:17 INFO - Return code: 0 15:25:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 15:25:17 INFO - # TBPL SUCCESS # 15:25:17 INFO - Running post-action listener: _resource_record_post_action 15:25:17 INFO - Running post-run listener: _resource_record_post_run 15:25:18 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 8192; Write bytes: 512446464; Read time: 16; Write time: 458024 15:25:18 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 241926144; Read time: 0; Write time: 270180 15:25:18 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 8192; Write bytes: 270295040; Read time: 16; Write time: 187832 15:25:18 INFO - Running post-run listener: _upload_blobber_files 15:25:18 INFO - Blob upload gear active. 15:25:18 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 15:25:18 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 15:25:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 15:25:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 15:25:19 INFO - (blobuploader) - INFO - Open directory for files ... 15:25:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:25:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:25:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:25:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:25:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:25:20 INFO - (blobuploader) - INFO - Done attempting. 15:25:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:25:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:25:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:25:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:25:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:25:21 INFO - (blobuploader) - INFO - Done attempting. 15:25:21 INFO - (blobuploader) - INFO - Iteration through files over. 15:25:21 INFO - Return code: 0 15:25:21 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 15:25:21 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 15:25:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5183d4c58d4e02a73aa167c05483c9a4d0972bea1a940f28a7e8aebb3b1fa2f6eb7eed513a0eec9fcd023feeb10f563fe2957a577bfdf78db0bd9b6de8358cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/027fd4625adcc2472e33a2f95b5ff326935bcd242553cce7fe38013548a58f1dea3efb9589aa1c3248b0a8198f61bee5a3a4631ec90ff1e5b3a5365f7e9c72f3"} 15:25:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 15:25:21 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 15:25:21 INFO - Contents: 15:25:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5183d4c58d4e02a73aa167c05483c9a4d0972bea1a940f28a7e8aebb3b1fa2f6eb7eed513a0eec9fcd023feeb10f563fe2957a577bfdf78db0bd9b6de8358cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/027fd4625adcc2472e33a2f95b5ff326935bcd242553cce7fe38013548a58f1dea3efb9589aa1c3248b0a8198f61bee5a3a4631ec90ff1e5b3a5365f7e9c72f3"} 15:25:21 INFO - Running post-run listener: copy_logs_to_upload_dir 15:25:21 INFO - Copying logs to upload dir... 15:25:21 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 15:25:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.696428 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-02-17 15:25:19.912605) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-17 15:25:19.916275) ========= 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=6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5183d4c58d4e02a73aa167c05483c9a4d0972bea1a940f28a7e8aebb3b1fa2f6eb7eed513a0eec9fcd023feeb10f563fe2957a577bfdf78db0bd9b6de8358cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/027fd4625adcc2472e33a2f95b5ff326935bcd242553cce7fe38013548a58f1dea3efb9589aa1c3248b0a8198f61bee5a3a4631ec90ff1e5b3a5365f7e9c72f3"} build_url:https://queue.taskcluster.net/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011412 build_url: 'https://queue.taskcluster.net/v1/task/eEleJ5TBQAm3O4jVZNCu5g/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d5183d4c58d4e02a73aa167c05483c9a4d0972bea1a940f28a7e8aebb3b1fa2f6eb7eed513a0eec9fcd023feeb10f563fe2957a577bfdf78db0bd9b6de8358cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/027fd4625adcc2472e33a2f95b5ff326935bcd242553cce7fe38013548a58f1dea3efb9589aa1c3248b0a8198f61bee5a3a4631ec90ff1e5b3a5365f7e9c72f3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-17 15:25:19.944112) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 15:25:19.944428) ========= 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=6d15e502d8e29d5d2676d664000001c3-1455750163.332625-1661283431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 15:25:20.027487) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-17 15:25:20.027804) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-17 15:25:20.028090) ========= ========= Total master_lag: 2.93 =========