builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1456655351.26 results: success (0) buildid: 20160227030340 builduid: ef20964ffb474f23ad057cd8a79c37a7 revision: b5df3e5a52c8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.263442) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.263825) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.264535) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009112 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.318572) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.318921) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.488421) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.488698) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019452 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.597623) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.597918) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.598367) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.598691) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-28 02:29:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 78.5M=0s 2016-02-28 02:29:11 (78.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169020 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.780694) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.781023) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.119827 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.936988) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.937327) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b5df3e5a52c8 --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 b5df3e5a52c8 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-28 02:29:12,025 Setting DEBUG logging. 2016-02-28 02:29:12,025 attempt 1/10 2016-02-28 02:29:12,025 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b5df3e5a52c8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-28 02:29:12,384 unpacking tar archive at: mozilla-aurora-b5df3e5a52c8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.683392 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:12.639737) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:12.640095) ========= echo b5df3e5a52c8 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b5df3e5a52c8'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b5df3e5a52c8 program finished with exit code 0 elapsedTime=0.004438 script_repo_revision: 'b5df3e5a52c8' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:12.691745) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:12.692137) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:12.704188) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2016-02-28 02:29:12.704547) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:29:12 INFO - MultiFileLogger online at 20160228 02:29:12 in /builds/slave/test-pgo 02:29:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:29:12 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 02:29:12 INFO - {'append_to_log': False, 02:29:12 INFO - 'base_work_dir': '/builds/slave/test-pgo', 02:29:12 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:29:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 02:29:12 INFO - 'branch': 'Mozilla-Aurora', 02:29:12 INFO - 'buildbot_json_path': 'buildprops.json', 02:29:12 INFO - 'config_files': ('talos/linux_config.py',), 02:29:12 INFO - 'default_actions': ('clobber', 02:29:12 INFO - 'read-buildbot-config', 02:29:12 INFO - 'download-and-extract', 02:29:12 INFO - 'populate-webroot', 02:29:12 INFO - 'create-virtualenv', 02:29:12 INFO - 'install', 02:29:12 INFO - 'run-tests'), 02:29:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:29:12 INFO - 'download_minidump_stackwalk': True, 02:29:12 INFO - 'download_symbols': 'ondemand', 02:29:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:29:12 INFO - 'tooltool.py': '/tools/tooltool.py', 02:29:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:29:12 INFO - '/tools/misc-python/virtualenv.py')}, 02:29:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:29:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:29:12 INFO - 'installer_path': 'installer.exe', 02:29:12 INFO - 'log_level': 'info', 02:29:12 INFO - 'log_name': 'talos', 02:29:12 INFO - 'log_to_console': True, 02:29:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:29:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:29:12 INFO - 'opt_config_files': (), 02:29:12 INFO - 'pip_index': False, 02:29:12 INFO - 'sps_profile': False, 02:29:12 INFO - 'sps_profile_interval': 0, 02:29:12 INFO - 'suite': 'dromaeojs', 02:29:12 INFO - 'system_bits': '32', 02:29:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:29:12 INFO - 'title': 'talos-linux64-ix-041', 02:29:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:29:12 INFO - 'use_talos_json': True, 02:29:12 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 02:29:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:29:12 INFO - 'work_dir': 'build'} 02:29:12 INFO - ##### 02:29:12 INFO - ##### Running clobber step. 02:29:12 INFO - ##### 02:29:12 INFO - Running pre-action listener: _resource_record_pre_action 02:29:12 INFO - Running main action method: clobber 02:29:12 INFO - rmtree: /builds/slave/test-pgo/build 02:29:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 02:29:13 INFO - Running post-action listener: _resource_record_post_action 02:29:13 INFO - ##### 02:29:13 INFO - ##### Running read-buildbot-config step. 02:29:13 INFO - ##### 02:29:13 INFO - Running pre-action listener: _resource_record_pre_action 02:29:13 INFO - Running main action method: read_buildbot_config 02:29:13 INFO - Using buildbot properties: 02:29:13 INFO - { 02:29:13 INFO - "project": "", 02:29:13 INFO - "product": "firefox", 02:29:13 INFO - "script_repo_revision": "production", 02:29:13 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:29:13 INFO - "repository": "", 02:29:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:29:13 INFO - "buildid": "20160227030340", 02:29:13 INFO - "pgo_build": "True", 02:29:13 INFO - "basedir": "/builds/slave/test-pgo", 02:29:13 INFO - "buildnumber": 189, 02:29:13 INFO - "slavename": "talos-linux64-ix-041", 02:29:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:29:13 INFO - "platform": "ubuntu64_hw", 02:29:13 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:29:13 INFO - "branch": "mozilla-aurora", 02:29:13 INFO - "repo_path": "releases/mozilla-aurora", 02:29:13 INFO - "revision": "b5df3e5a52c8", 02:29:13 INFO - "stage_platform": "linux64-pgo", 02:29:13 INFO - "builduid": "ef20964ffb474f23ad057cd8a79c37a7", 02:29:13 INFO - "slavebuilddir": "test" 02:29:13 INFO - } 02:29:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 02:29:13 INFO - Running post-action listener: _resource_record_post_action 02:29:13 INFO - ##### 02:29:13 INFO - ##### Running download-and-extract step. 02:29:13 INFO - ##### 02:29:13 INFO - Running pre-action listener: _resource_record_pre_action 02:29:13 INFO - Running main action method: download_and_extract 02:29:13 INFO - mkdir: /builds/slave/test-pgo/build/tests 02:29:13 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')]} 02:29:13 INFO - https://queue.taskcluster.net/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:29:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/test_packages.json 02:29:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/test_packages.json 02:29:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 02:29:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 02:29:21 INFO - Downloaded 1448 bytes. 02:29:21 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 02:29:21 INFO - Using the following test package requirements: 02:29:21 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 02:29:21 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:29:21 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:29:21 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:29:21 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:29:21 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:29:21 INFO - u'jsshell-linux-x86_64.zip'], 02:29:21 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:29:21 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:29:21 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 02:29:21 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:29:21 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:29:21 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:29:21 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:29:21 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:29:21 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:29:21 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 02:29:21 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:29:21 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:29:21 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:21 INFO - https://queue.taskcluster.net/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:29:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 02:29:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 02:29:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/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 02:29:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/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 02:29:35 INFO - Downloaded 23079152 bytes. 02:29:35 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'] 02:29:35 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 02:29:36 INFO - Return code: 0 02:29:36 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:29: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')]} 02:29:36 INFO - https://queue.taskcluster.net/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:29:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 02:29:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 02:29:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/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 02:29:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/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 02:29:41 INFO - Downloaded 23079152 bytes. 02:29:41 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'] 02:29:41 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 02:29:43 INFO - Return code: 0 02:29: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')]} 02:29:43 INFO - https://queue.taskcluster.net/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:29:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 02:29:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 02:29:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/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 02:29:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/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 02:29:44 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip: [Errno 104] Connection reset by peer 02:29:44 INFO - retry: attempt #1 caught exception: [Errno 104] Connection reset by peer 02:29:44 INFO - retry: Failed, sleeping 30 seconds before retrying 02:30:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/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 #2 02:30:16 INFO - Downloaded 10706572 bytes. 02:30:16 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'] 02:30:16 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 02:30:16 INFO - Return code: 0 02:30: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')]} 02:30:16 INFO - https://queue.taskcluster.net/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:30:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 02:30:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 02:30:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/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 02:30:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/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 02:30:19 INFO - Downloaded 59958857 bytes. 02:30:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 02:30:19 INFO - mkdir: /builds/slave/test-pgo/properties 02:30:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 02:30:19 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 02:30:19 INFO - Contents: 02:30:19 INFO - build_url:https://queue.taskcluster.net/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 02:30:20 INFO - Running post-action listener: _resource_record_post_action 02:30:20 INFO - Running post-action listener: set_extra_try_arguments 02:30:20 INFO - ##### 02:30:20 INFO - ##### Running populate-webroot step. 02:30:20 INFO - ##### 02:30:20 INFO - Running pre-action listener: _resource_record_pre_action 02:30:20 INFO - Running main action method: populate_webroot 02:30:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:30:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:30:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:30:20 INFO - '--tppagecycles', 02:30:20 INFO - '7'], 02:30:20 INFO - 'tests': ['tsvgm']}}, 02:30:20 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:30:20 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:30:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:30:20 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:30:20 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:30:20 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:30:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:30:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:20 INFO - 'talos_options': ['--e10s'], 02:30:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:30:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:20 INFO - 'tests': ['damp', 'tps']}, 02:30:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:20 INFO - 'talos_options': ['--e10s'], 02:30:20 INFO - 'tests': ['damp', 'tps']}, 02:30:20 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:30:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:30:20 INFO - 'other': {'tests': ['a11yr', 02:30:20 INFO - 'ts_paint', 02:30:20 INFO - 'tpaint', 02:30:20 INFO - 'sessionrestore', 02:30:20 INFO - 'sessionrestore_no_auto_restore']}, 02:30:20 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:30:20 INFO - 'tests': ['a11yr', 02:30:20 INFO - 'ts_paint', 02:30:20 INFO - 'tpaint', 02:30:20 INFO - 'sessionrestore', 02:30:20 INFO - 'sessionrestore_no_auto_restore']}, 02:30:20 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:30:20 INFO - 'tests': ['a11yr', 02:30:20 INFO - 'ts_paint', 02:30:20 INFO - 'tpaint', 02:30:20 INFO - 'sessionrestore', 02:30:20 INFO - 'sessionrestore_no_auto_restore']}, 02:30:20 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:30:20 INFO - 'tests': ['a11yr', 02:30:20 INFO - 'ts_paint', 02:30:20 INFO - 'tpaint', 02:30:20 INFO - 'sessionrestore', 02:30:20 INFO - 'sessionrestore_no_auto_restore']}, 02:30:20 INFO - 'other_l64': {'tests': ['a11yr', 02:30:20 INFO - 'ts_paint', 02:30:20 INFO - 'tpaint', 02:30:20 INFO - 'sessionrestore', 02:30:20 INFO - 'sessionrestore_no_auto_restore']}, 02:30:20 INFO - 'other_nol64': {'tests': ['a11yr', 02:30:20 INFO - 'ts_paint', 02:30:20 INFO - 'tpaint', 02:30:20 INFO - 'sessionrestore', 02:30:20 INFO - 'sessionrestore_no_auto_restore']}, 02:30:20 INFO - 'svgr': {'tests': ['tsvgx', 02:30:20 INFO - 'tsvgr_opacity', 02:30:20 INFO - 'tart', 02:30:20 INFO - 'tscrollx', 02:30:20 INFO - 'cart']}, 02:30:20 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:30:20 INFO - 'tests': ['tsvgx', 02:30:20 INFO - 'tsvgr_opacity', 02:30:20 INFO - 'tart', 02:30:20 INFO - 'tscrollx', 02:30:20 INFO - 'cart']}, 02:30:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:20 INFO - 'tests': ['tp5o']}, 02:30:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:20 INFO - 'talos_options': ['--e10s'], 02:30:20 INFO - 'tests': ['tp5o']}, 02:30:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:20 INFO - 'talos_options': ['--xperf_path', 02:30:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:30:20 INFO - 'tests': ['tp5n']}, 02:30:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:20 INFO - 'talos_options': ['--e10s', 02:30:20 INFO - '--xperf_path', 02:30:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:30:20 INFO - 'tests': ['tp5n']}}, 02:30:20 INFO - 'talos.zip': {'path': '', 02:30:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:30:20 INFO - Running post-action listener: _resource_record_post_action 02:30:20 INFO - ##### 02:30:20 INFO - ##### Running create-virtualenv step. 02:30:20 INFO - ##### 02:30:20 INFO - Running pre-action listener: _resource_record_pre_action 02:30:20 INFO - Running main action method: create_virtualenv 02:30:20 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 02:30:20 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 02:30:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 02:30:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:30:20 INFO - Using real prefix '/usr' 02:30:20 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 02:30:21 INFO - Installing distribute.............................................................................................................................................................................................done. 02:30:23 INFO - Installing pip.................done. 02:30:23 INFO - Return code: 0 02:30:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 02:30:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:23 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 0x7f90135def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2860230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f27f0>, '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 0x285e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285e760>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343', '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 02:30:23 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 02:30:23 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 02:30:23 INFO - Using env: {'DISPLAY': ':0', 02:30:23 INFO - 'HOME': '/home/cltbld', 02:30:23 INFO - 'LANG': 'en_US.UTF-8', 02:30:23 INFO - 'LANGUAGE': 'en_US:en', 02:30:23 INFO - 'LOGNAME': 'cltbld', 02:30:23 INFO - 'MAIL': '/var/mail/cltbld', 02:30:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:23 INFO - 'MOZ_NO_REMOTE': '1', 02:30:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:23 INFO - 'NO_EM_RESTART': '1', 02:30:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:30:23 INFO - 'PWD': '/builds/slave/test-pgo', 02:30:23 INFO - 'SHELL': '/bin/bash', 02:30:23 INFO - 'SHLVL': '1', 02:30:23 INFO - 'TERM': 'linux', 02:30:23 INFO - 'TMOUT': '86400', 02:30:23 INFO - 'USER': 'cltbld', 02:30:23 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343', 02:30:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:23 INFO - '_': '/tools/buildbot/bin/python'} 02:30:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:23 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 02:30:23 INFO - Cleaning up... 02:30:23 INFO - Return code: 0 02:30:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 02:30:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:23 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 0x7f90135def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2860230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f27f0>, '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 0x285e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285e760>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343', '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 02:30:23 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 02:30:23 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 02:30:23 INFO - Using env: {'DISPLAY': ':0', 02:30:23 INFO - 'HOME': '/home/cltbld', 02:30:23 INFO - 'LANG': 'en_US.UTF-8', 02:30:23 INFO - 'LANGUAGE': 'en_US:en', 02:30:23 INFO - 'LOGNAME': 'cltbld', 02:30:23 INFO - 'MAIL': '/var/mail/cltbld', 02:30:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:23 INFO - 'MOZ_NO_REMOTE': '1', 02:30:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:23 INFO - 'NO_EM_RESTART': '1', 02:30:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:30:23 INFO - 'PWD': '/builds/slave/test-pgo', 02:30:23 INFO - 'SHELL': '/bin/bash', 02:30:23 INFO - 'SHLVL': '1', 02:30:23 INFO - 'TERM': 'linux', 02:30:23 INFO - 'TMOUT': '86400', 02:30:23 INFO - 'USER': 'cltbld', 02:30:23 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343', 02:30:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:23 INFO - '_': '/tools/buildbot/bin/python'} 02:30:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:23 INFO - Downloading/unpacking psutil>=0.7.1 02:30:23 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 02:30:23 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 02:30:23 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 02:30:23 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 02:30:23 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 02:30:23 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 02:30:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 02:30:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:30:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:30:25 INFO - Installing collected packages: psutil 02:30:25 INFO - Running setup.py install for psutil 02:30:25 INFO - building 'psutil._psutil_linux' extension 02:30:25 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 02:30:25 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 02:30:25 INFO - building 'psutil._psutil_posix' extension 02:30:25 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 02:30:25 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 02:30:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:30:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:30:25 INFO - Successfully installed psutil 02:30:25 INFO - Cleaning up... 02:30:26 INFO - Return code: 0 02:30:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 02:30: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')]} 02:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30: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')]} 02:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:26 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 0x7f90135def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2860230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f27f0>, '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 0x285e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285e760>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343', '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 02:30:26 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 02:30:26 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 02:30:26 INFO - Using env: {'DISPLAY': ':0', 02:30:26 INFO - 'HOME': '/home/cltbld', 02:30:26 INFO - 'LANG': 'en_US.UTF-8', 02:30:26 INFO - 'LANGUAGE': 'en_US:en', 02:30:26 INFO - 'LOGNAME': 'cltbld', 02:30:26 INFO - 'MAIL': '/var/mail/cltbld', 02:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:26 INFO - 'MOZ_NO_REMOTE': '1', 02:30:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:26 INFO - 'NO_EM_RESTART': '1', 02:30:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:30:26 INFO - 'PWD': '/builds/slave/test-pgo', 02:30:26 INFO - 'SHELL': '/bin/bash', 02:30:26 INFO - 'SHLVL': '1', 02:30:26 INFO - 'TERM': 'linux', 02:30:26 INFO - 'TMOUT': '86400', 02:30:26 INFO - 'USER': 'cltbld', 02:30:26 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343', 02:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:26 INFO - '_': '/tools/buildbot/bin/python'} 02:30:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:30:26 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 02:30:26 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 02:30:26 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 02:30:26 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 02:30:26 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 02:30:26 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 02:30:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:30:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:30:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:30:28 INFO - Installing collected packages: mozsystemmonitor 02:30:28 INFO - Running setup.py install for mozsystemmonitor 02:30:28 INFO - Successfully installed mozsystemmonitor 02:30:28 INFO - Cleaning up... 02:30:28 INFO - Return code: 0 02:30:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 02:30:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:28 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 0x7f90135def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2860230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f27f0>, '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 0x285e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285e760>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343', '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 02:30:28 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 02:30:28 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 02:30:28 INFO - Using env: {'DISPLAY': ':0', 02:30:28 INFO - 'HOME': '/home/cltbld', 02:30:28 INFO - 'LANG': 'en_US.UTF-8', 02:30:28 INFO - 'LANGUAGE': 'en_US:en', 02:30:28 INFO - 'LOGNAME': 'cltbld', 02:30:28 INFO - 'MAIL': '/var/mail/cltbld', 02:30:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:28 INFO - 'MOZ_NO_REMOTE': '1', 02:30:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:28 INFO - 'NO_EM_RESTART': '1', 02:30:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:30:28 INFO - 'PWD': '/builds/slave/test-pgo', 02:30:28 INFO - 'SHELL': '/bin/bash', 02:30:28 INFO - 'SHLVL': '1', 02:30:28 INFO - 'TERM': 'linux', 02:30:28 INFO - 'TMOUT': '86400', 02:30:28 INFO - 'USER': 'cltbld', 02:30:28 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343', 02:30:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:28 INFO - '_': '/tools/buildbot/bin/python'} 02:30:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:28 INFO - Downloading/unpacking blobuploader==1.2.4 02:30:28 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 02:30:28 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 02:30:28 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 02:30:28 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 02:30:28 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 02:30:28 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 02:30:30 INFO - Downloading blobuploader-1.2.4.tar.gz 02:30:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:30:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:30:30 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 02:30:30 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 02:30:30 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 02:30:30 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 02:30:30 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 02:30:30 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 02:30:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 02:30:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:30:30 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 02:30:30 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 02:30:30 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 02:30:30 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 02:30:30 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 02:30:30 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 02:30:30 INFO - Downloading docopt-0.6.1.tar.gz 02:30:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 02:30:31 INFO - Installing collected packages: blobuploader, requests, docopt 02:30:31 INFO - Running setup.py install for blobuploader 02:30:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:30:31 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 02:30:31 INFO - Running setup.py install for requests 02:30:31 INFO - Running setup.py install for docopt 02:30:31 INFO - Successfully installed blobuploader requests docopt 02:30:31 INFO - Cleaning up... 02:30:31 INFO - Return code: 0 02:30:31 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:30: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')]} 02:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30: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')]} 02:30:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:31 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 0x7f90135def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2860230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f27f0>, '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 0x285e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285e760>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343', '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 02:30:31 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 02:30:31 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 02:30:31 INFO - Using env: {'DISPLAY': ':0', 02:30:31 INFO - 'HOME': '/home/cltbld', 02:30:31 INFO - 'LANG': 'en_US.UTF-8', 02:30:31 INFO - 'LANGUAGE': 'en_US:en', 02:30:31 INFO - 'LOGNAME': 'cltbld', 02:30:31 INFO - 'MAIL': '/var/mail/cltbld', 02:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:31 INFO - 'MOZ_NO_REMOTE': '1', 02:30:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:31 INFO - 'NO_EM_RESTART': '1', 02:30:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:30:31 INFO - 'PWD': '/builds/slave/test-pgo', 02:30:31 INFO - 'SHELL': '/bin/bash', 02:30:31 INFO - 'SHLVL': '1', 02:30:31 INFO - 'TERM': 'linux', 02:30:31 INFO - 'TMOUT': '86400', 02:30:31 INFO - 'USER': 'cltbld', 02:30:31 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343', 02:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:31 INFO - '_': '/tools/buildbot/bin/python'} 02:30:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:30:31 INFO - Running setup.py (path:/tmp/pip-uL1N_O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:30:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:30:31 INFO - Running setup.py (path:/tmp/pip-gVCAcJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:30:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:30:31 INFO - Running setup.py (path:/tmp/pip-qX_9_t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:30:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:30:32 INFO - Running setup.py (path:/tmp/pip-eyHO7d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:30:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:30:32 INFO - Running setup.py (path:/tmp/pip-AkD__P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:30:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:30:32 INFO - Running setup.py (path:/tmp/pip-aFBUos-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:30:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:30:32 INFO - Running setup.py (path:/tmp/pip-D8MXcC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:30:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:30:32 INFO - Running setup.py (path:/tmp/pip-ftDJYI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:30:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:30:32 INFO - Running setup.py (path:/tmp/pip-8rIm5E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:30:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:30:32 INFO - Running setup.py (path:/tmp/pip-CwoMHj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:30:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:30:32 INFO - Running setup.py (path:/tmp/pip-0mOzzp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:30:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:30:32 INFO - Running setup.py (path:/tmp/pip-TgOoD0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:30:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:30:32 INFO - Running setup.py (path:/tmp/pip-aABv74-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:30:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:30:32 INFO - Running setup.py (path:/tmp/pip-t7VwSP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:30:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:30:32 INFO - Running setup.py (path:/tmp/pip-X6pvYn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:30:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:30:32 INFO - Running setup.py (path:/tmp/pip-pCd0JU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:30:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:30:32 INFO - Running setup.py (path:/tmp/pip-DUzIEp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:30:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:30:33 INFO - Running setup.py install for manifestparser 02:30:33 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 02:30:33 INFO - Running setup.py install for mozcrash 02:30:33 INFO - Running setup.py install for mozdebug 02:30:33 INFO - Running setup.py install for mozdevice 02:30:33 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 02:30:33 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 02:30:33 INFO - Running setup.py install for mozfile 02:30:33 INFO - Running setup.py install for mozhttpd 02:30:33 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 02:30:33 INFO - Running setup.py install for mozinfo 02:30:33 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 02:30:33 INFO - Running setup.py install for mozInstall 02:30:33 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 02:30:33 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 02:30:33 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 02:30:33 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 02:30:33 INFO - Running setup.py install for mozleak 02:30:33 INFO - Running setup.py install for mozlog 02:30:34 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 02:30:34 INFO - Running setup.py install for moznetwork 02:30:34 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 02:30:34 INFO - Running setup.py install for mozprocess 02:30:34 INFO - Running setup.py install for mozprofile 02:30:34 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 02:30:34 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 02:30:34 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 02:30:34 INFO - Running setup.py install for mozrunner 02:30:34 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 02:30:34 INFO - Running setup.py install for mozscreenshot 02:30:34 INFO - Running setup.py install for moztest 02:30:34 INFO - Running setup.py install for mozversion 02:30:34 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 02:30:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:30:34 INFO - Cleaning up... 02:30:34 INFO - Return code: 0 02:30:34 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:30: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')]} 02:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30: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')]} 02:30:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:34 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 0x7f90135def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2860230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f27f0>, '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 0x285e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285e760>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343', '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 02:30:34 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 02:30:34 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 02:30:34 INFO - Using env: {'DISPLAY': ':0', 02:30:34 INFO - 'HOME': '/home/cltbld', 02:30:34 INFO - 'LANG': 'en_US.UTF-8', 02:30:34 INFO - 'LANGUAGE': 'en_US:en', 02:30:34 INFO - 'LOGNAME': 'cltbld', 02:30:34 INFO - 'MAIL': '/var/mail/cltbld', 02:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:34 INFO - 'MOZ_NO_REMOTE': '1', 02:30:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:34 INFO - 'NO_EM_RESTART': '1', 02:30:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:30:34 INFO - 'PWD': '/builds/slave/test-pgo', 02:30:34 INFO - 'SHELL': '/bin/bash', 02:30:34 INFO - 'SHLVL': '1', 02:30:34 INFO - 'TERM': 'linux', 02:30:34 INFO - 'TMOUT': '86400', 02:30:34 INFO - 'USER': 'cltbld', 02:30:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343', 02:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:34 INFO - '_': '/tools/buildbot/bin/python'} 02:30:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:30:34 INFO - Running setup.py (path:/tmp/pip-YCmLO2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:30:35 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)) 02:30:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:30:35 INFO - Running setup.py (path:/tmp/pip-sIYjL5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:30:35 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)) 02:30:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:30:35 INFO - Running setup.py (path:/tmp/pip-rTFc8q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:30:35 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)) 02:30:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:30:35 INFO - Running setup.py (path:/tmp/pip-rJWkw8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:30:35 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)) 02:30:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:30:35 INFO - Running setup.py (path:/tmp/pip-hyobAQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:30:35 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)) 02:30:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:30:35 INFO - Running setup.py (path:/tmp/pip-tXBj2w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:30:35 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)) 02:30:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:30:35 INFO - Running setup.py (path:/tmp/pip-E_HM98-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:30:35 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)) 02:30:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:30:35 INFO - Running setup.py (path:/tmp/pip-uaesFj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:30:35 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)) 02:30:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:30:35 INFO - Running setup.py (path:/tmp/pip-3fmKaX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:30:35 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)) 02:30:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:30:35 INFO - Running setup.py (path:/tmp/pip-VcCJlp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:30:35 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)) 02:30:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:30:35 INFO - Running setup.py (path:/tmp/pip-B0eOlW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:30:35 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)) 02:30:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:30:35 INFO - Running setup.py (path:/tmp/pip-r236iu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:30:35 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)) 02:30:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:30:35 INFO - Running setup.py (path:/tmp/pip-DoyTjG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:30:35 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)) 02:30:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:30:35 INFO - Running setup.py (path:/tmp/pip-wvSJ3N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:30:36 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)) 02:30:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:30:36 INFO - Running setup.py (path:/tmp/pip-xz6FU0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:30:36 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)) 02:30:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:30:36 INFO - Running setup.py (path:/tmp/pip-dYOHT4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:30:36 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)) 02:30:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:30:36 INFO - Running setup.py (path:/tmp/pip-g9Kk9m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:30:36 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)) 02:30:36 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)) 02:30:36 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)) 02:30:36 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)) 02:30:36 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)) 02:30:36 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)) 02:30:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 02:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:38 INFO - Downloading blessings-1.6.tar.gz 02:30:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 02:30:38 INFO - Installing collected packages: blessings 02:30:38 INFO - Running setup.py install for blessings 02:30:38 INFO - Successfully installed blessings 02:30:38 INFO - Cleaning up... 02:30:38 INFO - Return code: 0 02:30:38 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 02:30:38 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:30:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:30:38 INFO - Reading from file tmpfile_stdout 02:30:38 INFO - Current package versions: 02:30:38 INFO - argparse == 1.2.1 02:30:38 INFO - blessings == 1.6 02:30:38 INFO - blobuploader == 1.2.4 02:30:38 INFO - docopt == 0.6.1 02:30:38 INFO - manifestparser == 1.1 02:30:38 INFO - mozInstall == 1.12 02:30:38 INFO - mozcrash == 0.16 02:30:38 INFO - mozdebug == 0.1 02:30:38 INFO - mozdevice == 0.48 02:30:38 INFO - mozfile == 1.2 02:30:38 INFO - mozhttpd == 0.7 02:30:38 INFO - mozinfo == 0.9 02:30:38 INFO - mozleak == 0.1 02:30:38 INFO - mozlog == 3.1 02:30:38 INFO - moznetwork == 0.27 02:30:38 INFO - mozprocess == 0.22 02:30:38 INFO - mozprofile == 0.28 02:30:38 INFO - mozrunner == 6.11 02:30:38 INFO - mozscreenshot == 0.1 02:30:38 INFO - mozsystemmonitor == 0.0 02:30:38 INFO - moztest == 0.7 02:30:38 INFO - mozversion == 1.4 02:30:38 INFO - psutil == 3.1.1 02:30:38 INFO - requests == 1.2.3 02:30:38 INFO - wsgiref == 0.1.2 02:30:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:38 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 0x7f90135def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2860230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f27f0>, '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 0x285e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285e760>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343', '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 02:30:38 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 02:30:38 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 02:30:38 INFO - Using env: {'DISPLAY': ':0', 02:30:38 INFO - 'HOME': '/home/cltbld', 02:30:38 INFO - 'LANG': 'en_US.UTF-8', 02:30:38 INFO - 'LANGUAGE': 'en_US:en', 02:30:38 INFO - 'LOGNAME': 'cltbld', 02:30:38 INFO - 'MAIL': '/var/mail/cltbld', 02:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:38 INFO - 'MOZ_NO_REMOTE': '1', 02:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:38 INFO - 'NO_EM_RESTART': '1', 02:30:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:30:38 INFO - 'PWD': '/builds/slave/test-pgo', 02:30:38 INFO - 'SHELL': '/bin/bash', 02:30:38 INFO - 'SHLVL': '1', 02:30:38 INFO - 'TERM': 'linux', 02:30:38 INFO - 'TMOUT': '86400', 02:30:38 INFO - 'USER': 'cltbld', 02:30:38 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343', 02:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:38 INFO - '_': '/tools/buildbot/bin/python'} 02:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:38 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)) 02:30:38 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)) 02:30:38 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)) 02:30:38 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)) 02:30:38 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)) 02:30:38 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)) 02:30:38 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)) 02:30:38 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)) 02:30:38 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)) 02:30:38 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)) 02:30:38 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)) 02:30:38 INFO - Cleaning up... 02:30:38 INFO - Return code: 0 02:30:38 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 02:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90135def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2860230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f27f0>, '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 0x285e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285e760>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343', '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 02:30:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 02:30:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:30:38 INFO - Using env: {'DISPLAY': ':0', 02:30:38 INFO - 'HOME': '/home/cltbld', 02:30:38 INFO - 'LANG': 'en_US.UTF-8', 02:30:38 INFO - 'LANGUAGE': 'en_US:en', 02:30:38 INFO - 'LOGNAME': 'cltbld', 02:30:38 INFO - 'MAIL': '/var/mail/cltbld', 02:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:38 INFO - 'MOZ_NO_REMOTE': '1', 02:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:38 INFO - 'NO_EM_RESTART': '1', 02:30:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:30:38 INFO - 'PWD': '/builds/slave/test-pgo', 02:30:38 INFO - 'SHELL': '/bin/bash', 02:30:38 INFO - 'SHLVL': '1', 02:30:38 INFO - 'TERM': 'linux', 02:30:38 INFO - 'TMOUT': '86400', 02:30:38 INFO - 'USER': 'cltbld', 02:30:38 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343', 02:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:38 INFO - '_': '/tools/buildbot/bin/python'} 02:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:38 INFO - Downloading/unpacking jsonschema 02:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:30:40 INFO - Downloading/unpacking functools32 (from jsonschema) 02:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:40 INFO - Downloading functools32-3.2.3-2.tar.gz 02:30:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 02:30:41 INFO - warning: no files found matching '*.txt' 02:30:41 INFO - no previously-included directories found matching 'build' 02:30:41 INFO - no previously-included directories found matching 'dist' 02:30:41 INFO - no previously-included directories found matching '.git*' 02:30:41 INFO - Installing collected packages: jsonschema, functools32 02:30:41 INFO - Running setup.py install for functools32 02:30:41 INFO - warning: no files found matching '*.txt' 02:30:41 INFO - no previously-included directories found matching 'build' 02:30:41 INFO - no previously-included directories found matching 'dist' 02:30:41 INFO - no previously-included directories found matching '.git*' 02:30:41 INFO - Successfully installed jsonschema functools32 02:30:41 INFO - Cleaning up... 02:30:41 INFO - Return code: 0 02:30:41 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 02:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:41 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 0x7f90135def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2860230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f27f0>, '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 0x285e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285e760>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343', '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 02:30:41 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 02:30:41 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 02:30:41 INFO - Using env: {'DISPLAY': ':0', 02:30:41 INFO - 'HOME': '/home/cltbld', 02:30:41 INFO - 'LANG': 'en_US.UTF-8', 02:30:41 INFO - 'LANGUAGE': 'en_US:en', 02:30:41 INFO - 'LOGNAME': 'cltbld', 02:30:41 INFO - 'MAIL': '/var/mail/cltbld', 02:30:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:41 INFO - 'MOZ_NO_REMOTE': '1', 02:30:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:41 INFO - 'NO_EM_RESTART': '1', 02:30:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:30:41 INFO - 'PWD': '/builds/slave/test-pgo', 02:30:41 INFO - 'SHELL': '/bin/bash', 02:30:41 INFO - 'SHLVL': '1', 02:30:41 INFO - 'TERM': 'linux', 02:30:41 INFO - 'TMOUT': '86400', 02:30:41 INFO - 'USER': 'cltbld', 02:30:41 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343', 02:30:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:41 INFO - '_': '/tools/buildbot/bin/python'} 02:30:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:41 INFO - Downloading/unpacking flake8 02:30:41 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 02:30:41 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 02:30:41 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 02:30:41 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 02:30:41 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 02:30:41 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 02:30:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:30:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:30:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 02:30:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:30:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:30:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:30:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:30:43 INFO - no previously-included directories found matching 'docs/_build' 02:30:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:30:44 INFO - Running setup.py install for pep8 02:30:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:30:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:30:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:30:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:30:44 INFO - no previously-included directories found matching 'docs/_build' 02:30:44 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 02:30:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:30:44 INFO - Cleaning up... 02:30:44 INFO - Return code: 0 02:30:44 INFO - Running post-action listener: _resource_record_post_action 02:30:44 INFO - Running post-action listener: _start_resource_monitoring 02:30:44 INFO - Starting resource monitoring. 02:30:44 INFO - ##### 02:30:44 INFO - ##### Running install step. 02:30:44 INFO - ##### 02:30:44 INFO - Running pre-action listener: _resource_record_pre_action 02:30:44 INFO - Running main action method: install 02:30:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:30:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:30:44 INFO - Reading from file tmpfile_stdout 02:30:44 INFO - Detecting whether we're running mozinstall >=1.0... 02:30:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 02:30:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 02:30:44 INFO - Reading from file tmpfile_stdout 02:30:44 INFO - Output received: 02:30:44 INFO - Usage: mozinstall [options] installer 02:30:44 INFO - Options: 02:30:44 INFO - -h, --help show this help message and exit 02:30:44 INFO - -d DEST, --destination=DEST 02:30:44 INFO - Directory to install application into. [default: 02:30:44 INFO - "/builds/slave/test-pgo"] 02:30:44 INFO - --app=APP Application being installed. [default: firefox] 02:30:44 INFO - mkdir: /builds/slave/test-pgo/build/application 02:30:44 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'] 02:30:44 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 02:30:59 INFO - Reading from file tmpfile_stdout 02:30:59 INFO - Output received: 02:30:59 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 02:30:59 INFO - Running post-action listener: _resource_record_post_action 02:30:59 INFO - ##### 02:30:59 INFO - ##### Running run-tests step. 02:30:59 INFO - ##### 02:30:59 INFO - Running pre-action listener: _resource_record_pre_action 02:30:59 INFO - Running main action method: run_tests 02:30:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 02:30:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 02:30:59 INFO - Python 2.7.3 02:30:59 INFO - Return code: 0 02:30:59 INFO - grabbing minidump binary from tooltool 02:30:59 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')]} 02:30:59 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 0x28f27f0>, '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 0x285e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x285e760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 02:30:59 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 02:30:59 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 02:30:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:30:59 INFO - Return code: 0 02:30:59 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 02:30:59 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 02:30:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 02:30:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 02:30:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 02:30:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 02:30:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 02:31:00 INFO - Return code: 0 02:31:00 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 02:31:00 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 02:31:00 INFO - Using env: {'DISPLAY': ':0', 02:31:00 INFO - 'HOME': '/home/cltbld', 02:31:00 INFO - 'LANG': 'en_US.UTF-8', 02:31:00 INFO - 'LANGUAGE': 'en_US:en', 02:31:00 INFO - 'LOGNAME': 'cltbld', 02:31:00 INFO - 'MAIL': '/var/mail/cltbld', 02:31:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:31:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 02:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:31:00 INFO - 'MOZ_NO_REMOTE': '1', 02:31:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:31:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:31:00 INFO - 'NO_EM_RESTART': '1', 02:31:00 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:31:00 INFO - 'PWD': '/builds/slave/test-pgo', 02:31:00 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 02:31:00 INFO - 'SHELL': '/bin/bash', 02:31:00 INFO - 'SHLVL': '1', 02:31:00 INFO - 'TERM': 'linux', 02:31:00 INFO - 'TMOUT': '86400', 02:31:00 INFO - 'USER': 'cltbld', 02:31:00 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343', 02:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:31:00 INFO - '_': '/tools/buildbot/bin/python'} 02:31:00 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:31:00 INFO - mozversion application_buildid: 20160227030340 02:31:00 INFO - mozversion application_changeset: b5df3e5a52c8f97d97c44f7e200c866796da116f 02:31:00 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:31:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:31:00 INFO - mozversion application_name: Firefox 02:31:00 INFO - mozversion application_remotingname: firefox-dev 02:31:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:31:00 INFO - mozversion application_vendor: Mozilla 02:31:00 INFO - mozversion application_version: 46.0a2 02:31:00 INFO - mozversion platform_buildid: 20160227030340 02:31:00 INFO - mozversion platform_changeset: b5df3e5a52c8f97d97c44f7e200c866796da116f 02:31:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:31:00 INFO - mozversion platform_version: 46.0a2 02:31:00 INFO - using testdate: 1456655460 02:31:00 INFO - actual date: 1456655460 02:31:00 INFO - starting webserver on 'localhost:39772' 02:31:00 INFO - SUITE-START | Running 3 tests 02:31:00 INFO - TEST-START | dromaeo_css 02:31:00 INFO - operating with platform_type : linux_ 02:31:00 INFO - Initialising browser for dromaeo_css test... 02:31:00 INFO - TEST-INFO | started process 9061 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiz90IC/profile http://localhost:39772/getInfo.html) 02:31:05 INFO - PROCESS | 9061 | __metrics Screen width/height:1600/1200 02:31:05 INFO - PROCESS | 9061 | colorDepth:24 02:31:05 INFO - PROCESS | 9061 | Browser inner width/height: 1024/697 02:31:05 INFO - PROCESS | 9061 | __metrics 02:31:05 INFO - PROCESS | 9061 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:31:06 INFO - TEST-INFO | 9061: exit 0 02:31:06 INFO - Browser initialized. 02:31:06 INFO - Running cycle 1/1 for dromaeo_css test... 02:31:06 INFO - TEST-INFO | started process 9149 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiz90IC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:31:18 INFO - PROCESS | 9149 | RSS: Main: 137576448 02:31:18 INFO - PROCESS | 9149 | 02:32:10 INFO - PROCESS | 9149 | 1456655530151 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] 02:34:16 INFO - PROCESS | 9149 | Cycle 1(1): loaded http://localhost:39772/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39772/tests/dromaeo/cssquery-ext.html) 02:34:17 INFO - PROCESS | 9149 | RSS: Main: 209014784 02:34:17 INFO - PROCESS | 9149 | 02:37:20 INFO - PROCESS | 9149 | Cycle 1(1): loaded http://localhost:39772/tests/dromaeo/cssquery-ext.html (next: http://localhost:39772/tests/dromaeo/cssquery-jquery.html) 02:37:20 INFO - PROCESS | 9149 | RSS: Main: 224493568 02:37:20 INFO - PROCESS | 9149 | 02:40:22 INFO - PROCESS | 9149 | Cycle 1(1): loaded http://localhost:39772/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39772/tests/dromaeo/cssquery-mootools.html) 02:40:23 INFO - PROCESS | 9149 | RSS: Main: 240062464 02:40:23 INFO - PROCESS | 9149 | 02:43:25 INFO - PROCESS | 9149 | Cycle 1(1): loaded http://localhost:39772/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39772/tests/dromaeo/cssquery-prototype.html) 02:43:25 INFO - PROCESS | 9149 | RSS: Main: 203345920 02:43:25 INFO - PROCESS | 9149 | 02:46:28 INFO - PROCESS | 9149 | Cycle 1(1): loaded http://localhost:39772/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39772/tests/dromaeo/cssquery-yui.html) 02:46:28 INFO - PROCESS | 9149 | RSS: Main: 205651968 02:46:28 INFO - PROCESS | 9149 | 02:49:30 INFO - PROCESS | 9149 | Cycle 1(1): loaded http://localhost:39772/tests/dromaeo/cssquery-yui.html (next: http://localhost:39772/tests/dromaeo/cssquery-dojo.html) 02:49:31 INFO - PROCESS | 9149 | RSS: Main: 231268352 02:49:31 INFO - PROCESS | 9149 | 02:49:31 INFO - PROCESS | 9149 | __start_tp_report 02:49:31 INFO - PROCESS | 9149 | _x_x_mozilla_page_load 02:49:31 INFO - PROCESS | 9149 | _x_x_mozilla_page_load_details 02:49:31 INFO - PROCESS | 9149 | |i|pagename|runs| 02:49:31 INFO - PROCESS | 9149 | |0;dojo.html;3203.983980080099;3213.1163929919285;3270.7710460267776;3273.41078605851;3291.6214635316937;5134.178531434971;5136.768845401956;5149.227615857623;5160.974195129023;5183.352080989872;5150.639455238135;5164.690118592877;5180.663256888309;5185.274061631365;5201.271821944931;4643.2802915548145;4715.056988602293;4720.268358404444;4747.1692453820615;4785.66500344976;4706.247000479924;4712.6229901607785;4744.383230180072;4748.216544270192;4749.240121580548;4640.350350950869;4644.140833945731;4725.9054818903605;4738.147133515983;4758.500357462469;4693.155232058211;4741.336212930192;4758.524147585248;4767.594754445876;4775.570198682118;4722.929156062662;4761.190597598416;4766.022965292142;4780.163471392492;4794.856154315376;4874.7562621868765;4979.601631869442;4997.2004479283505;5032.2703208035;5049.596032317406;5451.591130665176;5516.834494965157;5517;5518.586106042063;5526.032944234783;5538.584606154554;5541.2796336476;5547.944520554824;5557.472040156179;5562.694051827148;5041.59667226621;5114.948850511521;5158.690478571298;5183.792648294064;5235.450277720823;5546.91679624806;5587.580931430159;5616.691081990448;5618.943810561842;5624.3813180550105;5352.170413585901;5352.437994010651;5367.194920761839;5375.623706340597;5378.704171270618;5335.413104558495;5392.164214546751;5417.674939503642;5436.429174936654;5523.226748255248;5462.180672899097;5485.4788795064405;5494.450554944474;5494.752736126884;5502.477264659851;5475.67145971243;5477.507024367826;5479.205515200353;5487.835364939058;5521.1442226454965;4203.726757760797;4259.637930775857;4262.25410553152;4274.465691788527;4323.913521729548;3837.1174629835295;3861.7296789224483;3875.4380614810693;3877.922441551153;3879.670228030649;5112.514311140436;5192.870178245574;5251.291075704808;5253.054450198924;5276.234945932818;5423.403425623178;5455.154451060012;5504.697241651667;5513.889722205534;5553.805616803474;5207.453217412193;5229.398619158769;5232.2674825524455;5235.136202526616;5273.709945952933;4654.534546545318;4676.0647870426055;4806.255030470283;4815.494373090845;4820.060088282751;5606.635568688022;5612.831615051555;5655.179998900218;5658.547316214693;5671.234383358276;5505.917411238915;5524.254225679482;5527.53015993645;5527.5577953762795;5527.723613819373;5571.637843540157;5657.4908258256955;5687.317521897398;5697.259356283656;5705.4009329019855;5476.123820188751;5491;5492.697901615449;5497.312835895513;5502.009638264991;5529.391766905717;5553.861153471195;5561.888762224814;5564.888702226014;5599.160125980972;5221.425643179323;5319.707416092152;5359.062164121341;5413.918791218056;5456.427075157051;5405.918911216257;5411.83764487066;5417.485338892799;5421.132618781134;5431.34823821144;5315.548178404879;5324.0150572144275;5342.652727572696;5344.144936810092;5349.144136938071;5249.448807875118;5325.147976323769;5359.249705041219;5408.513233808976;5468.535174510212;5273.6572122811895;5275.841724748264;5281.366236051698;5284.81503147388;5315.787368505216 02:49:31 INFO - PROCESS | 9149 | |1;ext.html;559.5607448153198;579.9913001304978;585.4730742331901;595.3034949109541;611.226798100403;30720.53919191211;38312.616873831255;38522.22955540888;38539.61460385395;38539.99999999993;41342;42064;42097.368539471936;42163.15673686525;42179.36730949038;9011.909880901188;9188.540572971358;9238.815223695523;9254.722358329227;9256.490893000882;8826.293896488265;8959.417637853552;8973.46159230445;8977.102289771003;8977.685780997666;8934.28525717941;9000.954995225014;9016.233620142295;9018.368714189977;9023.233025192867;8919.910800891972;8978.461292322449;8988.370814042986;8990.145936136056;8991.685291014848;8866.866996994986;8896.332775041898;8922.553872306358;8983.730488085368;8985.820283594292;41980.790096049626;42281.36577951333;42384.152316953485;42417.36373954393;42435.78782106101;3549.4675798630155;3588.910277243064;3731.440283957428;3736.159364143073;3748.3815170496837;32251.516227256376;32381;32522;32526.837365813255;32575.83712081448;4320.645801839015;4377.606015458624;4389.495208051083;4407.052483715985;4416.712913660602;301442;303277;303295;303318;303593.4820325906;58299;59474.70262648659;59551.40448595458;64600.35399646038;64849;69956;72579;72799.63600181966;72829.27170728226;72903;17272.22274997628;17717;17730.468085957444;17774.200160992787;17777.822221777875;12086.214396064228;12194.085443591766;13857.4457021718;13869.445222191;14518.709625807425;20768.68846967297;21308.04113814882;21317.25389611356;21395.358139255848;21441.78558214429;8187.304079153219;8357.331413486907;8399.580020998925;8400.369972252105;8502.872456913152;1011.3274672342957;1063.7234319077095;1093.781243751253;1139.0944199361527;1229.1150371732338;28922.421551568852;30811.767529299024;31218.687813121578;31523;31603.841980789948;1118.7706520163347;1185.4606154199819;1207.927524348542;1211.6304527119137;1214.8906598406186;14180.290985450687;14850.628734281729;14929.477468288558;15248.695026099416;15782.921085394499;272452;274308;276449;277183;277278;51288;51765;51842.740786296585;51848.22227666588;51883.22175167376;1446.7106578684304;1486.6283429142713;1512.2438780609696;1522.0563250784362;1536.4775976168157;27877.58183627288;29459.263518412212;29494;29571.112866614036;30461.390772184874;42883.14233715371;42928;43514;43943;48047;207170;506813;511054;511904;512609;32111.35777284488;32761;32901.34197315992;32915.83542082274;33020;46322;46864.297035543816;47401;47431;47913.08347666054;39315.60684393119;39425.80287098546;39949.80025099856;40043.599564003984;40663.1867362657;38980.610193898836;39320.21359572735;40166;40268.39597405983;40560;39265;39439.60560394359;39768.403473947335;40046.799766000986;40268.59731402648;33372.165695857795;33561.16097097495;36774.63225367712;37028.81485592555;37883.052923677125;26790.196294111207;27023.594646080717;27131.72868271292;27265;27290.317742056606 02:49:31 INFO - PROCESS | 9149 | |2;jquery.html;387.70921808643516;397.3800870641798;399.7002248313765;400.43138742984956;401.17158068588344;14099.859001409983;16728.41450549231;17031.233594488247;19254.422367328967;19273.036348182588;17041.91479042606;17446.65106697865;17487.825121748778;17909.91045044773;18245.270189192415;4697.671163018582;5158.40678321994;5171.612129090315;5175.353080864892;5175.870603234912;4024.3762216856435;4165.64592009678;5095.3885533736;5394.568434525228;5612;5547.5007249347755;5571.609987300871;5578.972105139469;5602.13166959122;5610.102383618621;5687.459691329317;5694.971525142348;5704.657720536781;5717.828465146032;5726.427357264281;5497.147942068986;5499.972500137474;5724.713764311809;5740.655560666331;5743.195952566644;14099.22454265015;14165.78751318731;18669.159887805083;21167.25914592982;21499.355019349445;2252.200468833557;2294.219965211836;2329.3594261578032;2342.2621874109773;2391.186996421208;9788.657396991142;9948.303618746691;10227.079562839306;10404.479776011245;12920.22478651284;1925.5763731978943;1926.8843869367884;1983.8313743331835;1989.1546092910455;2003.158673357179;53990.73004634952;58925.821483570515;61174.388256117316;62362.68818655923;62567;10733.302335348177;10886.72783180411;10954.835677464844;10966.506507207196;11019;14558.781618275523;14657.780133298009;14660.780088298685;14666.779998300033;14720.852791471949;8629.69796057135;8667.913320866837;8669.176428239307;8722.694705685271;8740.8688869667;8304.792380190424;8460.57697115154;8729.607167677343;8755.430896991675;8791.780205494913;4484.484284307281;4766.7854946526795;4855.393075865517;4861.222204447342;4892.363992680928;1838.8533856154286;1872.354037856937;1898.2501911744785;1911.722800193964;1934.1006432009183;990.5691024404407;1063.2132222155703;1082.2240951958202;1094.6934858239706;1111.7109551516503;14697.77953330701;17099.487015389557;17138.31446742116;17760.733588996176;17924.820751792577;1039.4127318065268;1068.1775033224528;1068.631322193842;1115.5203262597;1122.539758698946;10079.395236285847;10229.437380943971;10271.897281027244;10345.793084138275;10412.271141020055;644634;648981;654918;686920;696053;77729.61135194288;79581.60209198917;79620.20379796244;80618.19381806224;80682;1097.7365432296351;1152.3777160333327;1180.8701042885275;1189.5836457239898;1222.743223922986;14694.191819450032;15191.316390762664;15216.771748424004;15431.61420964485;15507.844921551092;32278.83860580682;32894;33615;34615.307693845476;36280.818595907906;41346.365034043345;42236.080443993014;42984.35523467213;44283;44686.776566118264;7526.09686837583;8118.512889226666;8173.264406203471;8187.099419063779;8197.877031844408;10621.681349559525;11326.660200194008;11810.468528916048;11989.460474278503;12102.45538950767;9478.427822488562;10010.749731256778;10085.041921017491;10457.895421045692;10799.13606911461;3061.8928337508974;5090.872728181825;10043.4476103815;10175.440350780778;10376.844347334947;10193.796124077626;10315.12321452655;10842.186835987175;10871.130309575057;11005.394703291076;7638.770836874903;7667.463277570517;7846.921530784847;8025.678972841254;8161.428699991181;9937.850932236166;10572.735681608021;10717.517711702836;10869.402182879701;10907.18196135309 02:49:31 INFO - PROCESS | 9149 | |3;mootools.html;1451.8257809062914;1523.0633160606226;1590.0459724165503;1826.8812527185733;1968.2127149140333;7325.890111648323;8202.138775428584;8341.082480927093;8377.287930525912;8404.579771011455;8286.337093032558;8465.068842427328;8483.57582120893;8490.150984901522;8521.446106003106;2120.0989579428683;2172.2071443923014;2174.9891250543724;2445.669834572332;2466.235467005234;2420;2468.3458883395915;2475.2203056037292;2484.1305543059875;2486.11742831295;2382.297222319411;2429.7327293997646;2441.3042282949364;2445;2451.044092803808;2323.848949818256;2343.5664402085667;2350.3536527454917;2386.7971222446113;2395.6765836612008;2286.5998450271304;2302.5625131225015;2305.054927479742;2352.882355882199;2437.9390515237083;8176.754697359089;8190.8771368429525;8205.343572514244;8207.425480216387;8237.382196335298;5091.363579552556;5219.973900130513;5231.189165679326;5233.319668443078;5237.031149237403;3306.437905556061;3318.3529211803707;3362.546056282395;3399.7280217582534;3427.9657203428146;1227.957021504252;1241.782688029591;1255.8492980842266;1275.011865804;1278.4119305119657;11473;11506.07951363889;11509.884901150965;11513.309201447857;11516.366599837005;4579.7252164870215;4647.209974304309;4679.438467383868;4746.7389293589185;4765.523447655207;9809.607615695435;9812.067853553901;9865.358751681119;9928.255380846465;9950.054744799232;5261.237120617489;5261.579073674096;5273.551748101378;5274.841754747364;5277.261183434322;4772.689775164603;4778.402699662543;4825.782839772219;4827.227643577011;4829.710217386968;3659.817009149585;3730.515033045687;3944.861929832442;4007.73949693269;4077.7757223353;1246.8316777235138;1304.178367628388;1312.3241530611742;1320.9009324300716;1323.9139455935526;1393.4426229508279;1416.0370947755625;1421.047897908404;1442.4662874736414;1454.4618491158128;7644.426667999922;7649.120351159577;7686.192949740197;7700.037495313086;7715.537067775951;1200.6758175292623;1212.090931801149;1213.3751118174148;1215.617080619602;1225.7303393253649;6275.309715931244;6297.685115744194;6397.264314603787;6397.616143031433;6410;9621.615135394506;9866.901330986599;9883.011698830203;9995.450250236307;9995.550200240861;9705.854412183822;9789.804203915883;9861.112499874902;9873.802523949624;9902.55438505269;7836;7838.372930165573;7859.6463159157975;7910.762677119696;7921.049474063034;7410.4442166836625;7424.1462231844025;7524.699012039676;7545;7556.697732090654;8764.211220989886;8799.34004949644;8949.507777072064;8990.86513702282;9066.50134242623;9125.954370228106;9144.497052661902;9186.466659367088;9236.769080773034;9283.11810378013;7142.750003749844;7193.964030179815;7209.170945341143;7264.963675181591;7265.309795569412;6901.206361268519;7124.251953544803;7671.61641917913;7689.461737678309;7691.50005249657;7417.925820741723;7423.888641670272;7478.7382441616455;7566.205548417337;7571.3564347031115;7245.587110513399;7262.709491620487;7323;7323.450741194325;7326.450516211199;7109.75115870942;7129.322714342129;7200.423966082805;7234.276572342724;7426.331630153312;6941.618210998444;6946.826329341605;6990.685419156252;6991.6853741580735;6994;7155.212926577969;7155.391791697556;7163.391111755559;7268.600226987566;7274.96362518184 02:49:31 INFO - PROCESS | 9149 | |4;prototype.html;372.91422972716276;377.60351630787676;380.01196888090965;383.5531605679384;389.46254169246436;5932.169496270526;5976.581639285252;5983.012802887529;5987.9101813472835;6025.3372129065765;5937.37657545958;5942.524598032158;5943.4056594340655;5944.989351810192;5946.732397042133;4473.888152796182;4623.514530974249;4630.305454181883;4663.930041049387;4665;4648.814047438098;4656.5110663380365;4669.276262179367;4671.252599584067;4674.0418214266165;4435.33674871923;4512.842050528232;4529.614982726455;4630.583247507724;4632.397788287535;4591.334256532818;4606.493285738566;4616.953830461686;4621.052684199731;4631.282151266576;4060.4518390017265;4078.4290199372113;4083.612056854624;4086.0193553547233;4088.550259471456;5495.890082198333;5526.585506087019;5592.3009623797025;5759.107338362519;5762.510186634141;5374.677519348813;5383.865403364947;5388.649737767033;5389.245505629215;5391.379991301012;6292.685365731741;6315.0843127746675;6320.273168585625;6321.620702757849;6327;4432.911341773147;4449.822007119711;4486.69885733137;4492.483364413101;4519.751413672247;6498.9350106498805;6573.835654108686;6577.638229897354;6580.407763301278;6588.242352129519;4629.328747331618;4635.142498637695;4643.489216186217;4646.4888862225125;4649.139909116824;4694.2723877799;4699.976500117477;4701.177293973541;4701.200795864711;4705.082508910798;5205.817796377184;5360.544353729899;5365.517103460707;5378.97310513445;5379.381371142291;6314.116023756677;6345.777897773556;6354.586951848115;6355.1420558224045;6366.26787919386;1639.5573195237218;1659.9751003734953;1661.0615002523537;1664.2344521519994;1665.7168281392192;1133.2010932292715;1134.6652737442473;1135.437958210691;1135.5968631135993;1162;6115.694215289307;6118.541109416811;6133.325334213233;6141.969290153521;6142.600730952474;6520.739170433224;6523.543351965317;6524.249711283263;6527.738890444424;6529.967350163219;6036.034234522455;6136.539759518054;6137.5703700741415;6138.7237574309265;6157.599756015845;3474.756767026284;3500.544929159193;3503.1242189452637;3504.5969713482764;3506.1760486285702;6551.705173267214;6636.601803891782;6649.3018233085795;6692.163479565054;6766.357196066366;6766.424853887376;6767.2894346093935;6768.357006084414;6773.1872175338285;6777.152855893013;6816.147981502312;6837.3162683731225;6847.1783385994;6850.9314906850295;6851.623160726208;6423.325550817284;6565.737370505126;6578.276389597045;6581.769638062837;6585.1439312889015;6481.4814814815645;6488.351164883474;6492.35076492347;6493.383128602775;6495.480361570969;6820.340067373629;6822.488313376417;6829.317068293131;6830.351116643911;6832.59004459734;4518.322251662277;4602.309653551994;4602.838900638461;4610.331501932268;4623.42207224097;6546.607203567801;6550.443212327005;6568.376004279586;6580.045893345342;6581.769638062645;6382.904256436064;6419.871602568016;6420.839479013062;6422.42198202164;6430.164078669743;6285.214348206474;6325.525585581192;6381.234251889803;6381.329960354096;6389.233292004989;6246.500279977682;6256;6290.622562646073;6297.874042519215;6306.400891915261;6383.425491705769;6418.711157997995;6442.355764423708;6444.226692796707;6449.871002580016;6140.109684095692;6262.2172228471445;6273.62358258506;6280.685965701788;6293.433590976834 02:49:31 INFO - PROCESS | 9149 | |5;yui.html;932.7261312792102;939.4785893828926;945.1588086602925;976.9169620582251;978.8874279457856;14552.41790328387;14701.558953231406;14817.18505482198;14848.03487773294;14850.405983760636;13776.793348099787;13941.860581394183;13975.930120349409;14441;14444.06113602615;906.8730377747104;916.4318122763896;917.9082091790801;921.4655499810094;922.294444749767;921.7695576105973;926.8146370725848;926.8609708543705;927.2581934452411;927.837628415028;967.7435479597913;975.6146322202726;976.4483067067084;979.1921664626676;979.3536266064399;968.8692026576427;971.489967766928;972.5477652891369;973.2214228617078;974.7709288317204;710.0591715976352;711.6939715922151;712.6436781609195;713.1264201353353;713.989290160648;13802.447902083904;13838.377273022737;13888.93055534726;13904.58286251414;13908.860911390857;12046.518139274418;12057.758844823142;12232.021438284915;12262.141650084497;12321.815172772416;10579.312344697648;10786;10817.513211905483;10820.945895270552;10957.17821163416;3553.893383198508;3672.265546890606;3688;3696.0944568580603;3697.279030589036;45281.320780188325;45967.31049034267;48590.757046214545;50873.491265087614;51118.7444062781;11223.382713950648;11319;11507;11612.12909031826;11739.647810565697;19974.10116544759;20281.290154844508;20292.695609565868;20298.594028119354;20303.390898273075;7628.847423051508;7749.263819937097;7876.763697089096;7876.842463150705;8294.792630184294;4371.475422949266;4499.595036446735;4588.151192029485;4597.195490789099;4649.651276154302;3116.080756176888;3156.3213909009673;3160.5259211118055;3162.5888634477833;3166.255929856482;566.7138095261867;574.9712514374264;575.2148317546519;575.6747437697687;586.0154939701257;724.5871943147728;736.8784150615088;747.4431548496405;754.35125791819;766.4634755671052;9192.21866141372;9416.670416535526;9559.665411710557;9573.808523829624;9590.90409095914;602.5661523702927;631.3497097989078;640.6743521018673;643.5302229372584;650.8991106378519;4298.914021719548;4427.46870375557;4459.509453960061;4532;4583.472900616472;59018.70490647519;59358.40641593615;59665.403345965984;60071.39928600658;60393.69803151044;53173.734131329096;55089.72455137699;55312.44687553153;55562.44437555573;57577;49755.75122124366;50259.74870125699;50553;50888.49111508911;51378.48621513737;9322.300827437834;9568.61725530971;9619.951900240454;9626.566804493674;9749.07383798538;35424.11439714028;35471.82264088663;37318.25363492661;37908.241835163695;38617.42073868838;44132.55867441413;45245.54754452413;48847.267290991374;48977.755111224214;49907.25139122989;12333.383330833243;12496.750064998467;12564.120511564468;12655.93672031634;12668.809967850306;13381.130226535244;13438.260895650443;13468.595942121752;13627.727445450837;14021.929890350482;11764.705882353146;11923.224990375598;12090.879091208975;12591.244525328144;12808.423620937267;12454.937725311316;12584.30786306762;12613.243205407705;12953.54662586805;13196.274204918822;12249.938750306192;12278.877211228131;12476.905225519366;12899.871001289866;13052.804207937079;10316.381017138996;10351.741206469596;10371.481425928523;10392;10600.734981625521;10210.489475526045;10469.68590942273;10560.841587376042;10598.89401105979;10721.571137154426 02:49:31 INFO - PROCESS | 9149 | __end_tp_report 02:49:31 INFO - PROCESS | 9149 | __start_cc_report 02:49:31 INFO - PROCESS | 9149 | _x_x_mozilla_cycle_collect,813 02:49:31 INFO - PROCESS | 9149 | __end_cc_report 02:49:31 INFO - PROCESS | 9149 | __startTimestamp1456656571085__endTimestamp 02:49:31 INFO - PROCESS | 9149 | 02:49:31 INFO - PROCESS | 9149 | ------- Summary: start ------- 02:49:31 INFO - PROCESS | 9149 | Number of tests: 6 02:49:31 INFO - PROCESS | 9149 | 02:49:31 INFO - PROCESS | 9149 | [#0] dojo.html Cycles:165 Average:5129.19 Median:5315.79 stddev:530.61 (10.0%) stddev-sans-first:510.29 02:49:31 INFO - PROCESS | 9149 | Values: 3204.0 3213.1 3270.8 3273.4 3291.6 5134.2 5136.8 5149.2 5161.0 5183.4 5150.6 5164.7 5180.7 5185.3 5201.3 4643.3 4715.1 4720.3 4747.2 4785.7 4706.2 4712.6 4744.4 4748.2 4749.2 4640.4 4644.1 4725.9 4738.1 4758.5 4693.2 4741.3 4758.5 4767.6 4775.6 4722.9 4761.2 4766.0 4780.2 4794.9 4874.8 4979.6 4997.2 5032.3 5049.6 5451.6 5516.8 5517.0 5518.6 5526.0 5538.6 5541.3 5547.9 5557.5 5562.7 5041.6 5114.9 5158.7 5183.8 5235.5 5546.9 5587.6 5616.7 5618.9 5624.4 5352.2 5352.4 5367.2 5375.6 5378.7 5335.4 5392.2 5417.7 5436.4 5523.2 5462.2 5485.5 5494.5 5494.8 5502.5 5475.7 5477.5 5479.2 5487.8 5521.1 4203.7 4259.6 4262.3 4274.5 4323.9 3837.1 3861.7 3875.4 3877.9 3879.7 5112.5 5192.9 5251.3 5253.1 5276.2 5423.4 5455.2 5504.7 5513.9 5553.8 5207.5 5229.4 5232.3 5235.1 5273.7 4654.5 4676.1 4806.3 4815.5 4820.1 5606.6 5612.8 5655.2 5658.5 5671.2 5505.9 5524.3 5527.5 5527.6 5527.7 5571.6 5657.5 5687.3 5697.3 5705.4 5476.1 5491.0 5492.7 5497.3 5502.0 5529.4 5553.9 5561.9 5564.9 5599.2 5221.4 5319.7 5359.1 5413.9 5456.4 5405.9 5411.8 5417.5 5421.1 5431.3 5315.5 5324.0 5342.7 5344.1 5349.1 5249.4 5325.1 5359.2 5408.5 5468.5 5273.7 5275.8 5281.4 5284.8 5315.8 02:49:31 INFO - PROCESS | 9149 | 02:49:31 INFO - PROCESS | 9149 | [#1] ext.html Cycles:180 Average:51864.33 Median:39432.70 stddev:94722.75 (240.2%) stddev-sans-first:94910.15 02:49:31 INFO - PROCESS | 9149 | Values: 559.6 580.0 585.5 595.3 611.2 30720.5 38312.6 38522.2 38539.6 38540.0 41342.0 42064.0 42097.4 42163.2 42179.4 9011.9 9188.5 9238.8 9254.7 9256.5 8826.3 8959.4 8973.5 8977.1 8977.7 8934.3 9001.0 9016.2 9018.4 9023.2 8919.9 8978.5 8988.4 8990.1 8991.7 8866.9 8896.3 8922.6 8983.7 8985.8 41980.8 42281.4 42384.2 42417.4 42435.8 3549.5 3588.9 3731.4 3736.2 3748.4 32251.5 32381.0 32522.0 32526.8 32575.8 4320.6 4377.6 4389.5 4407.1 4416.7 301442.0 303277.0 303295.0 303318.0 303593.5 58299.0 59474.7 59551.4 64600.4 64849.0 69956.0 72579.0 72799.6 72829.3 72903.0 17272.2 17717.0 17730.5 17774.2 17777.8 12086.2 12194.1 13857.4 13869.4 14518.7 20768.7 21308.0 21317.3 21395.4 21441.8 8187.3 8357.3 8399.6 8400.4 8502.9 1011.3 1063.7 1093.8 1139.1 1229.1 28922.4 30811.8 31218.7 31523.0 31603.8 1118.8 1185.5 1207.9 1211.6 1214.9 14180.3 14850.6 14929.5 15248.7 15782.9 272452.0 274308.0 276449.0 277183.0 277278.0 51288.0 51765.0 51842.7 51848.2 51883.2 1446.7 1486.6 1512.2 1522.1 1536.5 27877.6 29459.3 29494.0 29571.1 30461.4 42883.1 42928.0 43514.0 43943.0 48047.0 207170.0 506813.0 511054.0 511904.0 512609.0 32111.4 32761.0 32901.3 32915.8 33020.0 46322.0 46864.3 47401.0 47431.0 47913.1 39315.6 39425.8 39949.8 40043.6 40663.2 38980.6 39320.2 40166.0 40268.4 40560.0 39265.0 39439.6 39768.4 40046.8 40268.6 33372.2 33561.2 36774.6 37028.8 37883.1 26790.2 27023.6 27131.7 27265.0 27290.3 02:49:31 INFO - PROCESS | 9149 | 02:49:31 INFO - PROCESS | 9149 | [#2] jquery.html Cycles:180 Average:31658.61 Median:2335.81 stddev:108863.42 (4660.6%) stddev-sans-first:109143.48 02:49:31 INFO - PROCESS | 9149 | Values: 387.7 397.4 399.7 400.4 401.2 14099.9 16728.4 17031.2 19254.4 19273.0 17041.9 17446.7 17487.8 17909.9 18245.3 4697.7 5158.4 5171.6 5175.4 5175.9 4024.4 4165.6 5095.4 5394.6 5612.0 5547.5 5571.6 5579.0 5602.1 5610.1 5687.5 5695.0 5704.7 5717.8 5726.4 5497.1 5500.0 5724.7 5740.7 5743.2 14099.2 14165.8 18669.2 21167.3 21499.4 2252.2 2294.2 2329.4 2342.3 2391.2 9788.7 9948.3 10227.1 10404.5 12920.2 1925.6 1926.9 1983.8 1989.2 2003.2 53990.7 58925.8 61174.4 62362.7 62567.0 10733.3 10886.7 10954.8 10966.5 11019.0 14558.8 14657.8 14660.8 14666.8 14720.9 8629.7 8667.9 8669.2 8722.7 8740.9 8304.8 8460.6 8729.6 8755.4 8791.8 4484.5 4766.8 4855.4 4861.2 4892.4 1838.9 1872.4 1898.3 1911.7 1934.1 990.6 1063.2 1082.2 1094.7 1111.7 14697.8 17099.5 17138.3 17760.7 17924.8 1039.4 1068.2 1068.6 1115.5 1122.5 10079.4 10229.4 10271.9 10345.8 10412.3 644634.0 648981.0 654918.0 686920.0 696053.0 77729.6 79581.6 79620.2 80618.2 80682.0 1097.7 1152.4 1180.9 1189.6 1222.7 14694.2 15191.3 15216.8 15431.6 15507.8 32278.8 32894.0 33615.0 34615.3 36280.8 41346.4 42236.1 42984.4 44283.0 44686.8 7526.1 8118.5 8173.3 8187.1 8197.9 10621.7 11326.7 11810.5 11989.5 12102.5 9478.4 10010.7 10085.0 10457.9 10799.1 3061.9 5090.9 10043.4 10175.4 10376.8 10193.8 10315.1 10842.2 10871.1 11005.4 7638.8 7667.5 7846.9 8025.7 8161.4 9937.9 10572.7 10717.5 10869.4 10907.2 02:49:31 INFO - PROCESS | 9149 | 02:49:31 INFO - PROCESS | 9149 | [#3] mootools.html Cycles:180 Average:5836.99 Median:6921.41 stddev:2976.44 (43.0%) stddev-sans-first:2966.54 02:49:31 INFO - PROCESS | 9149 | Values: 1451.8 1523.1 1590.0 1826.9 1968.2 7325.9 8202.1 8341.1 8377.3 8404.6 8286.3 8465.1 8483.6 8490.2 8521.4 2120.1 2172.2 2175.0 2445.7 2466.2 2420.0 2468.3 2475.2 2484.1 2486.1 2382.3 2429.7 2441.3 2445.0 2451.0 2323.8 2343.6 2350.4 2386.8 2395.7 2286.6 2302.6 2305.1 2352.9 2437.9 8176.8 8190.9 8205.3 8207.4 8237.4 5091.4 5220.0 5231.2 5233.3 5237.0 3306.4 3318.4 3362.5 3399.7 3428.0 1228.0 1241.8 1255.8 1275.0 1278.4 11473.0 11506.1 11509.9 11513.3 11516.4 4579.7 4647.2 4679.4 4746.7 4765.5 9809.6 9812.1 9865.4 9928.3 9950.1 5261.2 5261.6 5273.6 5274.8 5277.3 4772.7 4778.4 4825.8 4827.2 4829.7 3659.8 3730.5 3944.9 4007.7 4077.8 1246.8 1304.2 1312.3 1320.9 1323.9 1393.4 1416.0 1421.0 1442.5 1454.5 7644.4 7649.1 7686.2 7700.0 7715.5 1200.7 1212.1 1213.4 1215.6 1225.7 6275.3 6297.7 6397.3 6397.6 6410.0 9621.6 9866.9 9883.0 9995.5 9995.6 9705.9 9789.8 9861.1 9873.8 9902.6 7836.0 7838.4 7859.6 7910.8 7921.0 7410.4 7424.1 7524.7 7545.0 7556.7 8764.2 8799.3 8949.5 8990.9 9066.5 9126.0 9144.5 9186.5 9236.8 9283.1 7142.8 7194.0 7209.2 7265.0 7265.3 6901.2 7124.3 7671.6 7689.5 7691.5 7417.9 7423.9 7478.7 7566.2 7571.4 7245.6 7262.7 7323.0 7323.5 7326.5 7109.8 7129.3 7200.4 7234.3 7426.3 6941.6 6946.8 6990.7 6991.7 6994.0 7155.2 7155.4 7163.4 7268.6 7275.0 02:49:31 INFO - PROCESS | 9149 | 02:49:31 INFO - PROCESS | 9149 | [#4] prototype.html Cycles:180 Average:5341.81 Median:6075.86 stddev:1583.25 (26.1%) stddev-sans-first:1543.14 02:49:31 INFO - PROCESS | 9149 | Values: 372.9 377.6 380.0 383.6 389.5 5932.2 5976.6 5983.0 5987.9 6025.3 5937.4 5942.5 5943.4 5945.0 5946.7 4473.9 4623.5 4630.3 4663.9 4665.0 4648.8 4656.5 4669.3 4671.3 4674.0 4435.3 4512.8 4529.6 4630.6 4632.4 4591.3 4606.5 4617.0 4621.1 4631.3 4060.5 4078.4 4083.6 4086.0 4088.6 5495.9 5526.6 5592.3 5759.1 5762.5 5374.7 5383.9 5388.6 5389.2 5391.4 6292.7 6315.1 6320.3 6321.6 6327.0 4432.9 4449.8 4486.7 4492.5 4519.8 6498.9 6573.8 6577.6 6580.4 6588.2 4629.3 4635.1 4643.5 4646.5 4649.1 4694.3 4700.0 4701.2 4701.2 4705.1 5205.8 5360.5 5365.5 5379.0 5379.4 6314.1 6345.8 6354.6 6355.1 6366.3 1639.6 1660.0 1661.1 1664.2 1665.7 1133.2 1134.7 1135.4 1135.6 1162.0 6115.7 6118.5 6133.3 6142.0 6142.6 6520.7 6523.5 6524.2 6527.7 6530.0 6036.0 6136.5 6137.6 6138.7 6157.6 3474.8 3500.5 3503.1 3504.6 3506.2 6551.7 6636.6 6649.3 6692.2 6766.4 6766.4 6767.3 6768.4 6773.2 6777.2 6816.1 6837.3 6847.2 6850.9 6851.6 6423.3 6565.7 6578.3 6581.8 6585.1 6481.5 6488.4 6492.4 6493.4 6495.5 6820.3 6822.5 6829.3 6830.4 6832.6 4518.3 4602.3 4602.8 4610.3 4623.4 6546.6 6550.4 6568.4 6580.0 6581.8 6382.9 6419.9 6420.8 6422.4 6430.2 6285.2 6325.5 6381.2 6381.3 6389.2 6246.5 6256.0 6290.6 6297.9 6306.4 6383.4 6418.7 6442.4 6444.2 6449.9 6140.1 6262.2 6273.6 6280.7 6293.4 02:49:31 INFO - PROCESS | 9149 | 02:49:31 INFO - PROCESS | 9149 | [#5] yui.html Cycles:180 Average:14738.03 Median:24872.57 stddev:16792.11 (67.5%) stddev-sans-first:16807.22 02:49:31 INFO - PROCESS | 9149 | Values: 932.7 939.5 945.2 976.9 978.9 14552.4 14701.6 14817.2 14848.0 14850.4 13776.8 13941.9 13975.9 14441.0 14444.1 906.9 916.4 917.9 921.5 922.3 921.8 926.8 926.9 927.3 927.8 967.7 975.6 976.4 979.2 979.4 968.9 971.5 972.5 973.2 974.8 710.1 711.7 712.6 713.1 714.0 13802.4 13838.4 13888.9 13904.6 13908.9 12046.5 12057.8 12232.0 12262.1 12321.8 10579.3 10786.0 10817.5 10820.9 10957.2 3553.9 3672.3 3688.0 3696.1 3697.3 45281.3 45967.3 48590.8 50873.5 51118.7 11223.4 11319.0 11507.0 11612.1 11739.6 19974.1 20281.3 20292.7 20298.6 20303.4 7628.8 7749.3 7876.8 7876.8 8294.8 4371.5 4499.6 4588.2 4597.2 4649.7 3116.1 3156.3 3160.5 3162.6 3166.3 566.7 575.0 575.2 575.7 586.0 724.6 736.9 747.4 754.4 766.5 9192.2 9416.7 9559.7 9573.8 9590.9 602.6 631.3 640.7 643.5 650.9 4298.9 4427.5 4459.5 4532.0 4583.5 59018.7 59358.4 59665.4 60071.4 60393.7 53173.7 55089.7 55312.4 55562.4 57577.0 49755.8 50259.7 50553.0 50888.5 51378.5 9322.3 9568.6 9620.0 9626.6 9749.1 35424.1 35471.8 37318.3 37908.2 38617.4 44132.6 45245.5 48847.3 48977.8 49907.3 12333.4 12496.8 12564.1 12655.9 12668.8 13381.1 13438.3 13468.6 13627.7 14021.9 11764.7 11923.2 12090.9 12591.2 12808.4 12454.9 12584.3 12613.2 12953.5 13196.3 12249.9 12278.9 12476.9 12899.9 13052.8 10316.4 10351.7 10371.5 10392.0 10600.7 10210.5 10469.7 10560.8 10598.9 10721.6 02:49:31 INFO - PROCESS | 9149 | -------- Summary: end -------- 02:49:31 INFO - PROCESS | 9149 | 02:49:31 INFO - TEST-INFO | 9149: exit 0 02:49:31 INFO - TEST-OK | dromaeo_css | took 1110897ms 02:49:31 INFO - TEST-START | kraken 02:49:31 INFO - operating with platform_type : linux_ 02:49:31 INFO - Initialising browser for kraken test... 02:49:31 INFO - TEST-INFO | started process 9332 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9xwlFz/profile http://localhost:39772/getInfo.html) 02:49:35 INFO - PROCESS | 9332 | __metrics Screen width/height:1600/1200 02:49:35 INFO - PROCESS | 9332 | colorDepth:24 02:49:35 INFO - PROCESS | 9332 | Browser inner width/height: 1024/697 02:49:35 INFO - PROCESS | 9332 | __metrics 02:49:35 INFO - PROCESS | 9332 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:49:37 INFO - TEST-INFO | 9332: exit 0 02:49:37 INFO - Browser initialized. 02:49:37 INFO - Running cycle 1/1 for kraken test... 02:49:37 INFO - TEST-INFO | started process 9425 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9xwlFz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:49:48 INFO - PROCESS | 9425 | RSS: Main: 137957376 02:49:48 INFO - PROCESS | 9425 | 02:49:51 INFO - PROCESS | 9425 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39772/tests/kraken/driver.html?testName=audio-beat-detection) 02:49:51 INFO - PROCESS | 9425 | RSS: Main: 171503616 02:49:51 INFO - PROCESS | 9425 | 02:49:54 INFO - PROCESS | 9425 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39772/tests/kraken/driver.html?testName=audio-dft) 02:49:55 INFO - PROCESS | 9425 | RSS: Main: 168742912 02:49:55 INFO - PROCESS | 9425 | 02:49:57 INFO - PROCESS | 9425 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39772/tests/kraken/driver.html?testName=audio-fft) 02:49:58 INFO - PROCESS | 9425 | RSS: Main: 167735296 02:49:58 INFO - PROCESS | 9425 | 02:50:00 INFO - PROCESS | 9425 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39772/tests/kraken/driver.html?testName=audio-oscillator) 02:50:01 INFO - PROCESS | 9425 | RSS: Main: 168820736 02:50:01 INFO - PROCESS | 9425 | 02:50:03 INFO - PROCESS | 9425 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39772/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:50:03 INFO - PROCESS | 9425 | RSS: Main: 164294656 02:50:03 INFO - PROCESS | 9425 | 02:50:06 INFO - PROCESS | 9425 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39772/tests/kraken/driver.html?testName=imaging-darkroom) 02:50:07 INFO - PROCESS | 9425 | RSS: Main: 164663296 02:50:07 INFO - PROCESS | 9425 | 02:50:10 INFO - PROCESS | 9425 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39772/tests/kraken/driver.html?testName=imaging-desaturate) 02:50:11 INFO - PROCESS | 9425 | RSS: Main: 166387712 02:50:11 INFO - PROCESS | 9425 | 02:50:13 INFO - PROCESS | 9425 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39772/tests/kraken/driver.html?testName=json-parse-financial) 02:50:14 INFO - PROCESS | 9425 | RSS: Main: 165679104 02:50:14 INFO - PROCESS | 9425 | 02:50:16 INFO - PROCESS | 9425 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39772/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:50:16 INFO - PROCESS | 9425 | RSS: Main: 169779200 02:50:16 INFO - PROCESS | 9425 | 02:50:18 INFO - PROCESS | 9425 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39772/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:50:18 INFO - PROCESS | 9425 | RSS: Main: 169050112 02:50:18 INFO - PROCESS | 9425 | 02:50:20 INFO - PROCESS | 9425 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39772/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:50:21 INFO - PROCESS | 9425 | RSS: Main: 174542848 02:50:21 INFO - PROCESS | 9425 | 02:50:23 INFO - PROCESS | 9425 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39772/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:50:24 INFO - PROCESS | 9425 | RSS: Main: 182743040 02:50:24 INFO - PROCESS | 9425 | 02:50:26 INFO - PROCESS | 9425 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39772/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:50:27 INFO - PROCESS | 9425 | RSS: Main: 179859456 02:50:27 INFO - PROCESS | 9425 | 02:50:29 INFO - PROCESS | 9425 | Cycle 1(1): loaded http://localhost:39772/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39772/tests/kraken/driver.html?testName=ai-astar) 02:50:29 INFO - PROCESS | 9425 | RSS: Main: 242282496 02:50:29 INFO - PROCESS | 9425 | 02:50:29 INFO - PROCESS | 9425 | __start_tp_report 02:50:29 INFO - PROCESS | 9425 | _x_x_mozilla_page_load 02:50:29 INFO - PROCESS | 9425 | _x_x_mozilla_page_load_details 02:50:29 INFO - PROCESS | 9425 | |i|pagename|runs| 02:50:29 INFO - PROCESS | 9425 | |0;ai-astar;110;110;104;109;110;110;100;110;109;110 02:50:29 INFO - PROCESS | 9425 | |1;audio-beat-detection;146;129;155;180;124;151;150;124;163;123 02:50:29 INFO - PROCESS | 9425 | |2;audio-dft;160;161;161;160;160;160;161;162;161;159 02:50:29 INFO - PROCESS | 9425 | |3;audio-fft;74;75;73;157;72;73;72;76;144;74 02:50:29 INFO - PROCESS | 9425 | |4;audio-oscillator;95;95;137;95;95;95;144;95;95;136 02:50:29 INFO - PROCESS | 9425 | |5;imaging-gaussian-blur;109;109;109;109;109;109;109;111;109;109 02:50:29 INFO - PROCESS | 9425 | |6;imaging-darkroom;146;147;146;146;146;147;145;146;146;146 02:50:29 INFO - PROCESS | 9425 | |7;imaging-desaturate;96;95;96;95;96;95;96;95;96;96 02:50:29 INFO - PROCESS | 9425 | |8;json-parse-financial;52;53;54;53;54;56;58;54;52;52 02:50:29 INFO - PROCESS | 9425 | |9;json-stringify-tinderbox;65;65;64;65;65;66;65;65;66;66 02:50:29 INFO - PROCESS | 9425 | |10;stanford-crypto-aes;79;81;80;80;80;80;81;80;80;81 02:50:29 INFO - PROCESS | 9425 | |11;stanford-crypto-ccm;110;109;112;112;118;112;111;109;113;112 02:50:29 INFO - PROCESS | 9425 | |12;stanford-crypto-pbkdf2;129;127;138;135;135;137;138;135;136;135 02:50:29 INFO - PROCESS | 9425 | |13;stanford-crypto-sha256-iterative;68;68;68;66;64;66;65;64;66;65 02:50:29 INFO - PROCESS | 9425 | __end_tp_report 02:50:29 INFO - PROCESS | 9425 | __start_cc_report 02:50:29 INFO - PROCESS | 9425 | _x_x_mozilla_cycle_collect,924 02:50:29 INFO - PROCESS | 9425 | __end_cc_report 02:50:29 INFO - PROCESS | 9425 | __startTimestamp1456656629337__endTimestamp 02:50:29 INFO - PROCESS | 9425 | 02:50:29 INFO - PROCESS | 9425 | ------- Summary: start ------- 02:50:29 INFO - PROCESS | 9425 | Number of tests: 14 02:50:29 INFO - PROCESS | 9425 | 02:50:29 INFO - PROCESS | 9425 | [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:3.43 (3.1%) stddev-sans-first:3.57 02:50:29 INFO - PROCESS | 9425 | Values: 110.0 110.0 104.0 109.0 110.0 110.0 100.0 110.0 109.0 110.0 02:50:29 INFO - PROCESS | 9425 | 02:50:29 INFO - PROCESS | 9425 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:150.50 stddev:19.24 (12.8%) stddev-sans-first:20.40 02:50:29 INFO - PROCESS | 9425 | Values: 146.0 129.0 155.0 180.0 124.0 151.0 150.0 124.0 163.0 123.0 02:50:29 INFO - PROCESS | 9425 | 02:50:29 INFO - PROCESS | 9425 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 02:50:29 INFO - PROCESS | 9425 | Values: 160.0 161.0 161.0 160.0 160.0 160.0 161.0 162.0 161.0 159.0 02:50:29 INFO - PROCESS | 9425 | 02:50:29 INFO - PROCESS | 9425 | [#3] audio-fft Cycles:10 Average:89.00 Median:73.50 stddev:32.58 (44.3%) stddev-sans-first:34.10 02:50:29 INFO - PROCESS | 9425 | Values: 74.0 75.0 73.0 157.0 72.0 73.0 72.0 76.0 144.0 74.0 02:50:29 INFO - PROCESS | 9425 | 02:50:29 INFO - PROCESS | 9425 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:95.00 stddev:21.35 (22.5%) stddev-sans-first:22.11 02:50:29 INFO - PROCESS | 9425 | Values: 95.0 95.0 137.0 95.0 95.0 95.0 144.0 95.0 95.0 136.0 02:50:29 INFO - PROCESS | 9425 | 02:50:29 INFO - PROCESS | 9425 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 02:50:29 INFO - PROCESS | 9425 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 111.0 109.0 109.0 02:50:29 INFO - PROCESS | 9425 | 02:50:29 INFO - PROCESS | 9425 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 02:50:29 INFO - PROCESS | 9425 | Values: 146.0 147.0 146.0 146.0 146.0 147.0 145.0 146.0 146.0 146.0 02:50:29 INFO - PROCESS | 9425 | 02:50:29 INFO - PROCESS | 9425 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:50:29 INFO - PROCESS | 9425 | Values: 96.0 95.0 96.0 95.0 96.0 95.0 96.0 95.0 96.0 96.0 02:50:29 INFO - PROCESS | 9425 | 02:50:29 INFO - PROCESS | 9425 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:1.93 (3.6%) stddev-sans-first:1.94 02:50:29 INFO - PROCESS | 9425 | Values: 52.0 53.0 54.0 53.0 54.0 56.0 58.0 54.0 52.0 52.0 02:50:29 INFO - PROCESS | 9425 | 02:50:29 INFO - PROCESS | 9425 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 02:50:29 INFO - PROCESS | 9425 | Values: 65.0 65.0 64.0 65.0 65.0 66.0 65.0 65.0 66.0 66.0 02:50:29 INFO - PROCESS | 9425 | 02:50:29 INFO - PROCESS | 9425 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.00 stddev:0.63 (0.8%) stddev-sans-first:0.50 02:50:29 INFO - PROCESS | 9425 | Values: 79.0 81.0 80.0 80.0 80.0 80.0 81.0 80.0 80.0 81.0 02:50:29 INFO - PROCESS | 9425 | 02:50:29 INFO - PROCESS | 9425 | [#11] stanford-crypto-ccm Cycles:10 Average:111.80 Median:112.00 stddev:2.57 (2.3%) stddev-sans-first:2.65 02:50:29 INFO - PROCESS | 9425 | Values: 110.0 109.0 112.0 112.0 118.0 112.0 111.0 109.0 113.0 112.0 02:50:29 INFO - PROCESS | 9425 | 02:50:29 INFO - PROCESS | 9425 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.50 Median:135.50 stddev:3.66 (2.7%) stddev-sans-first:3.30 02:50:29 INFO - PROCESS | 9425 | Values: 129.0 127.0 138.0 135.0 135.0 137.0 138.0 135.0 136.0 135.0 02:50:29 INFO - PROCESS | 9425 | 02:50:29 INFO - PROCESS | 9425 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.56 (2.4%) stddev-sans-first:1.48 02:50:29 INFO - PROCESS | 9425 | Values: 68.0 68.0 68.0 66.0 64.0 66.0 65.0 64.0 66.0 65.0 02:50:29 INFO - PROCESS | 9425 | -------- Summary: end -------- 02:50:29 INFO - PROCESS | 9425 | 02:50:30 INFO - TEST-INFO | 9425: exit 0 02:50:30 INFO - TEST-OK | kraken | took 58542ms 02:50:30 INFO - TEST-START | v8_7 02:50:30 INFO - operating with platform_type : linux_ 02:50:30 INFO - Initialising browser for v8_7 test... 02:50:30 INFO - TEST-INFO | started process 9678 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprtGxFU/profile http://localhost:39772/getInfo.html) 02:50:34 INFO - PROCESS | 9678 | __metrics Screen width/height:1600/1200 02:50:34 INFO - PROCESS | 9678 | colorDepth:24 02:50:34 INFO - PROCESS | 9678 | Browser inner width/height: 1024/697 02:50:34 INFO - PROCESS | 9678 | __metrics 02:50:34 INFO - PROCESS | 9678 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:50:35 INFO - TEST-INFO | 9678: exit 0 02:50:35 INFO - Browser initialized. 02:50:35 INFO - Running cycle 1/1 for v8_7 test... 02:50:35 INFO - TEST-INFO | started process 9771 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprtGxFU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:50:47 INFO - PROCESS | 9771 | RSS: Main: 137506816 02:50:47 INFO - PROCESS | 9771 | 02:51:09 INFO - PROCESS | 9771 | Cycle 1(1): loaded http://localhost:39772/tests/v8_7/run.html (next: http://localhost:39772/tests/v8_7/run.html) 02:51:09 INFO - PROCESS | 9771 | RSS: Main: 421318656 02:51:09 INFO - PROCESS | 9771 | 02:51:09 INFO - PROCESS | 9771 | __start_tp_report 02:51:09 INFO - PROCESS | 9771 | _x_x_mozilla_page_load 02:51:09 INFO - PROCESS | 9771 | _x_x_mozilla_page_load_details 02:51:09 INFO - PROCESS | 9771 | |i|pagename|runs| 02:51:09 INFO - PROCESS | 9771 | |0;Richards;167.0843776106934 02:51:09 INFO - PROCESS | 9771 | |1;DeltaBlue;170.24174327545114 02:51:09 INFO - PROCESS | 9771 | |2;Encrypt;279.72027972027973 02:51:09 INFO - PROCESS | 9771 | |3;Decrypt;5251.308900523561 02:51:09 INFO - PROCESS | 9771 | |4;RayTrace;1008.0645161290323 02:51:09 INFO - PROCESS | 9771 | |5;Earley;620.3473945409429 02:51:09 INFO - PROCESS | 9771 | |6;Boyer;11010.989010989011 02:51:09 INFO - PROCESS | 9771 | |7;RegExp;39365.38461538462 02:51:09 INFO - PROCESS | 9771 | |8;Splay;527.5013095861708 02:51:09 INFO - PROCESS | 9771 | |9;NavierStokes;4826.923076923077 02:51:09 INFO - PROCESS | 9771 | __end_tp_report 02:51:09 INFO - PROCESS | 9771 | __startTimestamp1456656669951__endTimestamp 02:51:09 INFO - PROCESS | 9771 | 02:51:09 INFO - PROCESS | 9771 | ------- Summary: start ------- 02:51:09 INFO - PROCESS | 9771 | Number of tests: 10 02:51:09 INFO - PROCESS | 9771 | 02:51:09 INFO - PROCESS | 9771 | [#0] Richards Cycles:1 Average:167.08 Median:167.08 stddev:0.00 (0.0%) 02:51:09 INFO - PROCESS | 9771 | Values: 167.1 02:51:09 INFO - PROCESS | 9771 | 02:51:09 INFO - PROCESS | 9771 | [#1] DeltaBlue Cycles:1 Average:170.24 Median:170.24 stddev:0.00 (0.0%) 02:51:09 INFO - PROCESS | 9771 | Values: 170.2 02:51:09 INFO - PROCESS | 9771 | 02:51:09 INFO - PROCESS | 9771 | [#2] Encrypt Cycles:1 Average:279.72 Median:279.72 stddev:0.00 (0.0%) 02:51:09 INFO - PROCESS | 9771 | Values: 279.7 02:51:09 INFO - PROCESS | 9771 | 02:51:09 INFO - PROCESS | 9771 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 02:51:09 INFO - PROCESS | 9771 | Values: 5251.3 02:51:09 INFO - PROCESS | 9771 | 02:51:09 INFO - PROCESS | 9771 | [#4] RayTrace Cycles:1 Average:1008.06 Median:1008.06 stddev:0.00 (0.0%) 02:51:09 INFO - PROCESS | 9771 | Values: 1008.1 02:51:09 INFO - PROCESS | 9771 | 02:51:09 INFO - PROCESS | 9771 | [#5] Earley Cycles:1 Average:620.35 Median:620.35 stddev:0.00 (0.0%) 02:51:09 INFO - PROCESS | 9771 | Values: 620.3 02:51:09 INFO - PROCESS | 9771 | 02:51:09 INFO - PROCESS | 9771 | [#6] Boyer Cycles:1 Average:11010.99 Median:11010.99 stddev:0.00 (0.0%) 02:51:09 INFO - PROCESS | 9771 | Values: 11011.0 02:51:09 INFO - PROCESS | 9771 | 02:51:09 INFO - PROCESS | 9771 | [#7] RegExp Cycles:1 Average:39365.38 Median:39365.38 stddev:0.00 (0.0%) 02:51:09 INFO - PROCESS | 9771 | Values: 39365.4 02:51:09 INFO - PROCESS | 9771 | 02:51:09 INFO - PROCESS | 9771 | [#8] Splay Cycles:1 Average:527.50 Median:527.50 stddev:0.00 (0.0%) 02:51:09 INFO - PROCESS | 9771 | Values: 527.5 02:51:09 INFO - PROCESS | 9771 | 02:51:09 INFO - PROCESS | 9771 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 02:51:09 INFO - PROCESS | 9771 | Values: 4826.9 02:51:09 INFO - PROCESS | 9771 | -------- Summary: end -------- 02:51:09 INFO - PROCESS | 9771 | 02:51:10 INFO - TEST-INFO | 9771: exit 0 02:51:10 INFO - TEST-OK | v8_7 | took 40595ms 02:51:10 INFO - SUITE-END | took 1210s 02:51:10 INFO - Completed test suite (00:20:10) 02:51:10 INFO - Working with test: dromaeo_css 02:51:10 INFO - Generating results file: dromaeo_css 02:51:10 INFO - Working with test: kraken 02:51:10 INFO - Generating results file: kraken 02:51:10 INFO - javascript benchmark 02:51:10 INFO - Working with test: v8_7 02:51:10 INFO - Generating results file: v8_7 02:51:10 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:51:11 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 02:51:11 INFO - process_Request line: dromaeo_css 7206.37 graph.html#tests=[[72,52,35]] 02:51:11 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:51:11 INFO - process_Request line: kraken 1472.80 graph.html#tests=[[232,52,35]] 02:51:11 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:51:11 INFO - process_Request line: v8_7 21577.83 graph.html#tests=[[230,52,35]] 02:51:11 INFO - RETURN: dromaeo_css: 7206.37 02:51:11 INFO - RETURN: kraken: 1472.80 02:51:11 INFO - RETURN: v8_7: 21577.83 02:51:11 INFO - javascript benchmark 02:51:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3203.983980080099, 3213.1163929919285, 3270.7710460267776, 3273.41078605851, 3291.6214635316937, 5134.178531434971, 5136.768845401956, 5149.227615857623, 5160.974195129023, 5183.352080989872, 5150.639455238135, 5164.690118592877, 5180.663256888309, 5185.274061631365, 5201.271821944931, 4643.2802915548145, 4715.056988602293, 4720.268358404444, 4747.1692453820615, 4785.66500344976, 4706.247000479924, 4712.6229901607785, 4744.383230180072, 4748.216544270192, 4749.240121580548, 4640.350350950869, 4644.140833945731, 4725.9054818903605, 4738.147133515983, 4758.500357462469, 4693.155232058211, 4741.336212930192, 4758.524147585248, 4767.594754445876, 4775.570198682118, 4722.929156062662, 4761.190597598416, 4766.022965292142, 4780.163471392492, 4794.856154315376, 4874.7562621868765, 4979.601631869442, 4997.2004479283505, 5032.2703208035, 5049.596032317406, 5451.591130665176, 5516.834494965157, 5517.0, 5518.586106042063, 5526.032944234783, 5538.584606154554, 5541.2796336476, 5547.944520554824, 5557.472040156179, 5562.694051827148, 5041.59667226621, 5114.948850511521, 5158.690478571298, 5183.792648294064, 5235.450277720823, 5546.91679624806, 5587.580931430159, 5616.691081990448, 5618.943810561842, 5624.3813180550105, 5352.170413585901, 5352.437994010651, 5367.194920761839, 5375.623706340597, 5378.704171270618, 5335.413104558495, 5392.164214546751, 5417.674939503642, 5436.429174936654, 5523.226748255248, 5462.180672899097, 5485.4788795064405, 5494.450554944474, 5494.752736126884, 5502.477264659851, 5475.67145971243, 5477.507024367826, 5479.205515200353, 5487.835364939058, 5521.1442226454965, 4203.726757760797, 4259.637930775857, 4262.25410553152, 4274.465691788527, 4323.913521729548, 3837.1174629835295, 3861.7296789224483, 3875.4380614810693, 3877.922441551153, 3879.670228030649, 5112.514311140436, 5192.870178245574, 5251.291075704808, 5253.054450198924, 5276.234945932818, 5423.403425623178, 5455.154451060012, 5504.697241651667, 5513.889722205534, 5553.805616803474, 5207.453217412193, 5229.398619158769, 5232.2674825524455, 5235.136202526616, 5273.709945952933, 4654.534546545318, 4676.0647870426055, 4806.255030470283, 4815.494373090845, 4820.060088282751, 5606.635568688022, 5612.831615051555, 5655.179998900218, 5658.547316214693, 5671.234383358276, 5505.917411238915, 5524.254225679482, 5527.53015993645, 5527.5577953762795, 5527.723613819373, 5571.637843540157, 5657.4908258256955, 5687.317521897398, 5697.259356283656, 5705.4009329019855, 5476.123820188751, 5491.0, 5492.697901615449, 5497.312835895513, 5502.009638264991, 5529.391766905717, 5553.861153471195, 5561.888762224814, 5564.888702226014, 5599.160125980972, 5221.425643179323, 5319.707416092152, 5359.062164121341, 5413.918791218056, 5456.427075157051, 5405.918911216257, 5411.83764487066, 5417.485338892799, 5421.132618781134, 5431.34823821144, 5315.548178404879, 5324.0150572144275, 5342.652727572696, 5344.144936810092, 5349.144136938071, 5249.448807875118, 5325.147976323769, 5359.249705041219, 5408.513233808976, 5468.535174510212, 5273.6572122811895, 5275.841724748264, 5281.366236051698, 5284.81503147388, 5315.787368505216], "unit": "score", "name": "dojo.html", "value": 5097.587699655024}, {"lowerIsBetter": false, "replicates": [559.5607448153198, 579.9913001304978, 585.4730742331901, 595.3034949109541, 611.226798100403, 30720.53919191211, 38312.616873831255, 38522.22955540888, 38539.61460385395, 38539.99999999993, 41342.0, 42064.0, 42097.368539471936, 42163.15673686525, 42179.36730949038, 9011.909880901188, 9188.540572971358, 9238.815223695523, 9254.722358329227, 9256.490893000882, 8826.293896488265, 8959.417637853552, 8973.46159230445, 8977.102289771003, 8977.685780997666, 8934.28525717941, 9000.954995225014, 9016.233620142295, 9018.368714189977, 9023.233025192867, 8919.910800891972, 8978.461292322449, 8988.370814042986, 8990.145936136056, 8991.685291014848, 8866.866996994986, 8896.332775041898, 8922.553872306358, 8983.730488085368, 8985.820283594292, 41980.790096049626, 42281.36577951333, 42384.152316953485, 42417.36373954393, 42435.78782106101, 3549.4675798630155, 3588.910277243064, 3731.440283957428, 3736.159364143073, 3748.3815170496837, 32251.516227256376, 32381.0, 32522.0, 32526.837365813255, 32575.83712081448, 4320.645801839015, 4377.606015458624, 4389.495208051083, 4407.052483715985, 4416.712913660602, 301442.0, 303277.0, 303295.0, 303318.0, 303593.4820325906, 58299.0, 59474.70262648659, 59551.40448595458, 64600.35399646038, 64849.0, 69956.0, 72579.0, 72799.63600181966, 72829.27170728226, 72903.0, 17272.22274997628, 17717.0, 17730.468085957444, 17774.200160992787, 17777.822221777875, 12086.214396064228, 12194.085443591766, 13857.4457021718, 13869.445222191, 14518.709625807425, 20768.68846967297, 21308.04113814882, 21317.25389611356, 21395.358139255848, 21441.78558214429, 8187.304079153219, 8357.331413486907, 8399.580020998925, 8400.369972252105, 8502.872456913152, 1011.3274672342957, 1063.7234319077095, 1093.781243751253, 1139.0944199361527, 1229.1150371732338, 28922.421551568852, 30811.767529299024, 31218.687813121578, 31523.0, 31603.841980789948, 1118.7706520163347, 1185.4606154199819, 1207.927524348542, 1211.6304527119137, 1214.8906598406186, 14180.290985450687, 14850.628734281729, 14929.477468288558, 15248.695026099416, 15782.921085394499, 272452.0, 274308.0, 276449.0, 277183.0, 277278.0, 51288.0, 51765.0, 51842.740786296585, 51848.22227666588, 51883.22175167376, 1446.7106578684304, 1486.6283429142713, 1512.2438780609696, 1522.0563250784362, 1536.4775976168157, 27877.58183627288, 29459.263518412212, 29494.0, 29571.112866614036, 30461.390772184874, 42883.14233715371, 42928.0, 43514.0, 43943.0, 48047.0, 207170.0, 506813.0, 511054.0, 511904.0, 512609.0, 32111.35777284488, 32761.0, 32901.34197315992, 32915.83542082274, 33020.0, 46322.0, 46864.297035543816, 47401.0, 47431.0, 47913.08347666054, 39315.60684393119, 39425.80287098546, 39949.80025099856, 40043.599564003984, 40663.1867362657, 38980.610193898836, 39320.21359572735, 40166.0, 40268.39597405983, 40560.0, 39265.0, 39439.60560394359, 39768.403473947335, 40046.799766000986, 40268.59731402648, 33372.165695857795, 33561.16097097495, 36774.63225367712, 37028.81485592555, 37883.052923677125, 26790.196294111207, 27023.594646080717, 27131.72868271292, 27265.0, 27290.317742056606], "unit": "score", "name": "ext.html", "value": 19803.3069034766}, {"lowerIsBetter": false, "replicates": [387.70921808643516, 397.3800870641798, 399.7002248313765, 400.43138742984956, 401.17158068588344, 14099.859001409983, 16728.41450549231, 17031.233594488247, 19254.422367328967, 19273.036348182588, 17041.91479042606, 17446.65106697865, 17487.825121748778, 17909.91045044773, 18245.270189192415, 4697.671163018582, 5158.40678321994, 5171.612129090315, 5175.353080864892, 5175.870603234912, 4024.3762216856435, 4165.64592009678, 5095.3885533736, 5394.568434525228, 5612.0, 5547.5007249347755, 5571.609987300871, 5578.972105139469, 5602.13166959122, 5610.102383618621, 5687.459691329317, 5694.971525142348, 5704.657720536781, 5717.828465146032, 5726.427357264281, 5497.147942068986, 5499.972500137474, 5724.713764311809, 5740.655560666331, 5743.195952566644, 14099.22454265015, 14165.78751318731, 18669.159887805083, 21167.25914592982, 21499.355019349445, 2252.200468833557, 2294.219965211836, 2329.3594261578032, 2342.2621874109773, 2391.186996421208, 9788.657396991142, 9948.303618746691, 10227.079562839306, 10404.479776011245, 12920.22478651284, 1925.5763731978943, 1926.8843869367884, 1983.8313743331835, 1989.1546092910455, 2003.158673357179, 53990.73004634952, 58925.821483570515, 61174.388256117316, 62362.68818655923, 62567.0, 10733.302335348177, 10886.72783180411, 10954.835677464844, 10966.506507207196, 11019.0, 14558.781618275523, 14657.780133298009, 14660.780088298685, 14666.779998300033, 14720.852791471949, 8629.69796057135, 8667.913320866837, 8669.176428239307, 8722.694705685271, 8740.8688869667, 8304.792380190424, 8460.57697115154, 8729.607167677343, 8755.430896991675, 8791.780205494913, 4484.484284307281, 4766.7854946526795, 4855.393075865517, 4861.222204447342, 4892.363992680928, 1838.8533856154286, 1872.354037856937, 1898.2501911744785, 1911.722800193964, 1934.1006432009183, 990.5691024404407, 1063.2132222155703, 1082.2240951958202, 1094.6934858239706, 1111.7109551516503, 14697.77953330701, 17099.487015389557, 17138.31446742116, 17760.733588996176, 17924.820751792577, 1039.4127318065268, 1068.1775033224528, 1068.631322193842, 1115.5203262597, 1122.539758698946, 10079.395236285847, 10229.437380943971, 10271.897281027244, 10345.793084138275, 10412.271141020055, 644634.0, 648981.0, 654918.0, 686920.0, 696053.0, 77729.61135194288, 79581.60209198917, 79620.20379796244, 80618.19381806224, 80682.0, 1097.7365432296351, 1152.3777160333327, 1180.8701042885275, 1189.5836457239898, 1222.743223922986, 14694.191819450032, 15191.316390762664, 15216.771748424004, 15431.61420964485, 15507.844921551092, 32278.83860580682, 32894.0, 33615.0, 34615.307693845476, 36280.818595907906, 41346.365034043345, 42236.080443993014, 42984.35523467213, 44283.0, 44686.776566118264, 7526.09686837583, 8118.512889226666, 8173.264406203471, 8187.099419063779, 8197.877031844408, 10621.681349559525, 11326.660200194008, 11810.468528916048, 11989.460474278503, 12102.45538950767, 9478.427822488562, 10010.749731256778, 10085.041921017491, 10457.895421045692, 10799.13606911461, 3061.8928337508974, 5090.872728181825, 10043.4476103815, 10175.440350780778, 10376.844347334947, 10193.796124077626, 10315.12321452655, 10842.186835987175, 10871.130309575057, 11005.394703291076, 7638.770836874903, 7667.463277570517, 7846.921530784847, 8025.678972841254, 8161.428699991181, 9937.850932236166, 10572.735681608021, 10717.517711702836, 10869.402182879701, 10907.18196135309], "unit": "score", "name": "jquery.html", "value": 8653.150504426816}, {"lowerIsBetter": false, "replicates": [1451.8257809062914, 1523.0633160606226, 1590.0459724165503, 1826.8812527185733, 1968.2127149140333, 7325.890111648323, 8202.138775428584, 8341.082480927093, 8377.287930525912, 8404.579771011455, 8286.337093032558, 8465.068842427328, 8483.57582120893, 8490.150984901522, 8521.446106003106, 2120.0989579428683, 2172.2071443923014, 2174.9891250543724, 2445.669834572332, 2466.235467005234, 2420.0, 2468.3458883395915, 2475.2203056037292, 2484.1305543059875, 2486.11742831295, 2382.297222319411, 2429.7327293997646, 2441.3042282949364, 2445.0, 2451.044092803808, 2323.848949818256, 2343.5664402085667, 2350.3536527454917, 2386.7971222446113, 2395.6765836612008, 2286.5998450271304, 2302.5625131225015, 2305.054927479742, 2352.882355882199, 2437.9390515237083, 8176.754697359089, 8190.8771368429525, 8205.343572514244, 8207.425480216387, 8237.382196335298, 5091.363579552556, 5219.973900130513, 5231.189165679326, 5233.319668443078, 5237.031149237403, 3306.437905556061, 3318.3529211803707, 3362.546056282395, 3399.7280217582534, 3427.9657203428146, 1227.957021504252, 1241.782688029591, 1255.8492980842266, 1275.011865804, 1278.4119305119657, 11473.0, 11506.07951363889, 11509.884901150965, 11513.309201447857, 11516.366599837005, 4579.7252164870215, 4647.209974304309, 4679.438467383868, 4746.7389293589185, 4765.523447655207, 9809.607615695435, 9812.067853553901, 9865.358751681119, 9928.255380846465, 9950.054744799232, 5261.237120617489, 5261.579073674096, 5273.551748101378, 5274.841754747364, 5277.261183434322, 4772.689775164603, 4778.402699662543, 4825.782839772219, 4827.227643577011, 4829.710217386968, 3659.817009149585, 3730.515033045687, 3944.861929832442, 4007.73949693269, 4077.7757223353, 1246.8316777235138, 1304.178367628388, 1312.3241530611742, 1320.9009324300716, 1323.9139455935526, 1393.4426229508279, 1416.0370947755625, 1421.047897908404, 1442.4662874736414, 1454.4618491158128, 7644.426667999922, 7649.120351159577, 7686.192949740197, 7700.037495313086, 7715.537067775951, 1200.6758175292623, 1212.090931801149, 1213.3751118174148, 1215.617080619602, 1225.7303393253649, 6275.309715931244, 6297.685115744194, 6397.264314603787, 6397.616143031433, 6410.0, 9621.615135394506, 9866.901330986599, 9883.011698830203, 9995.450250236307, 9995.550200240861, 9705.854412183822, 9789.804203915883, 9861.112499874902, 9873.802523949624, 9902.55438505269, 7836.0, 7838.372930165573, 7859.6463159157975, 7910.762677119696, 7921.049474063034, 7410.4442166836625, 7424.1462231844025, 7524.699012039676, 7545.0, 7556.697732090654, 8764.211220989886, 8799.34004949644, 8949.507777072064, 8990.86513702282, 9066.50134242623, 9125.954370228106, 9144.497052661902, 9186.466659367088, 9236.769080773034, 9283.11810378013, 7142.750003749844, 7193.964030179815, 7209.170945341143, 7264.963675181591, 7265.309795569412, 6901.206361268519, 7124.251953544803, 7671.61641917913, 7689.461737678309, 7691.50005249657, 7417.925820741723, 7423.888641670272, 7478.7382441616455, 7566.205548417337, 7571.3564347031115, 7245.587110513399, 7262.709491620487, 7323.0, 7323.450741194325, 7326.450516211199, 7109.75115870942, 7129.322714342129, 7200.423966082805, 7234.276572342724, 7426.331630153312, 6941.618210998444, 6946.826329341605, 6990.685419156252, 6991.6853741580735, 6994.0, 7155.212926577969, 7155.391791697556, 7163.391111755559, 7268.600226987566, 7274.96362518184], "unit": "score", "name": "mootools.html", "value": 4838.627231994602}, {"lowerIsBetter": false, "replicates": [372.91422972716276, 377.60351630787676, 380.01196888090965, 383.5531605679384, 389.46254169246436, 5932.169496270526, 5976.581639285252, 5983.012802887529, 5987.9101813472835, 6025.3372129065765, 5937.37657545958, 5942.524598032158, 5943.4056594340655, 5944.989351810192, 5946.732397042133, 4473.888152796182, 4623.514530974249, 4630.305454181883, 4663.930041049387, 4665.0, 4648.814047438098, 4656.5110663380365, 4669.276262179367, 4671.252599584067, 4674.0418214266165, 4435.33674871923, 4512.842050528232, 4529.614982726455, 4630.583247507724, 4632.397788287535, 4591.334256532818, 4606.493285738566, 4616.953830461686, 4621.052684199731, 4631.282151266576, 4060.4518390017265, 4078.4290199372113, 4083.612056854624, 4086.0193553547233, 4088.550259471456, 5495.890082198333, 5526.585506087019, 5592.3009623797025, 5759.107338362519, 5762.510186634141, 5374.677519348813, 5383.865403364947, 5388.649737767033, 5389.245505629215, 5391.379991301012, 6292.685365731741, 6315.0843127746675, 6320.273168585625, 6321.620702757849, 6327.0, 4432.911341773147, 4449.822007119711, 4486.69885733137, 4492.483364413101, 4519.751413672247, 6498.9350106498805, 6573.835654108686, 6577.638229897354, 6580.407763301278, 6588.242352129519, 4629.328747331618, 4635.142498637695, 4643.489216186217, 4646.4888862225125, 4649.139909116824, 4694.2723877799, 4699.976500117477, 4701.177293973541, 4701.200795864711, 4705.082508910798, 5205.817796377184, 5360.544353729899, 5365.517103460707, 5378.97310513445, 5379.381371142291, 6314.116023756677, 6345.777897773556, 6354.586951848115, 6355.1420558224045, 6366.26787919386, 1639.5573195237218, 1659.9751003734953, 1661.0615002523537, 1664.2344521519994, 1665.7168281392192, 1133.2010932292715, 1134.6652737442473, 1135.437958210691, 1135.5968631135993, 1162.0, 6115.694215289307, 6118.541109416811, 6133.325334213233, 6141.969290153521, 6142.600730952474, 6520.739170433224, 6523.543351965317, 6524.249711283263, 6527.738890444424, 6529.967350163219, 6036.034234522455, 6136.539759518054, 6137.5703700741415, 6138.7237574309265, 6157.599756015845, 3474.756767026284, 3500.544929159193, 3503.1242189452637, 3504.5969713482764, 3506.1760486285702, 6551.705173267214, 6636.601803891782, 6649.3018233085795, 6692.163479565054, 6766.357196066366, 6766.424853887376, 6767.2894346093935, 6768.357006084414, 6773.1872175338285, 6777.152855893013, 6816.147981502312, 6837.3162683731225, 6847.1783385994, 6850.9314906850295, 6851.623160726208, 6423.325550817284, 6565.737370505126, 6578.276389597045, 6581.769638062837, 6585.1439312889015, 6481.4814814815645, 6488.351164883474, 6492.35076492347, 6493.383128602775, 6495.480361570969, 6820.340067373629, 6822.488313376417, 6829.317068293131, 6830.351116643911, 6832.59004459734, 4518.322251662277, 4602.309653551994, 4602.838900638461, 4610.331501932268, 4623.42207224097, 6546.607203567801, 6550.443212327005, 6568.376004279586, 6580.045893345342, 6581.769638062645, 6382.904256436064, 6419.871602568016, 6420.839479013062, 6422.42198202164, 6430.164078669743, 6285.214348206474, 6325.525585581192, 6381.234251889803, 6381.329960354096, 6389.233292004989, 6246.500279977682, 6256.0, 6290.622562646073, 6297.874042519215, 6306.400891915261, 6383.425491705769, 6418.711157997995, 6442.355764423708, 6444.226692796707, 6449.871002580016, 6140.109684095692, 6262.2172228471445, 6273.62358258506, 6280.685965701788, 6293.433590976834], "unit": "score", "name": "prototype.html", "value": 4844.338528521797}, {"lowerIsBetter": false, "replicates": [932.7261312792102, 939.4785893828926, 945.1588086602925, 976.9169620582251, 978.8874279457856, 14552.41790328387, 14701.558953231406, 14817.18505482198, 14848.03487773294, 14850.405983760636, 13776.793348099787, 13941.860581394183, 13975.930120349409, 14441.0, 14444.06113602615, 906.8730377747104, 916.4318122763896, 917.9082091790801, 921.4655499810094, 922.294444749767, 921.7695576105973, 926.8146370725848, 926.8609708543705, 927.2581934452411, 927.837628415028, 967.7435479597913, 975.6146322202726, 976.4483067067084, 979.1921664626676, 979.3536266064399, 968.8692026576427, 971.489967766928, 972.5477652891369, 973.2214228617078, 974.7709288317204, 710.0591715976352, 711.6939715922151, 712.6436781609195, 713.1264201353353, 713.989290160648, 13802.447902083904, 13838.377273022737, 13888.93055534726, 13904.58286251414, 13908.860911390857, 12046.518139274418, 12057.758844823142, 12232.021438284915, 12262.141650084497, 12321.815172772416, 10579.312344697648, 10786.0, 10817.513211905483, 10820.945895270552, 10957.17821163416, 3553.893383198508, 3672.265546890606, 3688.0, 3696.0944568580603, 3697.279030589036, 45281.320780188325, 45967.31049034267, 48590.757046214545, 50873.491265087614, 51118.7444062781, 11223.382713950648, 11319.0, 11507.0, 11612.12909031826, 11739.647810565697, 19974.10116544759, 20281.290154844508, 20292.695609565868, 20298.594028119354, 20303.390898273075, 7628.847423051508, 7749.263819937097, 7876.763697089096, 7876.842463150705, 8294.792630184294, 4371.475422949266, 4499.595036446735, 4588.151192029485, 4597.195490789099, 4649.651276154302, 3116.080756176888, 3156.3213909009673, 3160.5259211118055, 3162.5888634477833, 3166.255929856482, 566.7138095261867, 574.9712514374264, 575.2148317546519, 575.6747437697687, 586.0154939701257, 724.5871943147728, 736.8784150615088, 747.4431548496405, 754.35125791819, 766.4634755671052, 9192.21866141372, 9416.670416535526, 9559.665411710557, 9573.808523829624, 9590.90409095914, 602.5661523702927, 631.3497097989078, 640.6743521018673, 643.5302229372584, 650.8991106378519, 4298.914021719548, 4427.46870375557, 4459.509453960061, 4532.0, 4583.472900616472, 59018.70490647519, 59358.40641593615, 59665.403345965984, 60071.39928600658, 60393.69803151044, 53173.734131329096, 55089.72455137699, 55312.44687553153, 55562.44437555573, 57577.0, 49755.75122124366, 50259.74870125699, 50553.0, 50888.49111508911, 51378.48621513737, 9322.300827437834, 9568.61725530971, 9619.951900240454, 9626.566804493674, 9749.07383798538, 35424.11439714028, 35471.82264088663, 37318.25363492661, 37908.241835163695, 38617.42073868838, 44132.55867441413, 45245.54754452413, 48847.267290991374, 48977.755111224214, 49907.25139122989, 12333.383330833243, 12496.750064998467, 12564.120511564468, 12655.93672031634, 12668.809967850306, 13381.130226535244, 13438.260895650443, 13468.595942121752, 13627.727445450837, 14021.929890350482, 11764.705882353146, 11923.224990375598, 12090.879091208975, 12591.244525328144, 12808.423620937267, 12454.937725311316, 12584.30786306762, 12613.243205407705, 12953.54662586805, 13196.274204918822, 12249.938750306192, 12278.877211228131, 12476.905225519366, 12899.871001289866, 13052.804207937079, 10316.381017138996, 10351.741206469596, 10371.481425928523, 10392.0, 10600.734981625521, 10210.489475526045, 10469.68590942273, 10560.841587376042, 10598.89401105979, 10721.571137154426], "unit": "score", "name": "yui.html", "value": 6839.544107567642}], "name": "dromaeo_css", "value": 7206.369346651981}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 104.0, 109.0, 110.0, 110.0, 100.0, 110.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [146.0, 129.0, 155.0, 180.0, 124.0, 151.0, 150.0, 124.0, 163.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 144.5}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 160.0, 160.0, 160.0, 161.0, 162.0, 161.0, 159.0], "unit": "score", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 73.0, 157.0, 72.0, 73.0, 72.0, 76.0, 144.0, 74.0], "unit": "score", "name": "audio-fft", "value": 89.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 137.0, 95.0, 95.0, 95.0, 144.0, 95.0, 95.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 108.2}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 111.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [52.0, 53.0, 54.0, 53.0, 54.0, 56.0, 58.0, 54.0, 52.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 53.8}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 64.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.2}, {"lowerIsBetter": true, "replicates": [79.0, 81.0, 80.0, 80.0, 80.0, 80.0, 81.0, 80.0, 80.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.2}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 112.0, 112.0, 118.0, 112.0, 111.0, 109.0, 113.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 111.8}, {"lowerIsBetter": true, "replicates": [129.0, 127.0, 138.0, 135.0, 135.0, 137.0, 138.0, 135.0, 136.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.5}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 66.0, 64.0, 66.0, 65.0, 64.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.0}], "name": "kraken", "value": 1472.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.0843776106934], "unit": "score", "name": "Richards", "value": 211.28247000000007}, {"lowerIsBetter": false, "replicates": [170.24174327545114], "unit": "score", "name": "DeltaBlue", "value": 388.3771319999999}, {"lowerIsBetter": false, "replicates": [279.72027972027973], "unit": "score", "name": "Encrypt", "value": 951.5970750000004}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [1008.0645161290323], "unit": "score", "name": "RayTrace", "value": 734.0690880000001}, {"lowerIsBetter": false, "replicates": [620.3473945409429], "unit": "score", "name": "Earley", "value": 1074.338356}, {"lowerIsBetter": false, "replicates": [11010.989010989011], "unit": "score", "name": "Boyer", "value": 60.527078842315376}, {"lowerIsBetter": false, "replicates": [39365.38461538462], "unit": "score", "name": "RegExp", "value": 23.141778212017584}, {"lowerIsBetter": false, "replicates": [527.5013095861708], "unit": "score", "name": "Splay", "value": 154.48492452830183}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 21577.83350839216}]} 02:51:11 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "21577.83"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1472.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7206.37"}}} 02:51:11 INFO - Return code: 0 02:51:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:51:11 INFO - # TBPL SUCCESS # 02:51:11 INFO - Running post-action listener: _resource_record_post_action 02:51:11 INFO - Running post-run listener: _resource_record_post_run 02:51:12 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 692224; Write bytes: 353685504; Read time: 144; Write time: 263680 02:51:12 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 99819520; Read time: 0; Write time: 62440 02:51:12 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 692224; Write bytes: 253865984; Read time: 144; Write time: 201240 02:51:12 INFO - Running post-run listener: _upload_blobber_files 02:51:12 INFO - Blob upload gear active. 02:51:12 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:51:12 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 02:51:12 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'] 02:51:12 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 02:51:12 INFO - (blobuploader) - INFO - Open directory for files ... 02:51:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 02:51:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:51:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:51:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:51:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:51:13 INFO - (blobuploader) - INFO - Done attempting. 02:51:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:51:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:51:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:51:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:51:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:51:14 INFO - (blobuploader) - INFO - Done attempting. 02:51:14 INFO - (blobuploader) - INFO - Iteration through files over. 02:51:14 INFO - Return code: 0 02:51:14 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:51:14 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:51:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d630b716b52c1b45984abd25c482e48483f23c01ea2fe196d229323f238460b8402dbad32ed48c52cd759ddfddb4e70bfeb441dba4fcbd596a27335db2ead838", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fe15c1fc019b9c605f84f018b593010c9f32c61291c6f409853a4b60f75b6ab317a7d45f36a1b51eb4033bc4f3a9baf97cd46cc40dcbcb4554a865fb6ac1e1b6"} 02:51:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:51:14 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:51:14 INFO - Contents: 02:51:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d630b716b52c1b45984abd25c482e48483f23c01ea2fe196d229323f238460b8402dbad32ed48c52cd759ddfddb4e70bfeb441dba4fcbd596a27335db2ead838", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fe15c1fc019b9c605f84f018b593010c9f32c61291c6f409853a4b60f75b6ab317a7d45f36a1b51eb4033bc4f3a9baf97cd46cc40dcbcb4554a865fb6ac1e1b6"} 02:51:14 INFO - Running post-run listener: copy_logs_to_upload_dir 02:51:14 INFO - Copying logs to upload dir... 02:51:14 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 02:51:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1322.068550 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2016-02-28 02:51:14.786335) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-28 02:51:14.789342) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d630b716b52c1b45984abd25c482e48483f23c01ea2fe196d229323f238460b8402dbad32ed48c52cd759ddfddb4e70bfeb441dba4fcbd596a27335db2ead838", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fe15c1fc019b9c605f84f018b593010c9f32c61291c6f409853a4b60f75b6ab317a7d45f36a1b51eb4033bc4f3a9baf97cd46cc40dcbcb4554a865fb6ac1e1b6"} build_url:https://queue.taskcluster.net/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011419 build_url: 'https://queue.taskcluster.net/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d630b716b52c1b45984abd25c482e48483f23c01ea2fe196d229323f238460b8402dbad32ed48c52cd759ddfddb4e70bfeb441dba4fcbd596a27335db2ead838", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fe15c1fc019b9c605f84f018b593010c9f32c61291c6f409853a4b60f75b6ab317a7d45f36a1b51eb4033bc4f3a9baf97cd46cc40dcbcb4554a865fb6ac1e1b6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-28 02:51:14.813675) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 02:51:14.814005) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1456653404.654488-2088228343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 02:51:14.896759) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-28 02:51:14.900136) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-28 02:51:14.900449) ========= ========= Total master_lag: 0.35 =========