builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-015 starttime: 1455842673.03 results: success (0) buildid: 20160218140410 builduid: 9b4bf39878304df3824c454a20826884 revision: 7141f2426f66c83c540f27196085cddcd5a227aa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 16:44:33.029498) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 16:44:33.029961) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-18 16:44:33.030293) ========= 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=20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006361 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-18 16:44:33.054282) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-18 16:44:33.054580) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-18 16:44:33.076725) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 16:44:33.077013) ========= 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=20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004582 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 16:44:33.128234) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 16:44:33.128532) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 16:44:33.128922) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 16:44:33.129194) ========= 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=20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-18 16:44:33-- 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% 219M=0s 2016-02-18 16:44:33 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100386 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 16:44:33.245903) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 16:44:33.246177) ========= 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=20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019639 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 16:44:33.298568) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-18 16:44:33.298949) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7141f2426f66c83c540f27196085cddcd5a227aa --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 7141f2426f66c83c540f27196085cddcd5a227aa --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=20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-18 16:44:33,536 truncating revision to first 12 chars 2016-02-18 16:44:33,536 Setting DEBUG logging. 2016-02-18 16:44:33,537 attempt 1/10 2016-02-18 16:44:33,537 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7141f2426f66?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-18 16:44:34,290 unpacking tar archive at: mozilla-aurora-7141f2426f66/testing/mozharness/ program finished with exit code 0 elapsedTime=1.052376 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-18 16:44:34.364999) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-18 16:44:34.365356) ========= echo 7141f2426f66c83c540f27196085cddcd5a227aa in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7141f2426f66c83c540f27196085cddcd5a227aa'] 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=20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 7141f2426f66c83c540f27196085cddcd5a227aa program finished with exit code 0 elapsedTime=0.004067 script_repo_revision: '7141f2426f66c83c540f27196085cddcd5a227aa' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-18 16:44:34.414865) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-18 16:44:34.415175) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-18 16:44:34.424811) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 14 secs) (at 2016-02-18 16:44:34.425118) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:44:34 INFO - MultiFileLogger online at 20160218 16:44:34 in /builds/slave/test-pgo 16:44:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:44:34 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:44:34 INFO - {'append_to_log': False, 16:44:34 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:44:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:44:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:44:34 INFO - 'branch': 'Mozilla-Aurora', 16:44:34 INFO - 'buildbot_json_path': 'buildprops.json', 16:44:34 INFO - 'config_files': ('talos/linux_config.py',), 16:44:34 INFO - 'default_actions': ('clobber', 16:44:34 INFO - 'read-buildbot-config', 16:44:34 INFO - 'download-and-extract', 16:44:34 INFO - 'populate-webroot', 16:44:34 INFO - 'create-virtualenv', 16:44:34 INFO - 'install', 16:44:34 INFO - 'run-tests'), 16:44:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:44:34 INFO - 'download_minidump_stackwalk': True, 16:44:34 INFO - 'download_symbols': 'ondemand', 16:44:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:44:34 INFO - 'tooltool.py': '/tools/tooltool.py', 16:44:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:44:34 INFO - '/tools/misc-python/virtualenv.py')}, 16:44:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:44:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:44:34 INFO - 'installer_path': 'installer.exe', 16:44:34 INFO - 'log_level': 'info', 16:44:34 INFO - 'log_name': 'talos', 16:44:34 INFO - 'log_to_console': True, 16:44:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:44:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:44:34 INFO - 'opt_config_files': (), 16:44:34 INFO - 'pip_index': False, 16:44:34 INFO - 'sps_profile': False, 16:44:34 INFO - 'sps_profile_interval': 0, 16:44:34 INFO - 'suite': 'dromaeojs-e10s', 16:44:34 INFO - 'system_bits': '32', 16:44:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:44:34 INFO - 'title': 'talos-linux64-ix-015', 16:44:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:44:34 INFO - 'use_talos_json': True, 16:44:34 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:44:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:44:34 INFO - 'work_dir': 'build'} 16:44:34 INFO - ##### 16:44:34 INFO - ##### Running clobber step. 16:44:34 INFO - ##### 16:44:34 INFO - Running pre-action listener: _resource_record_pre_action 16:44:34 INFO - Running main action method: clobber 16:44:34 INFO - rmtree: /builds/slave/test-pgo/build 16:44:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:44:35 INFO - Running post-action listener: _resource_record_post_action 16:44:35 INFO - ##### 16:44:35 INFO - ##### Running read-buildbot-config step. 16:44:35 INFO - ##### 16:44:35 INFO - Running pre-action listener: _resource_record_pre_action 16:44:35 INFO - Running main action method: read_buildbot_config 16:44:35 INFO - Using buildbot properties: 16:44:35 INFO - { 16:44:35 INFO - "project": "", 16:44:35 INFO - "product": "firefox", 16:44:35 INFO - "script_repo_revision": "production", 16:44:35 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 16:44:35 INFO - "repository": "", 16:44:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 16:44:35 INFO - "buildid": "20160218140410", 16:44:35 INFO - "pgo_build": "True", 16:44:35 INFO - "basedir": "/builds/slave/test-pgo", 16:44:35 INFO - "buildnumber": 143, 16:44:35 INFO - "slavename": "talos-linux64-ix-015", 16:44:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:44:35 INFO - "platform": "ubuntu64_hw", 16:44:35 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:44:35 INFO - "branch": "mozilla-aurora", 16:44:35 INFO - "repo_path": "releases/mozilla-aurora", 16:44:35 INFO - "revision": "7141f2426f66c83c540f27196085cddcd5a227aa", 16:44:35 INFO - "stage_platform": "linux64-pgo", 16:44:35 INFO - "builduid": "9b4bf39878304df3824c454a20826884", 16:44:35 INFO - "slavebuilddir": "test" 16:44:35 INFO - } 16:44:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/Pf7KXa7FS6urjgMqW26CQg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 16:44:35 INFO - Running post-action listener: _resource_record_post_action 16:44:35 INFO - ##### 16:44:35 INFO - ##### Running download-and-extract step. 16:44:35 INFO - ##### 16:44:35 INFO - Running pre-action listener: _resource_record_pre_action 16:44:35 INFO - Running main action method: download_and_extract 16:44:35 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:44:35 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')]} 16:44:35 INFO - https://queue.taskcluster.net/v1/task/Pf7KXa7FS6urjgMqW26CQg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:44:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pf7KXa7FS6urjgMqW26CQg/artifacts/public/build/test_packages.json 16:44:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pf7KXa7FS6urjgMqW26CQg/artifacts/public/build/test_packages.json 16:44:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pf7KXa7FS6urjgMqW26CQg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:44:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pf7KXa7FS6urjgMqW26CQg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:44:37 INFO - Downloaded 1448 bytes. 16:44:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:44:37 INFO - Using the following test package requirements: 16:44:37 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 16:44:37 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 16:44:37 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:44:37 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 16:44:37 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 16:44:37 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 16:44:37 INFO - u'jsshell-linux-x86_64.zip'], 16:44:37 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 16:44:37 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:44:37 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 16:44:37 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 16:44:37 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:44:37 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 16:44:37 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:44:37 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 16:44:37 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:44:37 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 16:44:37 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 16:44:37 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:44:37 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:37 INFO - https://queue.taskcluster.net/v1/task/Pf7KXa7FS6urjgMqW26CQg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:44:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pf7KXa7FS6urjgMqW26CQg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 16:44:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pf7KXa7FS6urjgMqW26CQg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 16:44:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pf7KXa7FS6urjgMqW26CQg/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 16:44:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pf7KXa7FS6urjgMqW26CQg/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 16:44:40 INFO - Downloaded 23077530 bytes. 16:44:40 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'] 16:44:40 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 16:44:41 INFO - Return code: 0 16:44:41 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 16:44: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')]} 16:44:41 INFO - https://queue.taskcluster.net/v1/task/Pf7KXa7FS6urjgMqW26CQg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:44:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pf7KXa7FS6urjgMqW26CQg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 16:44:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pf7KXa7FS6urjgMqW26CQg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 16:44:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pf7KXa7FS6urjgMqW26CQg/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 16:44:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pf7KXa7FS6urjgMqW26CQg/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 16:44:46 INFO - Downloaded 23077530 bytes. 16:44:46 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'] 16:44:46 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 16:44:47 INFO - Return code: 0 16:44:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:47 INFO - https://queue.taskcluster.net/v1/task/Pf7KXa7FS6urjgMqW26CQg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:44:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pf7KXa7FS6urjgMqW26CQg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 16:44:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pf7KXa7FS6urjgMqW26CQg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 16:44:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pf7KXa7FS6urjgMqW26CQg/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 16:44:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pf7KXa7FS6urjgMqW26CQg/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 16:44:48 INFO - Downloaded 10706572 bytes. 16:44:48 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'] 16:44:48 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 16:44:49 INFO - Return code: 0 16:44:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:49 INFO - https://queue.taskcluster.net/v1/task/Pf7KXa7FS6urjgMqW26CQg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:44:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pf7KXa7FS6urjgMqW26CQg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 16:44:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pf7KXa7FS6urjgMqW26CQg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 16:44:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pf7KXa7FS6urjgMqW26CQg/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 16:44:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pf7KXa7FS6urjgMqW26CQg/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 16:44:51 INFO - Downloaded 59960618 bytes. 16:44:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Pf7KXa7FS6urjgMqW26CQg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 16:44:51 INFO - mkdir: /builds/slave/test-pgo/properties 16:44:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:44:51 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:44:51 INFO - Contents: 16:44:51 INFO - build_url:https://queue.taskcluster.net/v1/task/Pf7KXa7FS6urjgMqW26CQg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 16:44:52 INFO - Running post-action listener: _resource_record_post_action 16:44:52 INFO - Running post-action listener: set_extra_try_arguments 16:44:52 INFO - ##### 16:44:52 INFO - ##### Running populate-webroot step. 16:44:52 INFO - ##### 16:44:52 INFO - Running pre-action listener: _resource_record_pre_action 16:44:52 INFO - Running main action method: populate_webroot 16:44:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:44:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:44:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:44:52 INFO - '--tppagecycles', 16:44:52 INFO - '7'], 16:44:52 INFO - 'tests': ['tsvgm']}}, 16:44:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:44:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:44:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:44:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:44:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:44:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:44:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:44:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:52 INFO - 'talos_options': ['--e10s'], 16:44:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:44:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:52 INFO - 'tests': ['damp', 'tps']}, 16:44:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:52 INFO - 'talos_options': ['--e10s'], 16:44:52 INFO - 'tests': ['damp', 'tps']}, 16:44:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:44:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:44:52 INFO - 'other': {'tests': ['a11yr', 16:44:52 INFO - 'ts_paint', 16:44:52 INFO - 'tpaint', 16:44:52 INFO - 'sessionrestore', 16:44:52 INFO - 'sessionrestore_no_auto_restore']}, 16:44:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:44:52 INFO - 'tests': ['a11yr', 16:44:52 INFO - 'ts_paint', 16:44:52 INFO - 'tpaint', 16:44:52 INFO - 'sessionrestore', 16:44:52 INFO - 'sessionrestore_no_auto_restore']}, 16:44:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:44:52 INFO - 'tests': ['a11yr', 16:44:52 INFO - 'ts_paint', 16:44:52 INFO - 'tpaint', 16:44:52 INFO - 'sessionrestore', 16:44:52 INFO - 'sessionrestore_no_auto_restore']}, 16:44:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:44:52 INFO - 'tests': ['a11yr', 16:44:52 INFO - 'ts_paint', 16:44:52 INFO - 'tpaint', 16:44:52 INFO - 'sessionrestore', 16:44:52 INFO - 'sessionrestore_no_auto_restore']}, 16:44:52 INFO - 'other_l64': {'tests': ['a11yr', 16:44:52 INFO - 'ts_paint', 16:44:52 INFO - 'tpaint', 16:44:52 INFO - 'sessionrestore', 16:44:52 INFO - 'sessionrestore_no_auto_restore']}, 16:44:52 INFO - 'other_nol64': {'tests': ['a11yr', 16:44:52 INFO - 'ts_paint', 16:44:52 INFO - 'tpaint', 16:44:52 INFO - 'sessionrestore', 16:44:52 INFO - 'sessionrestore_no_auto_restore']}, 16:44:52 INFO - 'svgr': {'tests': ['tsvgx', 16:44:52 INFO - 'tsvgr_opacity', 16:44:52 INFO - 'tart', 16:44:52 INFO - 'tscrollx', 16:44:52 INFO - 'cart']}, 16:44:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:44:52 INFO - 'tests': ['tsvgx', 16:44:52 INFO - 'tsvgr_opacity', 16:44:52 INFO - 'tart', 16:44:52 INFO - 'tscrollx', 16:44:52 INFO - 'cart']}, 16:44:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:52 INFO - 'tests': ['tp5o']}, 16:44:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:52 INFO - 'talos_options': ['--e10s'], 16:44:52 INFO - 'tests': ['tp5o']}, 16:44:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:52 INFO - 'talos_options': ['--xperf_path', 16:44:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:44:52 INFO - 'tests': ['tp5n']}, 16:44:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:44:52 INFO - 'talos_options': ['--e10s', 16:44:52 INFO - '--xperf_path', 16:44:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:44:52 INFO - 'tests': ['tp5n']}}, 16:44:52 INFO - 'talos.zip': {'path': '', 16:44:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:44:52 INFO - Running post-action listener: _resource_record_post_action 16:44:52 INFO - ##### 16:44:52 INFO - ##### Running create-virtualenv step. 16:44:52 INFO - ##### 16:44:52 INFO - Running pre-action listener: _resource_record_pre_action 16:44:52 INFO - Running main action method: create_virtualenv 16:44:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:44:52 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 16:44:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:44:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:44:52 INFO - Using real prefix '/usr' 16:44:52 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:44:52 INFO - Installing distribute.............................................................................................................................................................................................done. 16:44:54 INFO - Installing pip.................done. 16:44:54 INFO - Return code: 0 16:44:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:44:54 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')]} 16:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:54 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')]} 16:44:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:54 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 0x7fc9774e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a39230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acb7f0>, '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 0x2a372d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a37760>, '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': '20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976', '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 16:44:54 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 16:44:54 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 16:44:54 INFO - Using env: {'DISPLAY': ':0', 16:44:54 INFO - 'HOME': '/home/cltbld', 16:44:54 INFO - 'LANG': 'en_US.UTF-8', 16:44:54 INFO - 'LANGUAGE': 'en_US:en', 16:44:54 INFO - 'LOGNAME': 'cltbld', 16:44:54 INFO - 'MAIL': '/var/mail/cltbld', 16:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:54 INFO - 'MOZ_NO_REMOTE': '1', 16:44:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:54 INFO - 'NO_EM_RESTART': '1', 16:44:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:44:54 INFO - 'PWD': '/builds/slave/test-pgo', 16:44:54 INFO - 'SHELL': '/bin/bash', 16:44:54 INFO - 'SHLVL': '1', 16:44:54 INFO - 'TERM': 'linux', 16:44:54 INFO - 'TMOUT': '86400', 16:44:54 INFO - 'USER': 'cltbld', 16:44:54 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976', 16:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:54 INFO - '_': '/tools/buildbot/bin/python'} 16:44:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:54 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 16:44:54 INFO - Cleaning up... 16:44:54 INFO - Return code: 0 16:44:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:44:54 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')]} 16:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:54 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')]} 16:44:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:54 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 0x7fc9774e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a39230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acb7f0>, '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 0x2a372d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a37760>, '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': '20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976', '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 16:44:54 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 16:44:54 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 16:44:54 INFO - Using env: {'DISPLAY': ':0', 16:44:54 INFO - 'HOME': '/home/cltbld', 16:44:54 INFO - 'LANG': 'en_US.UTF-8', 16:44:54 INFO - 'LANGUAGE': 'en_US:en', 16:44:54 INFO - 'LOGNAME': 'cltbld', 16:44:54 INFO - 'MAIL': '/var/mail/cltbld', 16:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:54 INFO - 'MOZ_NO_REMOTE': '1', 16:44:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:54 INFO - 'NO_EM_RESTART': '1', 16:44:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:44:54 INFO - 'PWD': '/builds/slave/test-pgo', 16:44:54 INFO - 'SHELL': '/bin/bash', 16:44:54 INFO - 'SHLVL': '1', 16:44:54 INFO - 'TERM': 'linux', 16:44:54 INFO - 'TMOUT': '86400', 16:44:54 INFO - 'USER': 'cltbld', 16:44:54 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976', 16:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:54 INFO - '_': '/tools/buildbot/bin/python'} 16:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:55 INFO - Downloading/unpacking psutil>=0.7.1 16:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:44:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:44:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:44:57 INFO - Installing collected packages: psutil 16:44:57 INFO - Running setup.py install for psutil 16:44:57 INFO - building 'psutil._psutil_linux' extension 16:44:57 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 16:44:57 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 16:44:57 INFO - building 'psutil._psutil_posix' extension 16:44:57 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 16:44:57 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 16:44:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:44:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:44:57 INFO - Successfully installed psutil 16:44:57 INFO - Cleaning up... 16:44:57 INFO - Return code: 0 16:44:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:57 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 0x7fc9774e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a39230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acb7f0>, '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 0x2a372d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a37760>, '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': '20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976', '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 16:44:57 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 16:44:57 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 16:44:57 INFO - Using env: {'DISPLAY': ':0', 16:44:57 INFO - 'HOME': '/home/cltbld', 16:44:57 INFO - 'LANG': 'en_US.UTF-8', 16:44:57 INFO - 'LANGUAGE': 'en_US:en', 16:44:57 INFO - 'LOGNAME': 'cltbld', 16:44:57 INFO - 'MAIL': '/var/mail/cltbld', 16:44:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:57 INFO - 'MOZ_NO_REMOTE': '1', 16:44:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:57 INFO - 'NO_EM_RESTART': '1', 16:44:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:44:57 INFO - 'PWD': '/builds/slave/test-pgo', 16:44:57 INFO - 'SHELL': '/bin/bash', 16:44:57 INFO - 'SHLVL': '1', 16:44:57 INFO - 'TERM': 'linux', 16:44:57 INFO - 'TMOUT': '86400', 16:44:57 INFO - 'USER': 'cltbld', 16:44:57 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976', 16:44:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:57 INFO - '_': '/tools/buildbot/bin/python'} 16:44:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:44:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:44:59 INFO - Installing collected packages: mozsystemmonitor 16:44:59 INFO - Running setup.py install for mozsystemmonitor 16:44:59 INFO - Successfully installed mozsystemmonitor 16:44:59 INFO - Cleaning up... 16:44:59 INFO - Return code: 0 16:44:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:44: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')]} 16:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44: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')]} 16:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:59 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 0x7fc9774e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a39230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acb7f0>, '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 0x2a372d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a37760>, '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': '20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976', '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 16:44:59 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 16:44:59 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 16:44:59 INFO - Using env: {'DISPLAY': ':0', 16:44:59 INFO - 'HOME': '/home/cltbld', 16:44:59 INFO - 'LANG': 'en_US.UTF-8', 16:44:59 INFO - 'LANGUAGE': 'en_US:en', 16:44:59 INFO - 'LOGNAME': 'cltbld', 16:44:59 INFO - 'MAIL': '/var/mail/cltbld', 16:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:59 INFO - 'MOZ_NO_REMOTE': '1', 16:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:59 INFO - 'NO_EM_RESTART': '1', 16:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:44:59 INFO - 'PWD': '/builds/slave/test-pgo', 16:44:59 INFO - 'SHELL': '/bin/bash', 16:44:59 INFO - 'SHLVL': '1', 16:44:59 INFO - 'TERM': 'linux', 16:44:59 INFO - 'TMOUT': '86400', 16:44:59 INFO - 'USER': 'cltbld', 16:44:59 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976', 16:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:59 INFO - '_': '/tools/buildbot/bin/python'} 16:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:00 INFO - Downloading/unpacking blobuploader==1.2.4 16:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:01 INFO - Downloading blobuploader-1.2.4.tar.gz 16:45:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:45:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:45:01 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 16:45:01 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 16:45:01 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 16:45:01 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 16:45:01 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 16:45:01 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 16:45:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:45:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:02 INFO - Downloading docopt-0.6.1.tar.gz 16:45:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:45:02 INFO - Installing collected packages: blobuploader, requests, docopt 16:45:02 INFO - Running setup.py install for blobuploader 16:45:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:45:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:45:02 INFO - Running setup.py install for requests 16:45:03 INFO - Running setup.py install for docopt 16:45:03 INFO - Successfully installed blobuploader requests docopt 16:45:03 INFO - Cleaning up... 16:45:03 INFO - Return code: 0 16:45:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:45:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:03 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 0x7fc9774e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a39230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acb7f0>, '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 0x2a372d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a37760>, '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': '20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976', '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 16:45:03 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 16:45:03 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 16:45:03 INFO - Using env: {'DISPLAY': ':0', 16:45:03 INFO - 'HOME': '/home/cltbld', 16:45:03 INFO - 'LANG': 'en_US.UTF-8', 16:45:03 INFO - 'LANGUAGE': 'en_US:en', 16:45:03 INFO - 'LOGNAME': 'cltbld', 16:45:03 INFO - 'MAIL': '/var/mail/cltbld', 16:45:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:03 INFO - 'MOZ_NO_REMOTE': '1', 16:45:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:03 INFO - 'NO_EM_RESTART': '1', 16:45:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:45:03 INFO - 'PWD': '/builds/slave/test-pgo', 16:45:03 INFO - 'SHELL': '/bin/bash', 16:45:03 INFO - 'SHLVL': '1', 16:45:03 INFO - 'TERM': 'linux', 16:45:03 INFO - 'TMOUT': '86400', 16:45:03 INFO - 'USER': 'cltbld', 16:45:03 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976', 16:45:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:03 INFO - '_': '/tools/buildbot/bin/python'} 16:45:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:45:03 INFO - Running setup.py (path:/tmp/pip-qPa1HJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:45:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:45:03 INFO - Running setup.py (path:/tmp/pip-9DzIs8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:45:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:45:03 INFO - Running setup.py (path:/tmp/pip-3jLxHY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:45:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:45:03 INFO - Running setup.py (path:/tmp/pip-sJqWbM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:45:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:45:03 INFO - Running setup.py (path:/tmp/pip-KGHWJX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:45:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:45:03 INFO - Running setup.py (path:/tmp/pip-5u6FrL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:45:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:45:03 INFO - Running setup.py (path:/tmp/pip-EBvBv5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:45:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:45:03 INFO - Running setup.py (path:/tmp/pip-vrdu5u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:45:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:45:03 INFO - Running setup.py (path:/tmp/pip-EoL4GX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:45:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:45:04 INFO - Running setup.py (path:/tmp/pip-w1_7Bw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:45:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:45:04 INFO - Running setup.py (path:/tmp/pip-3IFKwM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:45:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:45:04 INFO - Running setup.py (path:/tmp/pip-MXwqT9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:45:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:45:04 INFO - Running setup.py (path:/tmp/pip-YUDyIF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:45:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:45:04 INFO - Running setup.py (path:/tmp/pip-Gi2xUD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:45:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:45:04 INFO - Running setup.py (path:/tmp/pip-HOo0lJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:45:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:45:04 INFO - Running setup.py (path:/tmp/pip-J9D9cP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:45:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:45:04 INFO - Running setup.py (path:/tmp/pip-Sptvoy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:45:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:45:04 INFO - Running setup.py install for manifestparser 16:45:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:45:04 INFO - Running setup.py install for mozcrash 16:45:04 INFO - Running setup.py install for mozdebug 16:45:04 INFO - Running setup.py install for mozdevice 16:45:05 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:45:05 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:45:05 INFO - Running setup.py install for mozfile 16:45:05 INFO - Running setup.py install for mozhttpd 16:45:05 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:45:05 INFO - Running setup.py install for mozinfo 16:45:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:45:05 INFO - Running setup.py install for mozInstall 16:45:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:45:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:45:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:45:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:45:05 INFO - Running setup.py install for mozleak 16:45:05 INFO - Running setup.py install for mozlog 16:45:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:45:05 INFO - Running setup.py install for moznetwork 16:45:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:45:05 INFO - Running setup.py install for mozprocess 16:45:05 INFO - Running setup.py install for mozprofile 16:45:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:45:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:45:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:45:05 INFO - Running setup.py install for mozrunner 16:45:06 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:45:06 INFO - Running setup.py install for mozscreenshot 16:45:06 INFO - Running setup.py install for moztest 16:45:06 INFO - Running setup.py install for mozversion 16:45:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:45:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:45:06 INFO - Cleaning up... 16:45:06 INFO - Return code: 0 16:45:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:45:06 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')]} 16:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:06 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')]} 16:45:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:06 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 0x7fc9774e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a39230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acb7f0>, '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 0x2a372d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a37760>, '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': '20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976', '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 16:45:06 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 16:45:06 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 16:45:06 INFO - Using env: {'DISPLAY': ':0', 16:45:06 INFO - 'HOME': '/home/cltbld', 16:45:06 INFO - 'LANG': 'en_US.UTF-8', 16:45:06 INFO - 'LANGUAGE': 'en_US:en', 16:45:06 INFO - 'LOGNAME': 'cltbld', 16:45:06 INFO - 'MAIL': '/var/mail/cltbld', 16:45:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:06 INFO - 'MOZ_NO_REMOTE': '1', 16:45:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:06 INFO - 'NO_EM_RESTART': '1', 16:45:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:45:06 INFO - 'PWD': '/builds/slave/test-pgo', 16:45:06 INFO - 'SHELL': '/bin/bash', 16:45:06 INFO - 'SHLVL': '1', 16:45:06 INFO - 'TERM': 'linux', 16:45:06 INFO - 'TMOUT': '86400', 16:45:06 INFO - 'USER': 'cltbld', 16:45:06 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976', 16:45:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:06 INFO - '_': '/tools/buildbot/bin/python'} 16:45:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:45:06 INFO - Running setup.py (path:/tmp/pip-jGGTj8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:45:06 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)) 16:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:45:06 INFO - Running setup.py (path:/tmp/pip-gElIdm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:45:06 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)) 16:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:45:06 INFO - Running setup.py (path:/tmp/pip-WsFkfr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:45:06 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)) 16:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:45:06 INFO - Running setup.py (path:/tmp/pip-jY6Dxn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:45:06 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)) 16:45:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:45:06 INFO - Running setup.py (path:/tmp/pip-oFYf8o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:45:07 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)) 16:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:45:07 INFO - Running setup.py (path:/tmp/pip-miqJ_f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:45:07 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)) 16:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:45:07 INFO - Running setup.py (path:/tmp/pip-YQBYvO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:45:07 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)) 16:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:45:07 INFO - Running setup.py (path:/tmp/pip-R_LlSl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:45:07 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)) 16:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:45:07 INFO - Running setup.py (path:/tmp/pip-KyevpX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:45:07 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)) 16:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:45:07 INFO - Running setup.py (path:/tmp/pip-03nDTi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:45:07 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)) 16:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:45:07 INFO - Running setup.py (path:/tmp/pip-RZxwfo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:45:07 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)) 16:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:45:07 INFO - Running setup.py (path:/tmp/pip-cUtlkS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:45:07 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)) 16:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:45:07 INFO - Running setup.py (path:/tmp/pip-Q22Khx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:45:07 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)) 16:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:45:07 INFO - Running setup.py (path:/tmp/pip-7J2JOg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:45:07 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)) 16:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:45:07 INFO - Running setup.py (path:/tmp/pip-kEYwHL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:45:07 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)) 16:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:45:07 INFO - Running setup.py (path:/tmp/pip-aR4SdA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:45:07 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)) 16:45:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:45:07 INFO - Running setup.py (path:/tmp/pip-7kmju7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:45:07 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)) 16:45:07 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)) 16:45:07 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)) 16:45:07 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)) 16:45:07 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)) 16:45:07 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)) 16:45:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:45:07 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 16:45:07 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 16:45:07 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 16:45:07 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 16:45:07 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 16:45:07 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 16:45:09 INFO - Downloading blessings-1.6.tar.gz 16:45:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:45:09 INFO - Installing collected packages: blessings 16:45:09 INFO - Running setup.py install for blessings 16:45:09 INFO - Successfully installed blessings 16:45:09 INFO - Cleaning up... 16:45:09 INFO - Return code: 0 16:45:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:45:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:45:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:45:10 INFO - Reading from file tmpfile_stdout 16:45:10 INFO - Current package versions: 16:45:10 INFO - argparse == 1.2.1 16:45:10 INFO - blessings == 1.6 16:45:10 INFO - blobuploader == 1.2.4 16:45:10 INFO - docopt == 0.6.1 16:45:10 INFO - manifestparser == 1.1 16:45:10 INFO - mozInstall == 1.12 16:45:10 INFO - mozcrash == 0.16 16:45:10 INFO - mozdebug == 0.1 16:45:10 INFO - mozdevice == 0.48 16:45:10 INFO - mozfile == 1.2 16:45:10 INFO - mozhttpd == 0.7 16:45:10 INFO - mozinfo == 0.9 16:45:10 INFO - mozleak == 0.1 16:45:10 INFO - mozlog == 3.1 16:45:10 INFO - moznetwork == 0.27 16:45:10 INFO - mozprocess == 0.22 16:45:10 INFO - mozprofile == 0.28 16:45:10 INFO - mozrunner == 6.11 16:45:10 INFO - mozscreenshot == 0.1 16:45:10 INFO - mozsystemmonitor == 0.0 16:45:10 INFO - moztest == 0.7 16:45:10 INFO - mozversion == 1.4 16:45:10 INFO - psutil == 3.1.1 16:45:10 INFO - requests == 1.2.3 16:45:10 INFO - wsgiref == 0.1.2 16:45:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:45:10 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')]} 16:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:10 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')]} 16:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:10 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 0x7fc9774e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a39230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acb7f0>, '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 0x2a372d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a37760>, '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': '20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976', '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 16:45:10 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 16:45:10 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 16:45:10 INFO - Using env: {'DISPLAY': ':0', 16:45:10 INFO - 'HOME': '/home/cltbld', 16:45:10 INFO - 'LANG': 'en_US.UTF-8', 16:45:10 INFO - 'LANGUAGE': 'en_US:en', 16:45:10 INFO - 'LOGNAME': 'cltbld', 16:45:10 INFO - 'MAIL': '/var/mail/cltbld', 16:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:10 INFO - 'MOZ_NO_REMOTE': '1', 16:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:10 INFO - 'NO_EM_RESTART': '1', 16:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:45:10 INFO - 'PWD': '/builds/slave/test-pgo', 16:45:10 INFO - 'SHELL': '/bin/bash', 16:45:10 INFO - 'SHLVL': '1', 16:45:10 INFO - 'TERM': 'linux', 16:45:10 INFO - 'TMOUT': '86400', 16:45:10 INFO - 'USER': 'cltbld', 16:45:10 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976', 16:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:10 INFO - '_': '/tools/buildbot/bin/python'} 16:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:10 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)) 16:45:10 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)) 16:45:10 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)) 16:45:10 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)) 16:45:10 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)) 16:45:10 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)) 16:45:10 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)) 16:45:10 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)) 16:45:10 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)) 16:45:10 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)) 16:45:10 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)) 16:45:10 INFO - Cleaning up... 16:45:10 INFO - Return code: 0 16:45:10 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:45:10 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')]} 16:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:10 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')]} 16:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:10 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 0x7fc9774e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a39230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acb7f0>, '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 0x2a372d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a37760>, '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': '20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976', '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 16:45:10 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 16:45:10 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 16:45:10 INFO - Using env: {'DISPLAY': ':0', 16:45:10 INFO - 'HOME': '/home/cltbld', 16:45:10 INFO - 'LANG': 'en_US.UTF-8', 16:45:10 INFO - 'LANGUAGE': 'en_US:en', 16:45:10 INFO - 'LOGNAME': 'cltbld', 16:45:10 INFO - 'MAIL': '/var/mail/cltbld', 16:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:10 INFO - 'MOZ_NO_REMOTE': '1', 16:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:10 INFO - 'NO_EM_RESTART': '1', 16:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:45:10 INFO - 'PWD': '/builds/slave/test-pgo', 16:45:10 INFO - 'SHELL': '/bin/bash', 16:45:10 INFO - 'SHLVL': '1', 16:45:10 INFO - 'TERM': 'linux', 16:45:10 INFO - 'TMOUT': '86400', 16:45:10 INFO - 'USER': 'cltbld', 16:45:10 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976', 16:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:10 INFO - '_': '/tools/buildbot/bin/python'} 16:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:10 INFO - Downloading/unpacking jsonschema 16:45:10 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 16:45:10 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 16:45:10 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 16:45:10 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 16:45:10 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 16:45:10 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 16:45:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:45:12 INFO - Downloading/unpacking functools32 (from jsonschema) 16:45:12 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 16:45:12 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 16:45:12 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 16:45:12 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 16:45:12 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 16:45:12 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 16:45:12 INFO - Downloading functools32-3.2.3-2.tar.gz 16:45:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:45:12 INFO - warning: no files found matching '*.txt' 16:45:12 INFO - no previously-included directories found matching 'build' 16:45:12 INFO - no previously-included directories found matching 'dist' 16:45:12 INFO - no previously-included directories found matching '.git*' 16:45:12 INFO - Installing collected packages: jsonschema, functools32 16:45:12 INFO - Running setup.py install for functools32 16:45:12 INFO - warning: no files found matching '*.txt' 16:45:12 INFO - no previously-included directories found matching 'build' 16:45:12 INFO - no previously-included directories found matching 'dist' 16:45:12 INFO - no previously-included directories found matching '.git*' 16:45:12 INFO - Successfully installed jsonschema functools32 16:45:12 INFO - Cleaning up... 16:45:12 INFO - Return code: 0 16:45:12 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:45:12 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')]} 16:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:12 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')]} 16:45:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:12 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 0x7fc9774e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a39230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acb7f0>, '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 0x2a372d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a37760>, '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': '20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976', '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 16:45:12 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 16:45:12 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 16:45:12 INFO - Using env: {'DISPLAY': ':0', 16:45:12 INFO - 'HOME': '/home/cltbld', 16:45:12 INFO - 'LANG': 'en_US.UTF-8', 16:45:12 INFO - 'LANGUAGE': 'en_US:en', 16:45:12 INFO - 'LOGNAME': 'cltbld', 16:45:12 INFO - 'MAIL': '/var/mail/cltbld', 16:45:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:12 INFO - 'MOZ_NO_REMOTE': '1', 16:45:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:12 INFO - 'NO_EM_RESTART': '1', 16:45:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:45:12 INFO - 'PWD': '/builds/slave/test-pgo', 16:45:12 INFO - 'SHELL': '/bin/bash', 16:45:12 INFO - 'SHLVL': '1', 16:45:12 INFO - 'TERM': 'linux', 16:45:12 INFO - 'TMOUT': '86400', 16:45:12 INFO - 'USER': 'cltbld', 16:45:12 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976', 16:45:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:12 INFO - '_': '/tools/buildbot/bin/python'} 16:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:13 INFO - Downloading/unpacking flake8 16:45:13 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 16:45:13 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 16:45:13 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 16:45:13 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 16:45:13 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 16:45:13 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 16:45:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:45:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:45:14 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 16:45:14 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 16:45:14 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 16:45:14 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 16:45:14 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 16:45:14 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 16:45:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:45:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:45:15 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 16:45:15 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 16:45:15 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 16:45:15 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 16:45:15 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 16:45:15 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 16:45:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:45:15 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 16:45:15 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 16:45:15 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 16:45:15 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 16:45:15 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 16:45:15 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 16:45:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:45:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:45:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:45:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:45:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:45:15 INFO - no previously-included directories found matching 'docs/_build' 16:45:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:45:15 INFO - Running setup.py install for pep8 16:45:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:45:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:45:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:45:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:45:15 INFO - no previously-included directories found matching 'docs/_build' 16:45:15 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:45:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:45:15 INFO - Cleaning up... 16:45:15 INFO - Return code: 0 16:45:15 INFO - Running post-action listener: _resource_record_post_action 16:45:15 INFO - Running post-action listener: _start_resource_monitoring 16:45:15 INFO - Starting resource monitoring. 16:45:15 INFO - ##### 16:45:15 INFO - ##### Running install step. 16:45:15 INFO - ##### 16:45:15 INFO - Running pre-action listener: _resource_record_pre_action 16:45:15 INFO - Running main action method: install 16:45:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:45:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:45:16 INFO - Reading from file tmpfile_stdout 16:45:16 INFO - Detecting whether we're running mozinstall >=1.0... 16:45:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:45:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:45:16 INFO - Reading from file tmpfile_stdout 16:45:16 INFO - Output received: 16:45:16 INFO - Usage: mozinstall [options] installer 16:45:16 INFO - Options: 16:45:16 INFO - -h, --help show this help message and exit 16:45:16 INFO - -d DEST, --destination=DEST 16:45:16 INFO - Directory to install application into. [default: 16:45:16 INFO - "/builds/slave/test-pgo"] 16:45:16 INFO - --app=APP Application being installed. [default: firefox] 16:45:16 INFO - mkdir: /builds/slave/test-pgo/build/application 16:45:16 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'] 16:45:16 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 16:45:31 INFO - Reading from file tmpfile_stdout 16:45:31 INFO - Output received: 16:45:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:45:31 INFO - Running post-action listener: _resource_record_post_action 16:45:31 INFO - ##### 16:45:31 INFO - ##### Running run-tests step. 16:45:31 INFO - ##### 16:45:31 INFO - Running pre-action listener: _resource_record_pre_action 16:45:31 INFO - Running main action method: run_tests 16:45:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:45:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:45:31 INFO - Python 2.7.3 16:45:31 INFO - Return code: 0 16:45:31 INFO - grabbing minidump binary from tooltool 16:45: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')]} 16:45:31 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 0x2acb7f0>, '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 0x2a372d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a37760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:45:31 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 16:45:31 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 16:45:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:45:31 INFO - Return code: 0 16:45:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:45:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:45:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:45:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:45:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:45:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:45:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:45:32 INFO - Return code: 0 16:45:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pf7KXa7FS6urjgMqW26CQg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 16:45:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Pf7KXa7FS6urjgMqW26CQg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:45:32 INFO - Using env: {'DISPLAY': ':0', 16:45:32 INFO - 'HOME': '/home/cltbld', 16:45:32 INFO - 'LANG': 'en_US.UTF-8', 16:45:32 INFO - 'LANGUAGE': 'en_US:en', 16:45:32 INFO - 'LOGNAME': 'cltbld', 16:45:32 INFO - 'MAIL': '/var/mail/cltbld', 16:45:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:45:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:32 INFO - 'MOZ_NO_REMOTE': '1', 16:45:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:45:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:32 INFO - 'NO_EM_RESTART': '1', 16:45:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:45:32 INFO - 'PWD': '/builds/slave/test-pgo', 16:45:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:45:32 INFO - 'SHELL': '/bin/bash', 16:45:32 INFO - 'SHLVL': '1', 16:45:32 INFO - 'TERM': 'linux', 16:45:32 INFO - 'TMOUT': '86400', 16:45:32 INFO - 'USER': 'cltbld', 16:45:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976', 16:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:32 INFO - '_': '/tools/buildbot/bin/python'} 16:45:32 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pf7KXa7FS6urjgMqW26CQg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:45:32 INFO - mozversion application_buildid: 20160218140410 16:45:32 INFO - mozversion application_changeset: 7141f2426f66c83c540f27196085cddcd5a227aa 16:45:32 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:45:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:45:32 INFO - mozversion application_name: Firefox 16:45:32 INFO - mozversion application_remotingname: firefox-dev 16:45:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:45:32 INFO - mozversion application_vendor: Mozilla 16:45:32 INFO - mozversion application_version: 46.0a2 16:45:32 INFO - mozversion platform_buildid: 20160218140410 16:45:32 INFO - mozversion platform_changeset: 7141f2426f66c83c540f27196085cddcd5a227aa 16:45:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:45:32 INFO - mozversion platform_version: 46.0a2 16:45:32 INFO - using testdate: 1455842732 16:45:32 INFO - actual date: 1455842732 16:45:32 INFO - starting webserver on 'localhost:48095' 16:45:32 INFO - SUITE-START | Running 3 tests 16:45:32 INFO - TEST-START | dromaeo_css 16:45:32 INFO - operating with platform_type : linux_ 16:45:32 INFO - Initialising browser for dromaeo_css test... 16:45:32 INFO - TEST-INFO | started process 29758 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8Praog/profile http://localhost:48095/getInfo.html) 16:45:36 INFO - PROCESS | 29758 | 16:45:36 INFO - PROCESS | 29758 | (process:29839): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:45:36 INFO - PROCESS | 29758 | __metrics Screen width/height:1600/1200 16:45:36 INFO - PROCESS | 29758 | colorDepth:24 16:45:36 INFO - PROCESS | 29758 | Browser inner width/height: 1024/697 16:45:36 INFO - PROCESS | 29758 | __metrics 16:45:37 INFO - TEST-INFO | 29758: exit 0 16:45:37 INFO - Browser initialized. 16:45:37 INFO - Running cycle 1/1 for dromaeo_css test... 16:45:37 INFO - TEST-INFO | started process 29888 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8Praog/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:45:39 INFO - PROCESS | 29888 | 16:45:39 INFO - PROCESS | 29888 | (process:29948): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:45:49 INFO - PROCESS | 29888 | RSS: Main: 141881344 16:45:49 INFO - PROCESS | 29888 | 16:46:39 INFO - PROCESS | 29888 | 1455842799390 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] 16:48:47 INFO - PROCESS | 29888 | Cycle 1(1): loaded http://localhost:48095/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48095/tests/dromaeo/cssquery-ext.html) 16:48:48 INFO - PROCESS | 29888 | RSS: Main: 146599936 16:48:48 INFO - PROCESS | 29888 | 16:51:50 INFO - PROCESS | 29888 | Cycle 1(1): loaded http://localhost:48095/tests/dromaeo/cssquery-ext.html (next: http://localhost:48095/tests/dromaeo/cssquery-jquery.html) 16:51:50 INFO - PROCESS | 29888 | RSS: Main: 145416192 16:51:50 INFO - PROCESS | 29888 | 16:54:52 INFO - PROCESS | 29888 | Cycle 1(1): loaded http://localhost:48095/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48095/tests/dromaeo/cssquery-mootools.html) 16:54:52 INFO - PROCESS | 29888 | RSS: Main: 144285696 16:54:52 INFO - PROCESS | 29888 | 16:57:54 INFO - PROCESS | 29888 | Cycle 1(1): loaded http://localhost:48095/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48095/tests/dromaeo/cssquery-prototype.html) 16:57:55 INFO - PROCESS | 29888 | RSS: Main: 144429056 16:57:55 INFO - PROCESS | 29888 | 17:00:57 INFO - PROCESS | 29888 | Cycle 1(1): loaded http://localhost:48095/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48095/tests/dromaeo/cssquery-yui.html) 17:00:58 INFO - PROCESS | 29888 | RSS: Main: 143790080 17:00:58 INFO - PROCESS | 29888 | 17:04:00 INFO - PROCESS | 29888 | Cycle 1(1): loaded http://localhost:48095/tests/dromaeo/cssquery-yui.html (next: http://localhost:48095/tests/dromaeo/cssquery-dojo.html) 17:04:00 INFO - PROCESS | 29888 | RSS: Main: 146284544 17:04:00 INFO - PROCESS | 29888 | 17:04:00 INFO - PROCESS | 29888 | __start_tp_report 17:04:00 INFO - PROCESS | 29888 | _x_x_mozilla_page_load 17:04:00 INFO - PROCESS | 29888 | _x_x_mozilla_page_load_details 17:04:00 INFO - PROCESS | 29888 | |i|pagename|runs| 17:04:00 INFO - PROCESS | 29888 | |0;dojo.html;3313.403587354276;3352.8658853645857;3374.9493757593655;3386.119608901686;3398.3033478136986;5533.750981205851;5554.222408862763;5556.055470570002;5559.332880054389;5572.804951826687;5477.917831232535;5480.150576660624;5544.584156188292;5552.000639884819;5569.498745112939;4983.053219888227;5081.085404627165;5151.407588127376;5153.742312884359;5276.577873770108;4828.637852161084;5016.548510634042;5048.570871475929;5050.84847454577;5155.175171972485;5016.673916195436;5066.1640829263315;5066.620003499752;5068.645194836363;5103.362079740033;5004.624653151028;5011.348524691785;5024.095662780698;5032.899342013176;5033.748312584356;4847.709137451729;4941.431735350445;4956.504349565051;4968.254761785725;4969.8012079516775;5309.840704778863;5349.652272602308;5357.919631205535;5369.060414427459;5375.919361209585;5869.413058694139;5899.498542623839;5910.497607703307;5929.169916211734;5945.16767652529;5846.7953621623465;5868.559858010666;5963.821085367446;5975;6062.090686397031;5503.532199763025;5511.338639363222;5525.419830917776;5531.446855314436;5535.6955367454775;5977.073553599199;5981.0729336952845;5984.670843103584;5988.490978266809;6004.459598636056;5784.59507834456;5790.247267855152;5823.126531020381;5823.5341172706085;5828.0966450200285;5926.496247818984;5927.881442371215;5938.346781853993;5949.9107513387335;5968.641881487125;5857.502112320501;5920.940790592125;5921.555883308769;5930.762769489258;5936.465718085393;5882.294124705063;5961.523078153824;5987.072003839412;6007.489363404072;6047.395260473917;4447.933281000787;4472.821087156477;4494.280915053576;4494.662900282427;4504;4006.4991876015497;4024.1549274652066;4059.7767122808527;4063.512378514597;4077.918441631151;5418.810341638024;5575.498205161555;5578.191162281447;5598.244237027949;5637.46444087811;5840.970795145997;5854.502367298742;5855.853603659943;5859.560532960045;5860.3260625027815;5408.486193811582;5448.891022179613;5497.312835895513;5522.5581953443625;5532.474414930575;5091.719955402415;5106.846794596168;5116.30929824469;5129.563987061141;5130.666506677054;6114.847128821815;6129.295131059896;6132.601380910227;6145.661988590581;6146.877062458815;5781.768729250783;5887.882242355215;5912.024515954819;5923.11153327013;5999.280086389486;5997.07045407945;6023.247094113236;6082.209312789486;6093.786717464867;6108.4807791338235;5758.827235182951;5808.07070868659;5833.562482813721;5838.211841401527;5844.181814545882;5766.423357664368;5837.29952405714;5887.911681324698;5921.822345329647;6012.849678758066;5749.13762935563;5757.539396848326;5773.24947756789;5787.913181302368;5803.216565763568;5686.9715651421475;5736.827895163152;5791.884162316815;5797.623154494944;5803.535717142703;5538.584606154474;5553.583481239004;5628.296462942132;5664.745086471201;5665.291838520185;5790.623609465371;5795.623284486495;5797.043487824631;5803.709814509342;5831.1253312001845;5527.53015993645;5690.402507736793;5696.11710184922;5701.771929122789;5709.628874123168 17:04:00 INFO - PROCESS | 29888 | |1;ext.html;521.4811262793521;555.7999120316687;566.710977401525;579.7940284208846;587.2248631806015;31616.99999999997;38888.22223555527;38898.416523752094;39111.804440977794;39135.21729565407;45170.548294517044;45828;45879.77060114695;46351.76824115883;46449.7677511612;9035.096490350978;9250.074992500764;9259.814803703923;9287.164155226028;9287.767805804875;8964.417312874675;9083;9093.318001149908;9129.22401595865;9138.954305228497;9102.954485227565;9177.632894684204;9214.815703685923;9215.677451289206;9232.538373081352;9096.090390960884;9164.221041211506;9180.311476639245;9183.908160918372;9184.494852783095;8933.240674542607;9020.413673111227;9068.093190680946;9072.8639070414;9100.453972761656;42166.578334216574;43170;43217.13565728668;43296.134077318595;43314.35028474576;3912.589178136283;3959.4852669153115;4267.210566045261;4378.846740364103;4379.364992076163;32685.18287042819;32798.18004549881;32971.67028329734;33079.83460082684;33935.32129357399;4143.56492568279;4158.750474971512;4199.307114326132;4218.514870789868;4256.063665993476;290221;293124;293475;294776;312470.4376478126;49467.50532494701;67316;67986.32013679898;68144;68162.65918670375;60134;60437.395626044054;60613.696931515944;60642.393576064555;60745.69627151836;17706.734398984026;18079.276828926697;18090.819091808913;18109.36617218391;18154.636907262044;13616.114952528054;13945.65135871591;13982.44070237179;14014.85985140156;14028.50900218508;21339.67990480144;21629.78370216309;21718;21805.454863628536;21838;7621.504602200839;7804.336631386395;7884.802879927933;7891.487053341514;7925.484843485155;943.4806382661376;1083.701981954953;1091.3560999010622;1127.5940661362067;1280.8283153480734;30460.69539304623;30461.543076853864;30558.54162187569;31470.37059258802;31598;1154.2974113183157;1189.250772013626;1208.015467394071;1242.2049888071642;1269.2955409747678;16735.330586776636;16812.83187168137;16825.747613785803;16978;17081.231344589523;270528;362048;369679;374622;375076;49361;49813;49898.750506247234;50031.499685003415;50200.246996295085;1450.3400952566558;1485.7771334299941;1497.4160077569538;1503.4362114207172;1512.7125846089427;27496.17511474659;28040.43919121647;28587;30003.24991875133;30966.380672385974;46896.29655555238;47541.76229118832;47588.762056189495;47592.04815903732;47722.5227747732;220969;221791;223043;223445;223707;34562.30875382529;35055.649443506256;35278.29443411066;35514.11214719549;35601.46597800983;46509.53490465052;47171.528284718086;47339.28991065068;47441.76279118582;47897.76051119722;37295.25409491849;39722.40416393698;40236.19527609373;41188.1762364757;41617.79191104025;36837;38137.427938581495;38804.41793373158;39468;39863.60136398599;36641.26717465689;36766.816165919;36912;37249.81375093107;39226.80386598049;32912.835435823625;33328.66671333255;33373.33253334968;33424.66575334313;33755.493667595496;26597.734022659526;27266.318342041606;27456.725432745417;28221.294467638472;28834.855825720737 17:04:00 INFO - PROCESS | 29888 | |2;jquery.html;399.8400639744102;405.46073721949807;405.8173821780199;409.8504046023202;410.2308172177168;17036.23336949837;17252.482425527254;17641.117944102793;18277.451676449728;18993;11949.044076473883;13404.597862064129;15548.06711597305;15725.292361843716;15756.448524301652;4598.816047358102;4787.234042553175;4790.7604619769045;4793.065352256312;4797.616190704753;4741.506425475964;4830.758462076899;4898.7060776353355;5156.53591176794;5162.664426812245;5107.080725469414;5129.820456284031;5745.770169193227;5936.347001829795;5959.851003724898;5610.961972035146;5629;5641.153826925953;5859.589828711992;5909.527237820964;5430.239766432703;5440.6735595863975;5441.646292990982;5446.2375267462585;5468.043092458804;13446.865531344756;13493;18905.527361816065;20066.899665501725;21498.355049348545;2143.2070134050346;2217.623004089309;2280.441291883483;2311.722593288799;2393.246127469841;10123.341982771097;10192.133668638175;10241.385516869012;10420.114290285335;10486;1832.2670931627322;1854.6568884756364;1903.6002439487725;1922.884626922389;1966.7148263501713;59318.40681593172;59782.40217597812;61564.69217653883;61614;62460.687696561225;10500.05499505033;10522.947385263025;10523.158147348193;10584;10684.145268378512;13715.862841371458;13881;13882.791758123636;13995.440182392795;14009.369578368794;7908.644111015018;8000.519968801774;8202.835943281101;8219.219174178443;8241.629126689193;8133.715319963773;8154.714584989615;8218.054923683852;8242.093369729326;8246.05170405399;4710.29345598163;4723.267893476516;4763.285507173951;4798.4001999750035;4829.975850120727;1896.8672192946638;1984.811442912921;2039.7246371739923;2061.288855344904;2094.1518684932626;947.7109481608038;957.1529196661005;1006.954687039085;1041.739565108723;1058.941758203306;17307.39424120175;17307.826921730873;17500.387486437914;17577.824221757874;18217.271309147487;978.4814048554277;1005.5123265216364;1022.8158931392272;1043.7495001199657;1095.3756358875523;10198.592056317813;10216.642417515352;10266.486675666336;10303.896961030294;10304.484775761182;627982;629819;630272;658039;663415;73288;75588;75875;76804.5051174204;79475.20524794678;1146.6674664347413;1164.6214980131492;1167.0371943146938;1179.1215544419463;1183.7928362536522;15589.220538972779;15750.684986300439;15779.447719329768;15840.128792916501;16064.518064458085;34268.82865585656;35499.46750798688;36721;39120;39969;44674.3298850511;45923.77038114922;46018.76990615026;46434.07131857411;50092.74953625354;10043.849342260019;10212.744681383025;10444.791104178026;10454.477276136011;10754.838677419688;8353.122922093093;11893.524259029542;12123.515059397878;12249.510019599116;12384.62846114618;7945.8410831781885;8012.479188852706;8023.358131349595;8023.6389362479995;8221.958890205511;7834;7980.960095199487;8051.2351326623875;8174.632141553763;8275.83448331042;7904;8092.4335296531035;8249;8253.33973282148;8341.16588341161;10600.840987385349;10715.624953126604;10834.67495975122;10838.187135964676;10945.288556243819;10947;10990.571225740603;11020.173486988348;11121.944390277997;11162.218644694793 17:04:00 INFO - PROCESS | 29888 | |3;mootools.html;1582.3828706804345;1612.459825958304;1880.962380752385;1937.4478273692;1975.4863735428785;8479.448835825668;8512.70205542806;8536.701215457444;8555.272801811845;8834.293256539462;8343.249107580317;8403.201695838901;8407.831843363128;8470.322374210064;8472.491650500975;2443.9144629937955;2472.9010839566395;2474.1093206445667;2485.6768620079365;2486.7513248675077;2463.519613675334;2491.5141547398266;2494.48862983088;2501.8123640726926;2505.7744802967727;2441.7802397784194;2481.9875900620473;2492.700875894895;2503.8748062596887;2510.836795608289;2500.8124390670773;2516.509280690266;2529.6079107738237;2530.4306531030556;2532.278300684296;2465.1372019793107;2480.7891329237036;2495.6506089147533;2501.5872381057284;2508.586083296254;8788.824223515494;8794.296456283482;8815.735527934172;8828.514431706253;8901.465912045298;5314.388845282803;5475.863103422406;5481.534069604048;5497.202905578709;5520.585956053312;3284.868605255787;3287.4411350070545;3317.5355450236984;3370.3427831572853;3392.4402473591826;1140.4981808004452;1149.9367534785667;1157.1090260499452;1172.3083380805365;1175.0423404925045;12557.246565206116;12604.054695897752;12709.809352859622;12717.809232861422;12738.80891786624;4815.855524334275;4862.80548778052;4868.2210846264425;4921.384826896638;4943.085529177114;10136.898631013742;10141.340812847142;10167.644132455329;10200.234982376203;10214.591416343412;5502.5597952163735;5508.118701007899;5529.585281103933;5535.750891209906;5537.335519737658;4951.801927922915;4995.350604421475;5010.298558201782;5043.4956504349275;5050.292958985745;3858.2090671412293;3860.4209368594375;3876.1666241758157;3882.2235552889533;3904.355781296111;1134.5064896769932;1150.79285728568;1163.668354518958;1164.0512981919708;1185.851768528934;1078.6763970808884;1089.983650245247;1097.8353247013013;1139.5897476908306;1183.0535571542732;7709.575973321521;7732.729354472566;7740.109887363025;7757.26306000929;7772.611369431505;1153.6366044695894;1182.456070207697;1190.0301254477572;1191.6544202181444;1196.0551164580058;6252.093446450239;6387.329330420239;6406.5515413920575;6459.806205813833;6469.061986012002;10709.839352409721;10988.890111098786;11014.944925275322;11117.888821111685;11132.443377831076;10510.579576816994;10858.294210876267;10912.181586381053;10933.289336193122;10990.505427255792;8264.132266112092;8427.536485493234;8434.451760635538;8439.156084391512;8511.702090426805;7909.129995700353;7932.563708996061;7935.722249721232;8042.276195142465;8070;9337.439753614804;9479.146876781122;9616.423014618866;9622.037796220322;9718.902810972082;9684.95157524208;9871.210303175585;10001.749956251151;10050.798984020425;10194;7309.305615966475;7426.331630153096;7500.399968002655;7517.248275172439;7536.585487798005;8328.708495202638;8336.791580210544;8417.579121044046;8421.70524031656;8426.873596896174;7058.188308344606;7858.921410785819;7939.84120317602;8004.279614834692;8189.672413103409;6951.895721564079;7718.073831140075;7858.803529911798;7902.288794008567;7914.16901225363;7779.57212353326;7800.414968877243;7801.102873169658;7818.140004599376;7841.215878412113;7144.035555199982;7147.785566433015;7176.96411517939;7196.316349946746;7207.5675459472595;6886.139232595926;6919.688614012281;6996.230414654282;7177.605231712306;7192.8921066183 17:04:00 INFO - PROCESS | 29888 | |4;prototype.html;375.7351067497414;387.2815926456423;388.35339160298116;390.0813584009659;394.27453485586517;6324.778632747843;6358.650274234921;6423.3897779710915;6452.64510451925;6463.03054541819;6129.509639228862;6301.149344838445;6320.11518387425;6368.04479328101;6372.394622510866;4935.580475659555;4943.085529177114;4950.702957822524;4954.826581069663;4963.1810751226185;4963.1810751226;4966.9751651241695;4972.502749725017;4975.4029516457895;4980.452150263468;4615.799892028063;4812.87967800806;4837.371141751585;4839.104765618372;4844.927326090112;4818.662693611449;4840.903181936377;4841.2496063110275;4841.273808928671;4853.296272040552;4236.809343579546;4244.384564238199;4250.213710463574;4257.787110644455;4264.552222016675;5901.822945311605;5953.226080609493;6023.548233882432;6026.608270462406;6038.365971573009;5663.5186009189265;5671.319441667027;5678.858028549278;5683.630564013326;5697.487226149667;6654.401103900624;6675.299093595151;6695.7656482023385;6738.191417029988;6761.188657361099;4686.062787442525;4699.778057705022;4701.271302948048;4702.788374523155;4705.200115980291;6933.826654333631;6947.756828510978;7110.893336599956;7111.537750046179;7113.928860711379;4849.078675051729;4890.95109048912;4895.583875370562;4897.608191344684;4917.0903382874285;4949.777260023236;4959.429665588431;4963.255511673278;4970.17992031318;4972.925406118911;5586.91619625706;5691.459311365496;5703.344115426779;5719.914201286984;5722.914156287659;6774.119364482585;6786.083878676414;6788.083608712859;6800.285969973181;6822.795316140524;1757.5606098475382;1805.8194180581836;1808.3851490493296;1809.4119411191416;1810.719338502508;1242.0870660064845;1250.1124201816813;1259.5213818748816;1275;1275.2348590845604;6376.202974628171;6451.548391612542;6483.3516648335735;6495.772647957393;6504.577202481918;6923.6192009439965;6926.064981227571;6994.370506654323;7011.824704382431;7020;6251;6325.399087086719;6344.302126766052;6366.84082897922;6424.972004479261;3739.962600374016;3750.9249815003545;3774.301754175486;3780.678642315379;3786.1481166737262;7160.606166660779;7174.246704096099;7182.569045857265;7227.855442891113;7243.818904527429;6967.721291148398;7062.92937070633;7106.431485481149;7123.964380178066;7127.322904324081;7175.533590316717;7176.354128128389;7199.964000180071;7202.675879585431;7208.423326133897;6902.620355880475;6912.827179320558;6926.44588432914;6930.168379794457;6950.721971121301;6691.498137639794;6839.110915581142;6855.794326170223;6918.654067296716;6928.757493487704;7194.964025179841;7213.314735100157;7226.277372262942;7231.963840180765;7235.2041275458605;4943;4944.258361245698;4946.579540739078;4947.381577302837;4949.084419382426;6821.1814582250445;6902.930970690229;6944.93055069463;7089.326513981164;7105.644717764195;6800.557963732342;6837.076994605664;6849.657517124024;6864.862702746017;6866.798310295579;6820.761273355409;6821.283765204582;6824.488163387865;6832;6847.965760171167;6606.9008964866525;6740.224874139537;6740.528163028541;6762.391384775394;6772.55978361405;6841.589504629738;6860.108185935796;6879.449644028366;6890.724371025303;6906.343897329745;6532.477401807749;6690.899636505359;6708.295628958889;6709.429698475684;6728.629925354153 17:04:00 INFO - PROCESS | 29888 | |5;yui.html;907.4192516789252;913.036746232725;921.0881227584691;929.8655640119055;931.3108299858103;14201;14526.201058941753;14537.418503259883;14603.634909127277;14607.415703371866;13960.092593981384;13971.16173029619;13984.230867302294;14015.509457169;14102.224377659224;883.6995421556669;888.1074520107284;892.4377642085509;911.8495448251031;919.1773362840254;895.8387490251752;899.5187574647565;903.1961554216753;906.0893801729253;907.224323203658;944.2068662323646;959.3140904253457;959.4579062829479;961.4087336288168;962.2061799015805;940.3981451870808;941.1341565759484;948.5589201021559;949.4635530925005;954.065016284042;696.5124412910983;702.1854648607641;703.4723957032226;707.4764674141098;709.9361057504849;14568.271586420637;14761.55715328542;14819.629509262248;14830.258487075604;14866.554003379915;13936.58190254294;13998;14046.1572305662;14103.224322662249;14154.50459233932;11296.265742726697;11382.260153090023;11473.885261147365;11621;11825.467853946593;3763.9435408468894;3771.15149091455;3778;3811;3899.025243689078;48443.27335089976;48685.75657121727;49214;49749.50250497521;49810.50189498131;10655.84016239757;10940.507677154388;11103.555857765761;11193.944030279796;11251.887481125248;18785;19135.617287654168;19165.61668766617;19457.31899383543;19530;7933.206679332136;7943.841123177504;7973.641186146638;7997.480163789335;8233.547154906419;4298.505671847715;4365.257906155961;4422.7346359218545;4443.733375997451;4493.977530112328;3169.889053883103;3187.4581321175456;3201.2637093468634;3219.3400352927592;3222.8227447490613;572.321798668579;581.7556626216999;582.6533212738499;588.0884628825304;588.8351261646745;557.2115456628825;568.3889818445188;616.9444749972524;658.4370363339372;685.6023506366296;9074.727758167266;9615.615375385047;9655.613775448903;9679.758006049906;9759.658411955548;584.4009889862924;681.5399605266425;723.1755798389839;743.4647054121024;746.5446077892482;4291.592298731615;4345.891352716144;4387.210302145644;4455.643548516111;4487.730736155841;62039.6898015507;63888;64132;64315.67842160759;64359.678201608695;55914.72042639761;56535.71732141313;56653;56785;57244.427555724746;49444.763880902545;49462.75268623634;49519.75240123848;49880;50206.99586008333;8529.872051919103;8532.872006919777;8656.523891186045;8950.060243674581;8959.731208063507;37427.251454971294;37455.25089498249;37512.43731344087;37729.43405848969;39800.20399591934;48795.26807097825;48832.779180520774;48994.75502622607;49154.26268606045;49921.500784993135;11715.648530544097;11897.286162830258;12081;12336.444859981142;12706.745865082832;12177.817332739838;12883.935580322039;13121.540746073842;13578.25319607431;13978.720425591635;12049.246301062289;12356;13311.33443327849;13354.799678004643;13515.391807368494;12674.206676153948;12919.418626161658;13029.934850325688;13300.800487992881;13463.932680336535;12171.33057681836;12654.367281635698;12859.807102893277;12979.740405191655;13341.19952802796;9761.267904907018;9930.751731206778;10122.848157277795;10185.592576296865;10489.895101048893;10034.347767395097;10345;10400.479976001321;10465.476726163814;10489.108425783588 17:04:00 INFO - PROCESS | 29888 | __end_tp_report 17:04:00 INFO - PROCESS | 29888 | __start_cc_report 17:04:00 INFO - PROCESS | 29888 | _x_x_mozilla_cycle_collect,295 17:04:00 INFO - PROCESS | 29888 | __end_cc_report 17:04:00 INFO - PROCESS | 29888 | __startTimestamp1455843840508__endTimestamp 17:04:00 INFO - PROCESS | 29888 | 17:04:00 INFO - PROCESS | 29888 | ------- Summary: start ------- 17:04:00 INFO - PROCESS | 29888 | Number of tests: 6 17:04:00 INFO - PROCESS | 29888 | 17:04:00 INFO - PROCESS | 29888 | [#0] dojo.html Cycles:165 Average:5482.74 Median:5690.40 stddev:601.59 (10.6%) stddev-sans-first:578.86 17:04:00 INFO - PROCESS | 29888 | Values: 3313.4 3352.9 3374.9 3386.1 3398.3 5533.8 5554.2 5556.1 5559.3 5572.8 5477.9 5480.2 5544.6 5552.0 5569.5 4983.1 5081.1 5151.4 5153.7 5276.6 4828.6 5016.5 5048.6 5050.8 5155.2 5016.7 5066.2 5066.6 5068.6 5103.4 5004.6 5011.3 5024.1 5032.9 5033.7 4847.7 4941.4 4956.5 4968.3 4969.8 5309.8 5349.7 5357.9 5369.1 5375.9 5869.4 5899.5 5910.5 5929.2 5945.2 5846.8 5868.6 5963.8 5975.0 6062.1 5503.5 5511.3 5525.4 5531.4 5535.7 5977.1 5981.1 5984.7 5988.5 6004.5 5784.6 5790.2 5823.1 5823.5 5828.1 5926.5 5927.9 5938.3 5949.9 5968.6 5857.5 5920.9 5921.6 5930.8 5936.5 5882.3 5961.5 5987.1 6007.5 6047.4 4447.9 4472.8 4494.3 4494.7 4504.0 4006.5 4024.2 4059.8 4063.5 4077.9 5418.8 5575.5 5578.2 5598.2 5637.5 5841.0 5854.5 5855.9 5859.6 5860.3 5408.5 5448.9 5497.3 5522.6 5532.5 5091.7 5106.8 5116.3 5129.6 5130.7 6114.8 6129.3 6132.6 6145.7 6146.9 5781.8 5887.9 5912.0 5923.1 5999.3 5997.1 6023.2 6082.2 6093.8 6108.5 5758.8 5808.1 5833.6 5838.2 5844.2 5766.4 5837.3 5887.9 5921.8 6012.8 5749.1 5757.5 5773.2 5787.9 5803.2 5687.0 5736.8 5791.9 5797.6 5803.5 5538.6 5553.6 5628.3 5664.7 5665.3 5790.6 5795.6 5797.0 5803.7 5831.1 5527.5 5690.4 5696.1 5701.8 5709.6 17:04:00 INFO - PROCESS | 29888 | 17:04:00 INFO - PROCESS | 29888 | [#1] ext.html Cycles:180 Average:47434.49 Median:21512.20 stddev:77241.45 (359.1%) stddev-sans-first:77377.82 17:04:00 INFO - PROCESS | 29888 | Values: 521.5 555.8 566.7 579.8 587.2 31617.0 38888.2 38898.4 39111.8 39135.2 45170.5 45828.0 45879.8 46351.8 46449.8 9035.1 9250.1 9259.8 9287.2 9287.8 8964.4 9083.0 9093.3 9129.2 9139.0 9103.0 9177.6 9214.8 9215.7 9232.5 9096.1 9164.2 9180.3 9183.9 9184.5 8933.2 9020.4 9068.1 9072.9 9100.5 42166.6 43170.0 43217.1 43296.1 43314.4 3912.6 3959.5 4267.2 4378.8 4379.4 32685.2 32798.2 32971.7 33079.8 33935.3 4143.6 4158.8 4199.3 4218.5 4256.1 290221.0 293124.0 293475.0 294776.0 312470.4 49467.5 67316.0 67986.3 68144.0 68162.7 60134.0 60437.4 60613.7 60642.4 60745.7 17706.7 18079.3 18090.8 18109.4 18154.6 13616.1 13945.7 13982.4 14014.9 14028.5 21339.7 21629.8 21718.0 21805.5 21838.0 7621.5 7804.3 7884.8 7891.5 7925.5 943.5 1083.7 1091.4 1127.6 1280.8 30460.7 30461.5 30558.5 31470.4 31598.0 1154.3 1189.3 1208.0 1242.2 1269.3 16735.3 16812.8 16825.7 16978.0 17081.2 270528.0 362048.0 369679.0 374622.0 375076.0 49361.0 49813.0 49898.8 50031.5 50200.2 1450.3 1485.8 1497.4 1503.4 1512.7 27496.2 28040.4 28587.0 30003.2 30966.4 46896.3 47541.8 47588.8 47592.0 47722.5 220969.0 221791.0 223043.0 223445.0 223707.0 34562.3 35055.6 35278.3 35514.1 35601.5 46509.5 47171.5 47339.3 47441.8 47897.8 37295.3 39722.4 40236.2 41188.2 41617.8 36837.0 38137.4 38804.4 39468.0 39863.6 36641.3 36766.8 36912.0 37249.8 39226.8 32912.8 33328.7 33373.3 33424.7 33755.5 26597.7 27266.3 27456.7 28221.3 28834.9 17:04:00 INFO - PROCESS | 29888 | 17:04:00 INFO - PROCESS | 29888 | [#2] jquery.html Cycles:180 Average:31006.20 Median:18331.04 stddev:104863.65 (572.1%) stddev-sans-first:105132.63 17:04:00 INFO - PROCESS | 29888 | Values: 399.8 405.5 405.8 409.9 410.2 17036.2 17252.5 17641.1 18277.5 18993.0 11949.0 13404.6 15548.1 15725.3 15756.4 4598.8 4787.2 4790.8 4793.1 4797.6 4741.5 4830.8 4898.7 5156.5 5162.7 5107.1 5129.8 5745.8 5936.3 5959.9 5611.0 5629.0 5641.2 5859.6 5909.5 5430.2 5440.7 5441.6 5446.2 5468.0 13446.9 13493.0 18905.5 20066.9 21498.4 2143.2 2217.6 2280.4 2311.7 2393.2 10123.3 10192.1 10241.4 10420.1 10486.0 1832.3 1854.7 1903.6 1922.9 1966.7 59318.4 59782.4 61564.7 61614.0 62460.7 10500.1 10522.9 10523.2 10584.0 10684.1 13715.9 13881.0 13882.8 13995.4 14009.4 7908.6 8000.5 8202.8 8219.2 8241.6 8133.7 8154.7 8218.1 8242.1 8246.1 4710.3 4723.3 4763.3 4798.4 4830.0 1896.9 1984.8 2039.7 2061.3 2094.2 947.7 957.2 1007.0 1041.7 1058.9 17307.4 17307.8 17500.4 17577.8 18217.3 978.5 1005.5 1022.8 1043.7 1095.4 10198.6 10216.6 10266.5 10303.9 10304.5 627982.0 629819.0 630272.0 658039.0 663415.0 73288.0 75588.0 75875.0 76804.5 79475.2 1146.7 1164.6 1167.0 1179.1 1183.8 15589.2 15750.7 15779.4 15840.1 16064.5 34268.8 35499.5 36721.0 39120.0 39969.0 44674.3 45923.8 46018.8 46434.1 50092.7 10043.8 10212.7 10444.8 10454.5 10754.8 8353.1 11893.5 12123.5 12249.5 12384.6 7945.8 8012.5 8023.4 8023.6 8222.0 7834.0 7981.0 8051.2 8174.6 8275.8 7904.0 8092.4 8249.0 8253.3 8341.2 10600.8 10715.6 10834.7 10838.2 10945.3 10947.0 10990.6 11020.2 11121.9 11162.2 17:04:00 INFO - PROCESS | 29888 | 17:04:00 INFO - PROCESS | 29888 | [#3] mootools.html Cycles:180 Average:6134.63 Median:5026.90 stddev:3253.22 (64.7%) stddev-sans-first:3244.35 17:04:00 INFO - PROCESS | 29888 | Values: 1582.4 1612.5 1881.0 1937.4 1975.5 8479.4 8512.7 8536.7 8555.3 8834.3 8343.2 8403.2 8407.8 8470.3 8472.5 2443.9 2472.9 2474.1 2485.7 2486.8 2463.5 2491.5 2494.5 2501.8 2505.8 2441.8 2482.0 2492.7 2503.9 2510.8 2500.8 2516.5 2529.6 2530.4 2532.3 2465.1 2480.8 2495.7 2501.6 2508.6 8788.8 8794.3 8815.7 8828.5 8901.5 5314.4 5475.9 5481.5 5497.2 5520.6 3284.9 3287.4 3317.5 3370.3 3392.4 1140.5 1149.9 1157.1 1172.3 1175.0 12557.2 12604.1 12709.8 12717.8 12738.8 4815.9 4862.8 4868.2 4921.4 4943.1 10136.9 10141.3 10167.6 10200.2 10214.6 5502.6 5508.1 5529.6 5535.8 5537.3 4951.8 4995.4 5010.3 5043.5 5050.3 3858.2 3860.4 3876.2 3882.2 3904.4 1134.5 1150.8 1163.7 1164.1 1185.9 1078.7 1090.0 1097.8 1139.6 1183.1 7709.6 7732.7 7740.1 7757.3 7772.6 1153.6 1182.5 1190.0 1191.7 1196.1 6252.1 6387.3 6406.6 6459.8 6469.1 10709.8 10988.9 11014.9 11117.9 11132.4 10510.6 10858.3 10912.2 10933.3 10990.5 8264.1 8427.5 8434.5 8439.2 8511.7 7909.1 7932.6 7935.7 8042.3 8070.0 9337.4 9479.1 9616.4 9622.0 9718.9 9685.0 9871.2 10001.7 10050.8 10194.0 7309.3 7426.3 7500.4 7517.2 7536.6 8328.7 8336.8 8417.6 8421.7 8426.9 7058.2 7858.9 7939.8 8004.3 8189.7 6951.9 7718.1 7858.8 7902.3 7914.2 7779.6 7800.4 7801.1 7818.1 7841.2 7144.0 7147.8 7177.0 7196.3 7207.6 6886.1 6919.7 6996.2 7177.6 7192.9 17:04:00 INFO - PROCESS | 29888 | 17:04:00 INFO - PROCESS | 29888 | [#4] prototype.html Cycles:180 Average:5674.15 Median:6374.30 stddev:1680.76 (26.4%) stddev-sans-first:1637.75 17:04:00 INFO - PROCESS | 29888 | Values: 375.7 387.3 388.4 390.1 394.3 6324.8 6358.7 6423.4 6452.6 6463.0 6129.5 6301.1 6320.1 6368.0 6372.4 4935.6 4943.1 4950.7 4954.8 4963.2 4963.2 4967.0 4972.5 4975.4 4980.5 4615.8 4812.9 4837.4 4839.1 4844.9 4818.7 4840.9 4841.2 4841.3 4853.3 4236.8 4244.4 4250.2 4257.8 4264.6 5901.8 5953.2 6023.5 6026.6 6038.4 5663.5 5671.3 5678.9 5683.6 5697.5 6654.4 6675.3 6695.8 6738.2 6761.2 4686.1 4699.8 4701.3 4702.8 4705.2 6933.8 6947.8 7110.9 7111.5 7113.9 4849.1 4891.0 4895.6 4897.6 4917.1 4949.8 4959.4 4963.3 4970.2 4972.9 5586.9 5691.5 5703.3 5719.9 5722.9 6774.1 6786.1 6788.1 6800.3 6822.8 1757.6 1805.8 1808.4 1809.4 1810.7 1242.1 1250.1 1259.5 1275.0 1275.2 6376.2 6451.5 6483.4 6495.8 6504.6 6923.6 6926.1 6994.4 7011.8 7020.0 6251.0 6325.4 6344.3 6366.8 6425.0 3740.0 3750.9 3774.3 3780.7 3786.1 7160.6 7174.2 7182.6 7227.9 7243.8 6967.7 7062.9 7106.4 7124.0 7127.3 7175.5 7176.4 7200.0 7202.7 7208.4 6902.6 6912.8 6926.4 6930.2 6950.7 6691.5 6839.1 6855.8 6918.7 6928.8 7195.0 7213.3 7226.3 7232.0 7235.2 4943.0 4944.3 4946.6 4947.4 4949.1 6821.2 6902.9 6944.9 7089.3 7105.6 6800.6 6837.1 6849.7 6864.9 6866.8 6820.8 6821.3 6824.5 6832.0 6848.0 6606.9 6740.2 6740.5 6762.4 6772.6 6841.6 6860.1 6879.4 6890.7 6906.3 6532.5 6690.9 6708.3 6709.4 6728.6 17:04:00 INFO - PROCESS | 29888 | 17:04:00 INFO - PROCESS | 29888 | [#5] yui.html Cycles:180 Average:14981.36 Median:4471.69 stddev:17303.19 (387.0%) stddev-sans-first:17319.46 17:04:00 INFO - PROCESS | 29888 | Values: 907.4 913.0 921.1 929.9 931.3 14201.0 14526.2 14537.4 14603.6 14607.4 13960.1 13971.2 13984.2 14015.5 14102.2 883.7 888.1 892.4 911.8 919.2 895.8 899.5 903.2 906.1 907.2 944.2 959.3 959.5 961.4 962.2 940.4 941.1 948.6 949.5 954.1 696.5 702.2 703.5 707.5 709.9 14568.3 14761.6 14819.6 14830.3 14866.6 13936.6 13998.0 14046.2 14103.2 14154.5 11296.3 11382.3 11473.9 11621.0 11825.5 3763.9 3771.2 3778.0 3811.0 3899.0 48443.3 48685.8 49214.0 49749.5 49810.5 10655.8 10940.5 11103.6 11193.9 11251.9 18785.0 19135.6 19165.6 19457.3 19530.0 7933.2 7943.8 7973.6 7997.5 8233.5 4298.5 4365.3 4422.7 4443.7 4494.0 3169.9 3187.5 3201.3 3219.3 3222.8 572.3 581.8 582.7 588.1 588.8 557.2 568.4 616.9 658.4 685.6 9074.7 9615.6 9655.6 9679.8 9759.7 584.4 681.5 723.2 743.5 746.5 4291.6 4345.9 4387.2 4455.6 4487.7 62039.7 63888.0 64132.0 64315.7 64359.7 55914.7 56535.7 56653.0 56785.0 57244.4 49444.8 49462.8 49519.8 49880.0 50207.0 8529.9 8532.9 8656.5 8950.1 8959.7 37427.3 37455.3 37512.4 37729.4 39800.2 48795.3 48832.8 48994.8 49154.3 49921.5 11715.6 11897.3 12081.0 12336.4 12706.7 12177.8 12883.9 13121.5 13578.3 13978.7 12049.2 12356.0 13311.3 13354.8 13515.4 12674.2 12919.4 13029.9 13300.8 13463.9 12171.3 12654.4 12859.8 12979.7 13341.2 9761.3 9930.8 10122.8 10185.6 10489.9 10034.3 10345.0 10400.5 10465.5 10489.1 17:04:00 INFO - PROCESS | 29888 | -------- Summary: end -------- 17:04:00 INFO - PROCESS | 29888 | 17:04:01 INFO - TEST-INFO | 29888: exit 0 17:04:01 INFO - TEST-OK | dromaeo_css | took 1108737ms 17:04:01 INFO - TEST-START | kraken 17:04:01 INFO - operating with platform_type : linux_ 17:04:01 INFO - Initialising browser for kraken test... 17:04:01 INFO - TEST-INFO | started process 30131 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppwVF9d/profile http://localhost:48095/getInfo.html) 17:04:04 INFO - PROCESS | 30131 | 17:04:04 INFO - PROCESS | 30131 | (process:30214): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:04:05 INFO - PROCESS | 30131 | __metrics Screen width/height:1600/1200 17:04:05 INFO - PROCESS | 30131 | colorDepth:24 17:04:05 INFO - PROCESS | 30131 | Browser inner width/height: 1024/697 17:04:05 INFO - PROCESS | 30131 | __metrics 17:04:06 INFO - TEST-INFO | 30131: exit 0 17:04:06 INFO - Browser initialized. 17:04:06 INFO - Running cycle 1/1 for kraken test... 17:04:06 INFO - TEST-INFO | started process 30263 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppwVF9d/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:04:07 INFO - PROCESS | 30263 | 17:04:07 INFO - PROCESS | 30263 | (process:30327): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:04:18 INFO - PROCESS | 30263 | RSS: Main: 140890112 17:04:18 INFO - PROCESS | 30263 | 17:04:20 INFO - PROCESS | 30263 | Cycle 1(1): loaded http://localhost:48095/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48095/tests/kraken/driver.html?testName=audio-beat-detection) 17:04:21 INFO - PROCESS | 30263 | RSS: Main: 146399232 17:04:21 INFO - PROCESS | 30263 | 17:04:23 INFO - PROCESS | 30263 | Cycle 1(1): loaded http://localhost:48095/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48095/tests/kraken/driver.html?testName=audio-dft) 17:04:24 INFO - PROCESS | 30263 | RSS: Main: 145080320 17:04:24 INFO - PROCESS | 30263 | 17:04:27 INFO - PROCESS | 30263 | Cycle 1(1): loaded http://localhost:48095/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48095/tests/kraken/driver.html?testName=audio-fft) 17:04:27 INFO - PROCESS | 30263 | RSS: Main: 146288640 17:04:27 INFO - PROCESS | 30263 | 17:04:29 INFO - PROCESS | 30263 | Cycle 1(1): loaded http://localhost:48095/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48095/tests/kraken/driver.html?testName=audio-oscillator) 17:04:30 INFO - PROCESS | 30263 | RSS: Main: 146468864 17:04:30 INFO - PROCESS | 30263 | 17:04:32 INFO - PROCESS | 30263 | Cycle 1(1): loaded http://localhost:48095/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48095/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:04:33 INFO - PROCESS | 30263 | RSS: Main: 144797696 17:04:33 INFO - PROCESS | 30263 | 17:04:36 INFO - PROCESS | 30263 | Cycle 1(1): loaded http://localhost:48095/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48095/tests/kraken/driver.html?testName=imaging-darkroom) 17:04:36 INFO - PROCESS | 30263 | RSS: Main: 145989632 17:04:36 INFO - PROCESS | 30263 | 17:04:40 INFO - PROCESS | 30263 | Cycle 1(1): loaded http://localhost:48095/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48095/tests/kraken/driver.html?testName=imaging-desaturate) 17:04:40 INFO - PROCESS | 30263 | RSS: Main: 145657856 17:04:40 INFO - PROCESS | 30263 | 17:04:43 INFO - PROCESS | 30263 | Cycle 1(1): loaded http://localhost:48095/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48095/tests/kraken/driver.html?testName=json-parse-financial) 17:04:44 INFO - PROCESS | 30263 | RSS: Main: 145350656 17:04:44 INFO - PROCESS | 30263 | 17:04:45 INFO - PROCESS | 30263 | Cycle 1(1): loaded http://localhost:48095/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48095/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:04:46 INFO - PROCESS | 30263 | RSS: Main: 145375232 17:04:46 INFO - PROCESS | 30263 | 17:04:48 INFO - PROCESS | 30263 | Cycle 1(1): loaded http://localhost:48095/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48095/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:04:48 INFO - PROCESS | 30263 | RSS: Main: 144830464 17:04:48 INFO - PROCESS | 30263 | 17:04:50 INFO - PROCESS | 30263 | Cycle 1(1): loaded http://localhost:48095/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48095/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:04:51 INFO - PROCESS | 30263 | RSS: Main: 145399808 17:04:51 INFO - PROCESS | 30263 | 17:04:53 INFO - PROCESS | 30263 | Cycle 1(1): loaded http://localhost:48095/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48095/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:04:54 INFO - PROCESS | 30263 | RSS: Main: 146456576 17:04:54 INFO - PROCESS | 30263 | 17:04:56 INFO - PROCESS | 30263 | Cycle 1(1): loaded http://localhost:48095/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48095/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:04:57 INFO - PROCESS | 30263 | RSS: Main: 146108416 17:04:57 INFO - PROCESS | 30263 | 17:04:58 INFO - PROCESS | 30263 | Cycle 1(1): loaded http://localhost:48095/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48095/tests/kraken/driver.html?testName=ai-astar) 17:04:59 INFO - PROCESS | 30263 | RSS: Main: 147763200 17:04:59 INFO - PROCESS | 30263 | 17:04:59 INFO - PROCESS | 30263 | __start_tp_report 17:04:59 INFO - PROCESS | 30263 | _x_x_mozilla_page_load 17:04:59 INFO - PROCESS | 30263 | _x_x_mozilla_page_load_details 17:04:59 INFO - PROCESS | 30263 | |i|pagename|runs| 17:04:59 INFO - PROCESS | 30263 | |0;ai-astar;109;105;110;109;110;119;110;111;111;109 17:04:59 INFO - PROCESS | 30263 | |1;audio-beat-detection;153;127;152;165;128;145;152;128;166;125 17:04:59 INFO - PROCESS | 30263 | |2;audio-dft;162;165;162;164;164;163;162;162;167;164 17:04:59 INFO - PROCESS | 30263 | |3;audio-fft;75;74;75;149;74;73;72;73;167;77 17:04:59 INFO - PROCESS | 30263 | |4;audio-oscillator;95;95;145;95;95;96;138;95;96;137 17:04:59 INFO - PROCESS | 30263 | |5;imaging-gaussian-blur;110;109;109;109;110;109;110;109;110;111 17:04:59 INFO - PROCESS | 30263 | |6;imaging-darkroom;148;148;148;147;148;147;149;147;147;147 17:04:59 INFO - PROCESS | 30263 | |7;imaging-desaturate;96;97;97;97;96;97;100;97;96;97 17:04:59 INFO - PROCESS | 30263 | |8;json-parse-financial;58;57;57;57;58;58;57;66;55;56 17:04:59 INFO - PROCESS | 30263 | |9;json-stringify-tinderbox;64;65;64;64;64;64;63;65;64;64 17:04:59 INFO - PROCESS | 30263 | |10;stanford-crypto-aes;80;81;84;83;82;82;91;82;89;82 17:04:59 INFO - PROCESS | 30263 | |11;stanford-crypto-ccm;117;117;113;110;120;120;117;112;113;123 17:04:59 INFO - PROCESS | 30263 | |12;stanford-crypto-pbkdf2;140;136;130;127;136;146;137;140;127;136 17:04:59 INFO - PROCESS | 30263 | |13;stanford-crypto-sha256-iterative;64;65;65;65;67;67;67;64;63;65 17:04:59 INFO - PROCESS | 30263 | __end_tp_report 17:04:59 INFO - PROCESS | 30263 | __start_cc_report 17:04:59 INFO - PROCESS | 30263 | _x_x_mozilla_cycle_collect,728 17:04:59 INFO - PROCESS | 30263 | __end_cc_report 17:04:59 INFO - PROCESS | 30263 | __startTimestamp1455843899190__endTimestamp 17:04:59 INFO - PROCESS | 30263 | 17:04:59 INFO - PROCESS | 30263 | ------- Summary: start ------- 17:04:59 INFO - PROCESS | 30263 | Number of tests: 14 17:04:59 INFO - PROCESS | 30263 | 17:04:59 INFO - PROCESS | 30263 | [#0] ai-astar Cycles:10 Average:110.30 Median:110.00 stddev:3.50 (3.2%) stddev-sans-first:3.68 17:04:59 INFO - PROCESS | 30263 | Values: 109.0 105.0 110.0 109.0 110.0 119.0 110.0 111.0 111.0 109.0 17:04:59 INFO - PROCESS | 30263 | 17:04:59 INFO - PROCESS | 30263 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:152.00 stddev:15.98 (10.5%) stddev-sans-first:16.62 17:04:59 INFO - PROCESS | 30263 | Values: 153.0 127.0 152.0 165.0 128.0 145.0 152.0 128.0 166.0 125.0 17:04:59 INFO - PROCESS | 30263 | 17:04:59 INFO - PROCESS | 30263 | [#2] audio-dft Cycles:10 Average:163.50 Median:164.00 stddev:1.65 (1.0%) stddev-sans-first:1.66 17:04:59 INFO - PROCESS | 30263 | Values: 162.0 165.0 162.0 164.0 164.0 163.0 162.0 162.0 167.0 164.0 17:04:59 INFO - PROCESS | 30263 | 17:04:59 INFO - PROCESS | 30263 | [#3] audio-fft Cycles:10 Average:90.90 Median:74.00 stddev:35.64 (48.2%) stddev-sans-first:37.34 17:04:59 INFO - PROCESS | 30263 | Values: 75.0 74.0 75.0 149.0 74.0 73.0 72.0 73.0 167.0 77.0 17:04:59 INFO - PROCESS | 30263 | 17:04:59 INFO - PROCESS | 30263 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:95.00 stddev:21.70 (22.8%) stddev-sans-first:22.44 17:04:59 INFO - PROCESS | 30263 | Values: 95.0 95.0 145.0 95.0 95.0 96.0 138.0 95.0 96.0 137.0 17:04:59 INFO - PROCESS | 30263 | 17:04:59 INFO - PROCESS | 30263 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 17:04:59 INFO - PROCESS | 30263 | Values: 110.0 109.0 109.0 109.0 110.0 109.0 110.0 109.0 110.0 111.0 17:04:59 INFO - PROCESS | 30263 | 17:04:59 INFO - PROCESS | 30263 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 17:04:59 INFO - PROCESS | 30263 | Values: 148.0 148.0 148.0 147.0 148.0 147.0 149.0 147.0 147.0 147.0 17:04:59 INFO - PROCESS | 30263 | 17:04:59 INFO - PROCESS | 30263 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:97.00 stddev:1.15 (1.2%) stddev-sans-first:1.17 17:04:59 INFO - PROCESS | 30263 | Values: 96.0 97.0 97.0 97.0 96.0 97.0 100.0 97.0 96.0 97.0 17:04:59 INFO - PROCESS | 30263 | 17:04:59 INFO - PROCESS | 30263 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:57.50 stddev:3.00 (5.2%) stddev-sans-first:3.18 17:04:59 INFO - PROCESS | 30263 | Values: 58.0 57.0 57.0 57.0 58.0 58.0 57.0 66.0 55.0 56.0 17:04:59 INFO - PROCESS | 30263 | 17:04:59 INFO - PROCESS | 30263 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 17:04:59 INFO - PROCESS | 30263 | Values: 64.0 65.0 64.0 64.0 64.0 64.0 63.0 65.0 64.0 64.0 17:04:59 INFO - PROCESS | 30263 | 17:04:59 INFO - PROCESS | 30263 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:82.50 stddev:3.57 (4.3%) stddev-sans-first:3.54 17:04:59 INFO - PROCESS | 30263 | Values: 80.0 81.0 84.0 83.0 82.0 82.0 91.0 82.0 89.0 82.0 17:04:59 INFO - PROCESS | 30263 | 17:04:59 INFO - PROCESS | 30263 | [#11] stanford-crypto-ccm Cycles:10 Average:116.20 Median:117.00 stddev:4.13 (3.5%) stddev-sans-first:4.37 17:04:59 INFO - PROCESS | 30263 | Values: 117.0 117.0 113.0 110.0 120.0 120.0 117.0 112.0 113.0 123.0 17:04:59 INFO - PROCESS | 30263 | 17:04:59 INFO - PROCESS | 30263 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.50 Median:136.50 stddev:6.04 (4.4%) stddev-sans-first:6.18 17:04:59 INFO - PROCESS | 30263 | Values: 140.0 136.0 130.0 127.0 136.0 146.0 137.0 140.0 127.0 136.0 17:04:59 INFO - PROCESS | 30263 | 17:04:59 INFO - PROCESS | 30263 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:1.40 (2.2%) stddev-sans-first:1.41 17:04:59 INFO - PROCESS | 30263 | Values: 64.0 65.0 65.0 65.0 67.0 67.0 67.0 64.0 63.0 65.0 17:04:59 INFO - PROCESS | 30263 | -------- Summary: end -------- 17:04:59 INFO - PROCESS | 30263 | 17:05:00 INFO - TEST-INFO | 30263: exit 0 17:05:00 INFO - TEST-OK | kraken | took 58939ms 17:05:00 INFO - TEST-START | v8_7 17:05:00 INFO - operating with platform_type : linux_ 17:05:00 INFO - Initialising browser for v8_7 test... 17:05:00 INFO - TEST-INFO | started process 30555 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3B3KxY/profile http://localhost:48095/getInfo.html) 17:05:03 INFO - PROCESS | 30555 | 17:05:03 INFO - PROCESS | 30555 | (process:30636): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:05:04 INFO - PROCESS | 30555 | __metrics Screen width/height:1600/1200 17:05:04 INFO - PROCESS | 30555 | colorDepth:24 17:05:04 INFO - PROCESS | 30555 | Browser inner width/height: 1024/697 17:05:04 INFO - PROCESS | 30555 | __metrics 17:05:05 INFO - TEST-INFO | 30555: exit 0 17:05:05 INFO - Browser initialized. 17:05:05 INFO - Running cycle 1/1 for v8_7 test... 17:05:05 INFO - TEST-INFO | started process 30685 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3B3KxY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:05:06 INFO - PROCESS | 30685 | 17:05:06 INFO - PROCESS | 30685 | (process:30745): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:05:17 INFO - PROCESS | 30685 | RSS: Main: 141008896 17:05:17 INFO - PROCESS | 30685 | 17:05:39 INFO - PROCESS | 30685 | Cycle 1(1): loaded http://localhost:48095/tests/v8_7/run.html (next: http://localhost:48095/tests/v8_7/run.html) 17:05:39 INFO - PROCESS | 30685 | RSS: Main: 144568320 17:05:39 INFO - PROCESS | 30685 | 17:05:39 INFO - PROCESS | 30685 | __start_tp_report 17:05:39 INFO - PROCESS | 30685 | _x_x_mozilla_page_load 17:05:39 INFO - PROCESS | 30685 | _x_x_mozilla_page_load_details 17:05:39 INFO - PROCESS | 30685 | |i|pagename|runs| 17:05:39 INFO - PROCESS | 30685 | |0;Richards;167.02856188408217 17:05:39 INFO - PROCESS | 30685 | |1;DeltaBlue;170.53206002728513 17:05:39 INFO - PROCESS | 30685 | |2;Encrypt;278.6291446085261 17:05:39 INFO - PROCESS | 30685 | |3;Decrypt;5235.602094240838 17:05:39 INFO - PROCESS | 30685 | |4;RayTrace;942.5070688030161 17:05:39 INFO - PROCESS | 30685 | |5;Earley;550.05500550055 17:05:39 INFO - PROCESS | 30685 | |6;Boyer;11111.111111111111 17:05:39 INFO - PROCESS | 30685 | |7;RegExp;38942.307692307695 17:05:39 INFO - PROCESS | 30685 | |8;Splay;521.9206680584551 17:05:39 INFO - PROCESS | 30685 | |9;NavierStokes;4830.917874396136 17:05:39 INFO - PROCESS | 30685 | __end_tp_report 17:05:39 INFO - PROCESS | 30685 | __startTimestamp1455843939802__endTimestamp 17:05:39 INFO - PROCESS | 30685 | 17:05:39 INFO - PROCESS | 30685 | ------- Summary: start ------- 17:05:39 INFO - PROCESS | 30685 | Number of tests: 10 17:05:39 INFO - PROCESS | 30685 | 17:05:39 INFO - PROCESS | 30685 | [#0] Richards Cycles:1 Average:167.03 Median:167.03 stddev:0.00 (0.0%) 17:05:39 INFO - PROCESS | 30685 | Values: 167.0 17:05:39 INFO - PROCESS | 30685 | 17:05:39 INFO - PROCESS | 30685 | [#1] DeltaBlue Cycles:1 Average:170.53 Median:170.53 stddev:0.00 (0.0%) 17:05:39 INFO - PROCESS | 30685 | Values: 170.5 17:05:39 INFO - PROCESS | 30685 | 17:05:39 INFO - PROCESS | 30685 | [#2] Encrypt Cycles:1 Average:278.63 Median:278.63 stddev:0.00 (0.0%) 17:05:39 INFO - PROCESS | 30685 | Values: 278.6 17:05:39 INFO - PROCESS | 30685 | 17:05:39 INFO - PROCESS | 30685 | [#3] Decrypt Cycles:1 Average:5235.60 Median:5235.60 stddev:0.00 (0.0%) 17:05:39 INFO - PROCESS | 30685 | Values: 5235.6 17:05:39 INFO - PROCESS | 30685 | 17:05:39 INFO - PROCESS | 30685 | [#4] RayTrace Cycles:1 Average:942.51 Median:942.51 stddev:0.00 (0.0%) 17:05:39 INFO - PROCESS | 30685 | Values: 942.5 17:05:39 INFO - PROCESS | 30685 | 17:05:39 INFO - PROCESS | 30685 | [#5] Earley Cycles:1 Average:550.06 Median:550.06 stddev:0.00 (0.0%) 17:05:39 INFO - PROCESS | 30685 | Values: 550.1 17:05:39 INFO - PROCESS | 30685 | 17:05:39 INFO - PROCESS | 30685 | [#6] Boyer Cycles:1 Average:11111.11 Median:11111.11 stddev:0.00 (0.0%) 17:05:39 INFO - PROCESS | 30685 | Values: 11111.1 17:05:39 INFO - PROCESS | 30685 | 17:05:39 INFO - PROCESS | 30685 | [#7] RegExp Cycles:1 Average:38942.31 Median:38942.31 stddev:0.00 (0.0%) 17:05:39 INFO - PROCESS | 30685 | Values: 38942.3 17:05:39 INFO - PROCESS | 30685 | 17:05:39 INFO - PROCESS | 30685 | [#8] Splay Cycles:1 Average:521.92 Median:521.92 stddev:0.00 (0.0%) 17:05:39 INFO - PROCESS | 30685 | Values: 521.9 17:05:39 INFO - PROCESS | 30685 | 17:05:39 INFO - PROCESS | 30685 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 17:05:39 INFO - PROCESS | 30685 | Values: 4830.9 17:05:39 INFO - PROCESS | 30685 | -------- Summary: end -------- 17:05:39 INFO - PROCESS | 30685 | 17:05:40 INFO - TEST-INFO | 30685: exit 0 17:05:40 INFO - TEST-OK | v8_7 | took 40513ms 17:05:40 INFO - SUITE-END | took 1208s 17:05:40 INFO - Completed test suite (00:20:08) 17:05:40 INFO - Working with test: dromaeo_css 17:05:40 INFO - Generating results file: dromaeo_css 17:05:40 INFO - Working with test: kraken 17:05:40 INFO - Generating results file: kraken 17:05:40 INFO - javascript benchmark 17:05:40 INFO - Working with test: v8_7 17:05:40 INFO - Generating results file: v8_7 17:05:40 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:05:40 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 17:05:40 INFO - process_Request line: dromaeo_css 7379.47 graph.html#tests=[[72,52,43]] 17:05:40 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:05:40 INFO - process_Request line: kraken 1494.20 graph.html#tests=[[232,52,43]] 17:05:40 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:05:40 INFO - process_Request line: v8_7 22024.57 graph.html#tests=[[230,52,43]] 17:05:40 INFO - RETURN: dromaeo_css: 7379.47 17:05:40 INFO - RETURN: kraken: 1494.20 17:05:40 INFO - RETURN: v8_7: 22024.57 17:05:40 INFO - javascript benchmark 17:05:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3313.403587354276, 3352.8658853645857, 3374.9493757593655, 3386.119608901686, 3398.3033478136986, 5533.750981205851, 5554.222408862763, 5556.055470570002, 5559.332880054389, 5572.804951826687, 5477.917831232535, 5480.150576660624, 5544.584156188292, 5552.000639884819, 5569.498745112939, 4983.053219888227, 5081.085404627165, 5151.407588127376, 5153.742312884359, 5276.577873770108, 4828.637852161084, 5016.548510634042, 5048.570871475929, 5050.84847454577, 5155.175171972485, 5016.673916195436, 5066.1640829263315, 5066.620003499752, 5068.645194836363, 5103.362079740033, 5004.624653151028, 5011.348524691785, 5024.095662780698, 5032.899342013176, 5033.748312584356, 4847.709137451729, 4941.431735350445, 4956.504349565051, 4968.254761785725, 4969.8012079516775, 5309.840704778863, 5349.652272602308, 5357.919631205535, 5369.060414427459, 5375.919361209585, 5869.413058694139, 5899.498542623839, 5910.497607703307, 5929.169916211734, 5945.16767652529, 5846.7953621623465, 5868.559858010666, 5963.821085367446, 5975.0, 6062.090686397031, 5503.532199763025, 5511.338639363222, 5525.419830917776, 5531.446855314436, 5535.6955367454775, 5977.073553599199, 5981.0729336952845, 5984.670843103584, 5988.490978266809, 6004.459598636056, 5784.59507834456, 5790.247267855152, 5823.126531020381, 5823.5341172706085, 5828.0966450200285, 5926.496247818984, 5927.881442371215, 5938.346781853993, 5949.9107513387335, 5968.641881487125, 5857.502112320501, 5920.940790592125, 5921.555883308769, 5930.762769489258, 5936.465718085393, 5882.294124705063, 5961.523078153824, 5987.072003839412, 6007.489363404072, 6047.395260473917, 4447.933281000787, 4472.821087156477, 4494.280915053576, 4494.662900282427, 4504.0, 4006.4991876015497, 4024.1549274652066, 4059.7767122808527, 4063.512378514597, 4077.918441631151, 5418.810341638024, 5575.498205161555, 5578.191162281447, 5598.244237027949, 5637.46444087811, 5840.970795145997, 5854.502367298742, 5855.853603659943, 5859.560532960045, 5860.3260625027815, 5408.486193811582, 5448.891022179613, 5497.312835895513, 5522.5581953443625, 5532.474414930575, 5091.719955402415, 5106.846794596168, 5116.30929824469, 5129.563987061141, 5130.666506677054, 6114.847128821815, 6129.295131059896, 6132.601380910227, 6145.661988590581, 6146.877062458815, 5781.768729250783, 5887.882242355215, 5912.024515954819, 5923.11153327013, 5999.280086389486, 5997.07045407945, 6023.247094113236, 6082.209312789486, 6093.786717464867, 6108.4807791338235, 5758.827235182951, 5808.07070868659, 5833.562482813721, 5838.211841401527, 5844.181814545882, 5766.423357664368, 5837.29952405714, 5887.911681324698, 5921.822345329647, 6012.849678758066, 5749.13762935563, 5757.539396848326, 5773.24947756789, 5787.913181302368, 5803.216565763568, 5686.9715651421475, 5736.827895163152, 5791.884162316815, 5797.623154494944, 5803.535717142703, 5538.584606154474, 5553.583481239004, 5628.296462942132, 5664.745086471201, 5665.291838520185, 5790.623609465371, 5795.623284486495, 5797.043487824631, 5803.709814509342, 5831.1253312001845, 5527.53015993645, 5690.402507736793, 5696.11710184922, 5701.771929122789, 5709.628874123168], "unit": "score", "name": "dojo.html", "value": 5444.3642759263785}, {"lowerIsBetter": false, "replicates": [521.4811262793521, 555.7999120316687, 566.710977401525, 579.7940284208846, 587.2248631806015, 31616.99999999997, 38888.22223555527, 38898.416523752094, 39111.804440977794, 39135.21729565407, 45170.548294517044, 45828.0, 45879.77060114695, 46351.76824115883, 46449.7677511612, 9035.096490350978, 9250.074992500764, 9259.814803703923, 9287.164155226028, 9287.767805804875, 8964.417312874675, 9083.0, 9093.318001149908, 9129.22401595865, 9138.954305228497, 9102.954485227565, 9177.632894684204, 9214.815703685923, 9215.677451289206, 9232.538373081352, 9096.090390960884, 9164.221041211506, 9180.311476639245, 9183.908160918372, 9184.494852783095, 8933.240674542607, 9020.413673111227, 9068.093190680946, 9072.8639070414, 9100.453972761656, 42166.578334216574, 43170.0, 43217.13565728668, 43296.134077318595, 43314.35028474576, 3912.589178136283, 3959.4852669153115, 4267.210566045261, 4378.846740364103, 4379.364992076163, 32685.18287042819, 32798.18004549881, 32971.67028329734, 33079.83460082684, 33935.32129357399, 4143.56492568279, 4158.750474971512, 4199.307114326132, 4218.514870789868, 4256.063665993476, 290221.0, 293124.0, 293475.0, 294776.0, 312470.4376478126, 49467.50532494701, 67316.0, 67986.32013679898, 68144.0, 68162.65918670375, 60134.0, 60437.395626044054, 60613.696931515944, 60642.393576064555, 60745.69627151836, 17706.734398984026, 18079.276828926697, 18090.819091808913, 18109.36617218391, 18154.636907262044, 13616.114952528054, 13945.65135871591, 13982.44070237179, 14014.85985140156, 14028.50900218508, 21339.67990480144, 21629.78370216309, 21718.0, 21805.454863628536, 21838.0, 7621.504602200839, 7804.336631386395, 7884.802879927933, 7891.487053341514, 7925.484843485155, 943.4806382661376, 1083.701981954953, 1091.3560999010622, 1127.5940661362067, 1280.8283153480734, 30460.69539304623, 30461.543076853864, 30558.54162187569, 31470.37059258802, 31598.0, 1154.2974113183157, 1189.250772013626, 1208.015467394071, 1242.2049888071642, 1269.2955409747678, 16735.330586776636, 16812.83187168137, 16825.747613785803, 16978.0, 17081.231344589523, 270528.0, 362048.0, 369679.0, 374622.0, 375076.0, 49361.0, 49813.0, 49898.750506247234, 50031.499685003415, 50200.246996295085, 1450.3400952566558, 1485.7771334299941, 1497.4160077569538, 1503.4362114207172, 1512.7125846089427, 27496.17511474659, 28040.43919121647, 28587.0, 30003.24991875133, 30966.380672385974, 46896.29655555238, 47541.76229118832, 47588.762056189495, 47592.04815903732, 47722.5227747732, 220969.0, 221791.0, 223043.0, 223445.0, 223707.0, 34562.30875382529, 35055.649443506256, 35278.29443411066, 35514.11214719549, 35601.46597800983, 46509.53490465052, 47171.528284718086, 47339.28991065068, 47441.76279118582, 47897.76051119722, 37295.25409491849, 39722.40416393698, 40236.19527609373, 41188.1762364757, 41617.79191104025, 36837.0, 38137.427938581495, 38804.41793373158, 39468.0, 39863.60136398599, 36641.26717465689, 36766.816165919, 36912.0, 37249.81375093107, 39226.80386598049, 32912.835435823625, 33328.66671333255, 33373.33253334968, 33424.66575334313, 33755.493667595496, 26597.734022659526, 27266.318342041606, 27456.725432745417, 28221.294467638472, 28834.855825720737], "unit": "score", "name": "ext.html", "value": 19668.497511058456}, {"lowerIsBetter": false, "replicates": [399.8400639744102, 405.46073721949807, 405.8173821780199, 409.8504046023202, 410.2308172177168, 17036.23336949837, 17252.482425527254, 17641.117944102793, 18277.451676449728, 18993.0, 11949.044076473883, 13404.597862064129, 15548.06711597305, 15725.292361843716, 15756.448524301652, 4598.816047358102, 4787.234042553175, 4790.7604619769045, 4793.065352256312, 4797.616190704753, 4741.506425475964, 4830.758462076899, 4898.7060776353355, 5156.53591176794, 5162.664426812245, 5107.080725469414, 5129.820456284031, 5745.770169193227, 5936.347001829795, 5959.851003724898, 5610.961972035146, 5629.0, 5641.153826925953, 5859.589828711992, 5909.527237820964, 5430.239766432703, 5440.6735595863975, 5441.646292990982, 5446.2375267462585, 5468.043092458804, 13446.865531344756, 13493.0, 18905.527361816065, 20066.899665501725, 21498.355049348545, 2143.2070134050346, 2217.623004089309, 2280.441291883483, 2311.722593288799, 2393.246127469841, 10123.341982771097, 10192.133668638175, 10241.385516869012, 10420.114290285335, 10486.0, 1832.2670931627322, 1854.6568884756364, 1903.6002439487725, 1922.884626922389, 1966.7148263501713, 59318.40681593172, 59782.40217597812, 61564.69217653883, 61614.0, 62460.687696561225, 10500.05499505033, 10522.947385263025, 10523.158147348193, 10584.0, 10684.145268378512, 13715.862841371458, 13881.0, 13882.791758123636, 13995.440182392795, 14009.369578368794, 7908.644111015018, 8000.519968801774, 8202.835943281101, 8219.219174178443, 8241.629126689193, 8133.715319963773, 8154.714584989615, 8218.054923683852, 8242.093369729326, 8246.05170405399, 4710.29345598163, 4723.267893476516, 4763.285507173951, 4798.4001999750035, 4829.975850120727, 1896.8672192946638, 1984.811442912921, 2039.7246371739923, 2061.288855344904, 2094.1518684932626, 947.7109481608038, 957.1529196661005, 1006.954687039085, 1041.739565108723, 1058.941758203306, 17307.39424120175, 17307.826921730873, 17500.387486437914, 17577.824221757874, 18217.271309147487, 978.4814048554277, 1005.5123265216364, 1022.8158931392272, 1043.7495001199657, 1095.3756358875523, 10198.592056317813, 10216.642417515352, 10266.486675666336, 10303.896961030294, 10304.484775761182, 627982.0, 629819.0, 630272.0, 658039.0, 663415.0, 73288.0, 75588.0, 75875.0, 76804.5051174204, 79475.20524794678, 1146.6674664347413, 1164.6214980131492, 1167.0371943146938, 1179.1215544419463, 1183.7928362536522, 15589.220538972779, 15750.684986300439, 15779.447719329768, 15840.128792916501, 16064.518064458085, 34268.82865585656, 35499.46750798688, 36721.0, 39120.0, 39969.0, 44674.3298850511, 45923.77038114922, 46018.76990615026, 46434.07131857411, 50092.74953625354, 10043.849342260019, 10212.744681383025, 10444.791104178026, 10454.477276136011, 10754.838677419688, 8353.122922093093, 11893.524259029542, 12123.515059397878, 12249.510019599116, 12384.62846114618, 7945.8410831781885, 8012.479188852706, 8023.358131349595, 8023.6389362479995, 8221.958890205511, 7834.0, 7980.960095199487, 8051.2351326623875, 8174.632141553763, 8275.83448331042, 7904.0, 8092.4335296531035, 8249.0, 8253.33973282148, 8341.16588341161, 10600.840987385349, 10715.624953126604, 10834.67495975122, 10838.187135964676, 10945.288556243819, 10947.0, 10990.571225740603, 11020.173486988348, 11121.944390277997, 11162.218644694793], "unit": "score", "name": "jquery.html", "value": 8587.544032742824}, {"lowerIsBetter": false, "replicates": [1582.3828706804345, 1612.459825958304, 1880.962380752385, 1937.4478273692, 1975.4863735428785, 8479.448835825668, 8512.70205542806, 8536.701215457444, 8555.272801811845, 8834.293256539462, 8343.249107580317, 8403.201695838901, 8407.831843363128, 8470.322374210064, 8472.491650500975, 2443.9144629937955, 2472.9010839566395, 2474.1093206445667, 2485.6768620079365, 2486.7513248675077, 2463.519613675334, 2491.5141547398266, 2494.48862983088, 2501.8123640726926, 2505.7744802967727, 2441.7802397784194, 2481.9875900620473, 2492.700875894895, 2503.8748062596887, 2510.836795608289, 2500.8124390670773, 2516.509280690266, 2529.6079107738237, 2530.4306531030556, 2532.278300684296, 2465.1372019793107, 2480.7891329237036, 2495.6506089147533, 2501.5872381057284, 2508.586083296254, 8788.824223515494, 8794.296456283482, 8815.735527934172, 8828.514431706253, 8901.465912045298, 5314.388845282803, 5475.863103422406, 5481.534069604048, 5497.202905578709, 5520.585956053312, 3284.868605255787, 3287.4411350070545, 3317.5355450236984, 3370.3427831572853, 3392.4402473591826, 1140.4981808004452, 1149.9367534785667, 1157.1090260499452, 1172.3083380805365, 1175.0423404925045, 12557.246565206116, 12604.054695897752, 12709.809352859622, 12717.809232861422, 12738.80891786624, 4815.855524334275, 4862.80548778052, 4868.2210846264425, 4921.384826896638, 4943.085529177114, 10136.898631013742, 10141.340812847142, 10167.644132455329, 10200.234982376203, 10214.591416343412, 5502.5597952163735, 5508.118701007899, 5529.585281103933, 5535.750891209906, 5537.335519737658, 4951.801927922915, 4995.350604421475, 5010.298558201782, 5043.4956504349275, 5050.292958985745, 3858.2090671412293, 3860.4209368594375, 3876.1666241758157, 3882.2235552889533, 3904.355781296111, 1134.5064896769932, 1150.79285728568, 1163.668354518958, 1164.0512981919708, 1185.851768528934, 1078.6763970808884, 1089.983650245247, 1097.8353247013013, 1139.5897476908306, 1183.0535571542732, 7709.575973321521, 7732.729354472566, 7740.109887363025, 7757.26306000929, 7772.611369431505, 1153.6366044695894, 1182.456070207697, 1190.0301254477572, 1191.6544202181444, 1196.0551164580058, 6252.093446450239, 6387.329330420239, 6406.5515413920575, 6459.806205813833, 6469.061986012002, 10709.839352409721, 10988.890111098786, 11014.944925275322, 11117.888821111685, 11132.443377831076, 10510.579576816994, 10858.294210876267, 10912.181586381053, 10933.289336193122, 10990.505427255792, 8264.132266112092, 8427.536485493234, 8434.451760635538, 8439.156084391512, 8511.702090426805, 7909.129995700353, 7932.563708996061, 7935.722249721232, 8042.276195142465, 8070.0, 9337.439753614804, 9479.146876781122, 9616.423014618866, 9622.037796220322, 9718.902810972082, 9684.95157524208, 9871.210303175585, 10001.749956251151, 10050.798984020425, 10194.0, 7309.305615966475, 7426.331630153096, 7500.399968002655, 7517.248275172439, 7536.585487798005, 8328.708495202638, 8336.791580210544, 8417.579121044046, 8421.70524031656, 8426.873596896174, 7058.188308344606, 7858.921410785819, 7939.84120317602, 8004.279614834692, 8189.672413103409, 6951.895721564079, 7718.073831140075, 7858.803529911798, 7902.288794008567, 7914.16901225363, 7779.57212353326, 7800.414968877243, 7801.102873169658, 7818.140004599376, 7841.215878412113, 7144.035555199982, 7147.785566433015, 7176.96411517939, 7196.316349946746, 7207.5675459472595, 6886.139232595926, 6919.688614012281, 6996.230414654282, 7177.605231712306, 7192.8921066183], "unit": "score", "name": "mootools.html", "value": 4988.7002648424805}, {"lowerIsBetter": false, "replicates": [375.7351067497414, 387.2815926456423, 388.35339160298116, 390.0813584009659, 394.27453485586517, 6324.778632747843, 6358.650274234921, 6423.3897779710915, 6452.64510451925, 6463.03054541819, 6129.509639228862, 6301.149344838445, 6320.11518387425, 6368.04479328101, 6372.394622510866, 4935.580475659555, 4943.085529177114, 4950.702957822524, 4954.826581069663, 4963.1810751226185, 4963.1810751226, 4966.9751651241695, 4972.502749725017, 4975.4029516457895, 4980.452150263468, 4615.799892028063, 4812.87967800806, 4837.371141751585, 4839.104765618372, 4844.927326090112, 4818.662693611449, 4840.903181936377, 4841.2496063110275, 4841.273808928671, 4853.296272040552, 4236.809343579546, 4244.384564238199, 4250.213710463574, 4257.787110644455, 4264.552222016675, 5901.822945311605, 5953.226080609493, 6023.548233882432, 6026.608270462406, 6038.365971573009, 5663.5186009189265, 5671.319441667027, 5678.858028549278, 5683.630564013326, 5697.487226149667, 6654.401103900624, 6675.299093595151, 6695.7656482023385, 6738.191417029988, 6761.188657361099, 4686.062787442525, 4699.778057705022, 4701.271302948048, 4702.788374523155, 4705.200115980291, 6933.826654333631, 6947.756828510978, 7110.893336599956, 7111.537750046179, 7113.928860711379, 4849.078675051729, 4890.95109048912, 4895.583875370562, 4897.608191344684, 4917.0903382874285, 4949.777260023236, 4959.429665588431, 4963.255511673278, 4970.17992031318, 4972.925406118911, 5586.91619625706, 5691.459311365496, 5703.344115426779, 5719.914201286984, 5722.914156287659, 6774.119364482585, 6786.083878676414, 6788.083608712859, 6800.285969973181, 6822.795316140524, 1757.5606098475382, 1805.8194180581836, 1808.3851490493296, 1809.4119411191416, 1810.719338502508, 1242.0870660064845, 1250.1124201816813, 1259.5213818748816, 1275.0, 1275.2348590845604, 6376.202974628171, 6451.548391612542, 6483.3516648335735, 6495.772647957393, 6504.577202481918, 6923.6192009439965, 6926.064981227571, 6994.370506654323, 7011.824704382431, 7020.0, 6251.0, 6325.399087086719, 6344.302126766052, 6366.84082897922, 6424.972004479261, 3739.962600374016, 3750.9249815003545, 3774.301754175486, 3780.678642315379, 3786.1481166737262, 7160.606166660779, 7174.246704096099, 7182.569045857265, 7227.855442891113, 7243.818904527429, 6967.721291148398, 7062.92937070633, 7106.431485481149, 7123.964380178066, 7127.322904324081, 7175.533590316717, 7176.354128128389, 7199.964000180071, 7202.675879585431, 7208.423326133897, 6902.620355880475, 6912.827179320558, 6926.44588432914, 6930.168379794457, 6950.721971121301, 6691.498137639794, 6839.110915581142, 6855.794326170223, 6918.654067296716, 6928.757493487704, 7194.964025179841, 7213.314735100157, 7226.277372262942, 7231.963840180765, 7235.2041275458605, 4943.0, 4944.258361245698, 4946.579540739078, 4947.381577302837, 4949.084419382426, 6821.1814582250445, 6902.930970690229, 6944.93055069463, 7089.326513981164, 7105.644717764195, 6800.557963732342, 6837.076994605664, 6849.657517124024, 6864.862702746017, 6866.798310295579, 6820.761273355409, 6821.283765204582, 6824.488163387865, 6832.0, 6847.965760171167, 6606.9008964866525, 6740.224874139537, 6740.528163028541, 6762.391384775394, 6772.55978361405, 6841.589504629738, 6860.108185935796, 6879.449644028366, 6890.724371025303, 6906.343897329745, 6532.477401807749, 6690.899636505359, 6708.295628958889, 6709.429698475684, 6728.629925354153], "unit": "score", "name": "prototype.html", "value": 5145.590174770042}, {"lowerIsBetter": false, "replicates": [907.4192516789252, 913.036746232725, 921.0881227584691, 929.8655640119055, 931.3108299858103, 14201.0, 14526.201058941753, 14537.418503259883, 14603.634909127277, 14607.415703371866, 13960.092593981384, 13971.16173029619, 13984.230867302294, 14015.509457169, 14102.224377659224, 883.6995421556669, 888.1074520107284, 892.4377642085509, 911.8495448251031, 919.1773362840254, 895.8387490251752, 899.5187574647565, 903.1961554216753, 906.0893801729253, 907.224323203658, 944.2068662323646, 959.3140904253457, 959.4579062829479, 961.4087336288168, 962.2061799015805, 940.3981451870808, 941.1341565759484, 948.5589201021559, 949.4635530925005, 954.065016284042, 696.5124412910983, 702.1854648607641, 703.4723957032226, 707.4764674141098, 709.9361057504849, 14568.271586420637, 14761.55715328542, 14819.629509262248, 14830.258487075604, 14866.554003379915, 13936.58190254294, 13998.0, 14046.1572305662, 14103.224322662249, 14154.50459233932, 11296.265742726697, 11382.260153090023, 11473.885261147365, 11621.0, 11825.467853946593, 3763.9435408468894, 3771.15149091455, 3778.0, 3811.0, 3899.025243689078, 48443.27335089976, 48685.75657121727, 49214.0, 49749.50250497521, 49810.50189498131, 10655.84016239757, 10940.507677154388, 11103.555857765761, 11193.944030279796, 11251.887481125248, 18785.0, 19135.617287654168, 19165.61668766617, 19457.31899383543, 19530.0, 7933.206679332136, 7943.841123177504, 7973.641186146638, 7997.480163789335, 8233.547154906419, 4298.505671847715, 4365.257906155961, 4422.7346359218545, 4443.733375997451, 4493.977530112328, 3169.889053883103, 3187.4581321175456, 3201.2637093468634, 3219.3400352927592, 3222.8227447490613, 572.321798668579, 581.7556626216999, 582.6533212738499, 588.0884628825304, 588.8351261646745, 557.2115456628825, 568.3889818445188, 616.9444749972524, 658.4370363339372, 685.6023506366296, 9074.727758167266, 9615.615375385047, 9655.613775448903, 9679.758006049906, 9759.658411955548, 584.4009889862924, 681.5399605266425, 723.1755798389839, 743.4647054121024, 746.5446077892482, 4291.592298731615, 4345.891352716144, 4387.210302145644, 4455.643548516111, 4487.730736155841, 62039.6898015507, 63888.0, 64132.0, 64315.67842160759, 64359.678201608695, 55914.72042639761, 56535.71732141313, 56653.0, 56785.0, 57244.427555724746, 49444.763880902545, 49462.75268623634, 49519.75240123848, 49880.0, 50206.99586008333, 8529.872051919103, 8532.872006919777, 8656.523891186045, 8950.060243674581, 8959.731208063507, 37427.251454971294, 37455.25089498249, 37512.43731344087, 37729.43405848969, 39800.20399591934, 48795.26807097825, 48832.779180520774, 48994.75502622607, 49154.26268606045, 49921.500784993135, 11715.648530544097, 11897.286162830258, 12081.0, 12336.444859981142, 12706.745865082832, 12177.817332739838, 12883.935580322039, 13121.540746073842, 13578.25319607431, 13978.720425591635, 12049.246301062289, 12356.0, 13311.33443327849, 13354.799678004643, 13515.391807368494, 12674.206676153948, 12919.418626161658, 13029.934850325688, 13300.800487992881, 13463.932680336535, 12171.33057681836, 12654.367281635698, 12859.807102893277, 12979.740405191655, 13341.19952802796, 9761.267904907018, 9930.751731206778, 10122.848157277795, 10185.592576296865, 10489.895101048893, 10034.347767395097, 10345.0, 10400.479976001321, 10465.476726163814, 10489.108425783588], "unit": "score", "name": "yui.html", "value": 6840.822760485169}], "name": "dromaeo_css", "value": 7379.474243451213}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 105.0, 110.0, 109.0, 110.0, 119.0, 110.0, 111.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [153.0, 127.0, 152.0, 165.0, 128.0, 145.0, 152.0, 128.0, 166.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 144.1}, {"lowerIsBetter": true, "replicates": [162.0, 165.0, 162.0, 164.0, 164.0, 163.0, 162.0, 162.0, 167.0, 164.0], "unit": "score", "name": "audio-dft", "value": 163.5}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 75.0, 149.0, 74.0, 73.0, 72.0, 73.0, 167.0, 77.0], "unit": "score", "name": "audio-fft", "value": 90.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 145.0, 95.0, 95.0, 96.0, 138.0, 95.0, 96.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 147.0, 148.0, 147.0, 149.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 97.0, 96.0, 97.0, 100.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.0}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 57.0, 57.0, 58.0, 58.0, 57.0, 66.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.9}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 63.0, 65.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 84.0, 83.0, 82.0, 82.0, 91.0, 82.0, 89.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 113.0, 110.0, 120.0, 120.0, 117.0, 112.0, 113.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.2}, {"lowerIsBetter": true, "replicates": [140.0, 136.0, 130.0, 127.0, 136.0, 146.0, 137.0, 140.0, 127.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.5}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 65.0, 65.0, 67.0, 67.0, 67.0, 64.0, 63.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.2}], "name": "kraken", "value": 1494.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.02856188408217], "unit": "score", "name": "Richards", "value": 211.35307400000002}, {"lowerIsBetter": false, "replicates": [170.53206002728513], "unit": "score", "name": "DeltaBlue", "value": 387.71595200000013}, {"lowerIsBetter": false, "replicates": [278.6291446085261], "unit": "score", "name": "Encrypt", "value": 955.3236090000001}, {"lowerIsBetter": false, "replicates": [5235.602094240838], "unit": "score", "name": "Decrypt", "value": 50.84057100000005}, {"lowerIsBetter": false, "replicates": [942.5070688030161], "unit": "score", "name": "RayTrace", "value": 785.1283289999999}, {"lowerIsBetter": false, "replicates": [550.05500550055], "unit": "score", "name": "Earley", "value": 1211.629734}, {"lowerIsBetter": false, "replicates": [11111.111111111111], "unit": "score", "name": "Boyer", "value": 59.98166999999996}, {"lowerIsBetter": false, "replicates": [38942.307692307695], "unit": "score", "name": "RegExp", "value": 23.39319506172841}, {"lowerIsBetter": false, "replicates": [521.9206680584551], "unit": "score", "name": "Splay", "value": 156.13675599999996}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 22024.571790600967}]} 17:05:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "22024.57"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1494.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7379.47"}}} 17:05:41 INFO - Return code: 0 17:05:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:05:41 INFO - # TBPL SUCCESS # 17:05:41 INFO - Running post-action listener: _resource_record_post_action 17:05:41 INFO - Running post-run listener: _resource_record_post_run 17:05:42 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 500813824; Read time: 16; Write time: 327004 17:05:42 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 242135040; Read time: 0; Write time: 210724 17:05:42 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 4096; Write bytes: 258678784; Read time: 16; Write time: 116280 17:05:42 INFO - Running post-run listener: _upload_blobber_files 17:05:42 INFO - Blob upload gear active. 17:05:42 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:05:42 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:05:42 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'] 17:05:42 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 17:05:42 INFO - (blobuploader) - INFO - Open directory for files ... 17:05:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:05:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:05:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:05:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:05:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:05:43 INFO - (blobuploader) - INFO - Done attempting. 17:05:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:05:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:05:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:05:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:05:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:05:44 INFO - (blobuploader) - INFO - Done attempting. 17:05:44 INFO - (blobuploader) - INFO - Iteration through files over. 17:05:44 INFO - Return code: 0 17:05:44 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:05:44 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:05:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f511372279bb94c7346123093d059e14a600229eff478dfd1c169c6b9cc3a4b2f952e88c90d563d3c5e07016d6c3c6ac0f1169696263385cccc5b9980b5e9ee0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f18c4511c87b939075e99d302fd41881f445d6f178dac6d61e2334079a1ffcaff05f7fa673f88836443488087e5e86ff4d654e1a22e04a2f9beffa505bd2050"} 17:05:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:05:44 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:05:44 INFO - Contents: 17:05:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f511372279bb94c7346123093d059e14a600229eff478dfd1c169c6b9cc3a4b2f952e88c90d563d3c5e07016d6c3c6ac0f1169696263385cccc5b9980b5e9ee0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f18c4511c87b939075e99d302fd41881f445d6f178dac6d61e2334079a1ffcaff05f7fa673f88836443488087e5e86ff4d654e1a22e04a2f9beffa505bd2050"} 17:05:44 INFO - Running post-run listener: copy_logs_to_upload_dir 17:05:44 INFO - Copying logs to upload dir... 17:05:44 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:05:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.756954 ========= master_lag: 64.80 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 14 secs) (at 2016-02-18 17:06:48.977842) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-18 17:06:48.981138) ========= 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=20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f511372279bb94c7346123093d059e14a600229eff478dfd1c169c6b9cc3a4b2f952e88c90d563d3c5e07016d6c3c6ac0f1169696263385cccc5b9980b5e9ee0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f18c4511c87b939075e99d302fd41881f445d6f178dac6d61e2334079a1ffcaff05f7fa673f88836443488087e5e86ff4d654e1a22e04a2f9beffa505bd2050"} build_url:https://queue.taskcluster.net/v1/task/Pf7KXa7FS6urjgMqW26CQg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011522 build_url: 'https://queue.taskcluster.net/v1/task/Pf7KXa7FS6urjgMqW26CQg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f511372279bb94c7346123093d059e14a600229eff478dfd1c169c6b9cc3a4b2f952e88c90d563d3c5e07016d6c3c6ac0f1169696263385cccc5b9980b5e9ee0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f18c4511c87b939075e99d302fd41881f445d6f178dac6d61e2334079a1ffcaff05f7fa673f88836443488087e5e86ff4d654e1a22e04a2f9beffa505bd2050"}' ========= master_lag: 0.31 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-18 17:06:49.305135) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 17:06:49.305491) ========= 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=20e666a3d4cfbb71505a330e000001b4-1455842521.471370-172452976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004536 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 17:06:49.321546) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-18 17:06:49.322059) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-18 17:06:49.323398) ========= ========= Total master_lag: 65.29 =========