builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-002 starttime: 1452051833.02 results: success (0) buildid: 20160105173105 builduid: 587936b5fa5544a6bdebd8e9437b765d revision: 5cb754f869c7d481e73344642e4f941f08357b8b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 19:43:53.022325) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 19:43:53.022837) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 19:43:53.023204) ========= 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=a0d2d2de893abaa8702a9954000001a7-1452051832.534616-1894599926 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006191 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 19:43:53.046486) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 19:43:53.046836) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 19:43:53.060223) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 19:43:53.060558) ========= 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=a0d2d2de893abaa8702a9954000001a7-1452051832.534616-1894599926 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004636 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 19:43:53.110447) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 19:43:53.110793) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 19:43:53.111252) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 19:43:53.111633) ========= 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=a0d2d2de893abaa8702a9954000001a7-1452051832.534616-1894599926 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-05 19:43:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-01-05 19:43:53 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161669 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 19:43:53.287349) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 19:43:53.287749) ========= 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=a0d2d2de893abaa8702a9954000001a7-1452051832.534616-1894599926 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022848 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 19:43:53.338581) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-05 19:43:53.338979) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5cb754f869c7d481e73344642e4f941f08357b8b --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 5cb754f869c7d481e73344642e4f941f08357b8b --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=a0d2d2de893abaa8702a9954000001a7-1452051832.534616-1894599926 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-05 19:43:53,723 truncating revision to first 12 chars 2016-01-05 19:43:53,723 Setting DEBUG logging. 2016-01-05 19:43:53,723 attempt 1/10 2016-01-05 19:43:53,723 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5cb754f869c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-05 19:43:55,022 unpacking tar archive at: mozilla-aurora-5cb754f869c7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.597421 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-05 19:43:54.950286) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 19:43:54.950652) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 19:43:54.959244) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 19:43:54.959576) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 19:43:54.960069) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-01-05 19:43:54.960426) ========= /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=a0d2d2de893abaa8702a9954000001a7-1452051832.534616-1894599926 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:43:55 INFO - MultiFileLogger online at 20160105 19:43:55 in /builds/slave/test-pgo 19:43:55 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 19:43:55 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:43:55 INFO - {'append_to_log': False, 19:43:55 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:43:55 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:43:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:43:55 INFO - 'branch': 'Mozilla-Aurora', 19:43:55 INFO - 'buildbot_json_path': 'buildprops.json', 19:43:55 INFO - 'config_files': ('talos/linux_config.py',), 19:43:55 INFO - 'default_actions': ('clobber', 19:43:55 INFO - 'read-buildbot-config', 19:43:55 INFO - 'download-and-extract', 19:43:55 INFO - 'populate-webroot', 19:43:55 INFO - 'create-virtualenv', 19:43:55 INFO - 'install', 19:43:55 INFO - 'run-tests'), 19:43:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:43:55 INFO - 'download_minidump_stackwalk': True, 19:43:55 INFO - 'download_symbols': 'ondemand', 19:43:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:43:55 INFO - 'tooltool.py': '/tools/tooltool.py', 19:43:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:43:55 INFO - '/tools/misc-python/virtualenv.py')}, 19:43:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:43:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:43:55 INFO - 'installer_path': 'installer.exe', 19:43:55 INFO - 'log_level': 'info', 19:43:55 INFO - 'log_name': 'talos', 19:43:55 INFO - 'log_to_console': True, 19:43:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:43:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:43:55 INFO - 'opt_config_files': (), 19:43:55 INFO - 'pip_index': False, 19:43:55 INFO - 'sps_profile': False, 19:43:55 INFO - 'sps_profile_interval': 0, 19:43:55 INFO - 'suite': 'dromaeojs-e10s', 19:43:55 INFO - 'system_bits': '32', 19:43:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:43:55 INFO - 'title': 'talos-linux64-ix-002', 19:43:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:43:55 INFO - 'use_talos_json': True, 19:43:55 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:43:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:43:55 INFO - 'work_dir': 'build'} 19:43:55 INFO - ##### 19:43:55 INFO - ##### Running clobber step. 19:43:55 INFO - ##### 19:43:55 INFO - Running pre-action listener: _resource_record_pre_action 19:43:55 INFO - Running main action method: clobber 19:43:55 INFO - rmtree: /builds/slave/test-pgo/build 19:43:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:43:55 INFO - Running post-action listener: _resource_record_post_action 19:43:55 INFO - ##### 19:43:55 INFO - ##### Running read-buildbot-config step. 19:43:55 INFO - ##### 19:43:55 INFO - Running pre-action listener: _resource_record_pre_action 19:43:55 INFO - Running main action method: read_buildbot_config 19:43:55 INFO - Using buildbot properties: 19:43:55 INFO - { 19:43:55 INFO - "properties": { 19:43:55 INFO - "buildnumber": 69, 19:43:55 INFO - "product": "firefox", 19:43:55 INFO - "script_repo_revision": "production", 19:43:55 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 19:43:55 INFO - "repository": "", 19:43:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 19:43:55 INFO - "buildid": "20160105173105", 19:43:55 INFO - "slavename": "talos-linux64-ix-002", 19:43:55 INFO - "pgo_build": "True", 19:43:55 INFO - "basedir": "/builds/slave/test-pgo", 19:43:55 INFO - "project": "", 19:43:55 INFO - "platform": "ubuntu64_hw", 19:43:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:43:55 INFO - "slavebuilddir": "test", 19:43:55 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 19:43:55 INFO - "branch": "mozilla-aurora", 19:43:55 INFO - "repo_path": "releases/mozilla-aurora", 19:43:55 INFO - "stage_platform": "linux64-pgo", 19:43:55 INFO - "builduid": "587936b5fa5544a6bdebd8e9437b765d", 19:43:55 INFO - "revision": "5cb754f869c7d481e73344642e4f941f08357b8b" 19:43:55 INFO - }, 19:43:55 INFO - "sourcestamp": { 19:43:55 INFO - "repository": "", 19:43:55 INFO - "hasPatch": false, 19:43:55 INFO - "project": "", 19:43:55 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 19:43:55 INFO - "changes": [ 19:43:55 INFO - { 19:43:55 INFO - "category": null, 19:43:55 INFO - "files": [ 19:43:55 INFO - { 19:43:55 INFO - "url": null, 19:43:55 INFO - "name": "https://queue.taskcluster.net/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 19:43:55 INFO - } 19:43:55 INFO - ], 19:43:55 INFO - "repository": "", 19:43:55 INFO - "rev": "5cb754f869c7d481e73344642e4f941f08357b8b", 19:43:55 INFO - "who": "kwierso@gmail.com", 19:43:55 INFO - "when": 1452051687, 19:43:55 INFO - "number": 7422081, 19:43:55 INFO - "comments": "Bug 1225625 - Increase the timeout of browser_vimemacs.js a=test-only", 19:43:55 INFO - "project": "", 19:43:55 INFO - "at": "Tue 05 Jan 2016 19:41:27", 19:43:55 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 19:43:55 INFO - "revlink": "", 19:43:55 INFO - "properties": [ 19:43:55 INFO - [ 19:43:55 INFO - "buildid", 19:43:55 INFO - "20160105173105", 19:43:55 INFO - "Change" 19:43:55 INFO - ], 19:43:55 INFO - [ 19:43:55 INFO - "builduid", 19:43:55 INFO - "587936b5fa5544a6bdebd8e9437b765d", 19:43:55 INFO - "Change" 19:43:55 INFO - ], 19:43:55 INFO - [ 19:43:55 INFO - "pgo_build", 19:43:55 INFO - "True", 19:43:55 INFO - "Change" 19:43:55 INFO - ] 19:43:55 INFO - ], 19:43:55 INFO - "revision": "5cb754f869c7d481e73344642e4f941f08357b8b" 19:43:55 INFO - } 19:43:55 INFO - ], 19:43:55 INFO - "revision": "5cb754f869c7d481e73344642e4f941f08357b8b" 19:43:55 INFO - } 19:43:55 INFO - } 19:43:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 19:43:55 INFO - Running post-action listener: _resource_record_post_action 19:43:55 INFO - ##### 19:43:55 INFO - ##### Running download-and-extract step. 19:43:55 INFO - ##### 19:43:55 INFO - Running pre-action listener: _resource_record_pre_action 19:43:55 INFO - Running main action method: download_and_extract 19:43:55 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:55 INFO - https://queue.taskcluster.net/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:43:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/test_packages.json 19:43:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/test_packages.json 19:43:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:43:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:43:56 INFO - Downloaded 1302 bytes. 19:43:56 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:43:56 INFO - Using the following test package requirements: 19:43:56 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 19:43:56 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 19:43:56 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 19:43:56 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 19:43:56 INFO - u'jsshell-linux-x86_64.zip'], 19:43:56 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 19:43:56 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 19:43:56 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 19:43:56 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 19:43:56 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 19:43:56 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 19:43:56 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 19:43:56 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 19:43:56 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 19:43:56 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 19:43:56 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 19:43:56 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 19:43:56 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:43:56 INFO - https://queue.taskcluster.net/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:43:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 19:43:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 19:43:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 19:43:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:43:57 INFO - Downloaded 23023488 bytes. 19:43:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 19:43:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 19:43:57 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:43:58 INFO - Return code: 0 19:43:58 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:43:58 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')]} 19:43:58 INFO - https://queue.taskcluster.net/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:43:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 19:43:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 19:43:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 19:43:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:43:59 INFO - Downloaded 23023488 bytes. 19:43:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 19:43:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 19:43:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:44:00 INFO - Return code: 0 19:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:00 INFO - https://queue.taskcluster.net/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:44:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 19:44:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 19:44:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 19:44:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:44:01 INFO - Downloaded 11132038 bytes. 19:44:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 19:44:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 19:44:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 19:44:01 INFO - Return code: 0 19:44:01 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')]} 19:44:01 INFO - https://queue.taskcluster.net/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:44:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 19:44:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 19:44:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 19:44:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:44:03 INFO - Downloaded 58111973 bytes. 19:44:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 19:44:03 INFO - mkdir: /builds/slave/test-pgo/properties 19:44:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:44:03 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:44:03 INFO - Contents: 19:44:03 INFO - build_url:https://queue.taskcluster.net/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 19:44:03 INFO - Running post-action listener: _resource_record_post_action 19:44:03 INFO - Running post-action listener: set_extra_try_arguments 19:44:03 INFO - ##### 19:44:03 INFO - ##### Running populate-webroot step. 19:44:03 INFO - ##### 19:44:03 INFO - Running pre-action listener: _resource_record_pre_action 19:44:03 INFO - Running main action method: populate_webroot 19:44:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:44:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:44:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:44:03 INFO - '--tppagecycles', 19:44:03 INFO - '7'], 19:44:03 INFO - 'tests': ['tsvgm']}}, 19:44:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:44:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:44:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:44:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:44:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:44:03 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:44:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:44:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:03 INFO - 'talos_options': ['--e10s'], 19:44:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:44:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:03 INFO - 'tests': ['damp', 'tps']}, 19:44:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:03 INFO - 'talos_options': ['--e10s'], 19:44:03 INFO - 'tests': ['damp', 'tps']}, 19:44:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:44:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:44:03 INFO - 'other': {'tests': ['a11yr', 19:44:03 INFO - 'ts_paint', 19:44:03 INFO - 'tpaint', 19:44:03 INFO - 'sessionrestore', 19:44:03 INFO - 'sessionrestore_no_auto_restore']}, 19:44:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:44:03 INFO - 'tests': ['a11yr', 19:44:03 INFO - 'ts_paint', 19:44:03 INFO - 'tpaint', 19:44:03 INFO - 'sessionrestore', 19:44:03 INFO - 'sessionrestore_no_auto_restore']}, 19:44:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:44:03 INFO - 'tests': ['a11yr', 19:44:03 INFO - 'ts_paint', 19:44:03 INFO - 'tpaint', 19:44:03 INFO - 'sessionrestore', 19:44:03 INFO - 'sessionrestore_no_auto_restore']}, 19:44:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:44:03 INFO - 'tests': ['a11yr', 19:44:03 INFO - 'ts_paint', 19:44:03 INFO - 'tpaint', 19:44:03 INFO - 'sessionrestore', 19:44:03 INFO - 'sessionrestore_no_auto_restore']}, 19:44:03 INFO - 'other_l64': {'tests': ['a11yr', 19:44:03 INFO - 'ts_paint', 19:44:03 INFO - 'tpaint', 19:44:03 INFO - 'sessionrestore', 19:44:03 INFO - 'sessionrestore_no_auto_restore']}, 19:44:03 INFO - 'other_nol64': {'tests': ['a11yr', 19:44:03 INFO - 'ts_paint', 19:44:03 INFO - 'tpaint', 19:44:03 INFO - 'sessionrestore', 19:44:03 INFO - 'sessionrestore_no_auto_restore']}, 19:44:03 INFO - 'svgr': {'tests': ['tsvgx', 19:44:03 INFO - 'tsvgr_opacity', 19:44:03 INFO - 'tart', 19:44:03 INFO - 'tscrollx', 19:44:03 INFO - 'cart']}, 19:44:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:44:03 INFO - 'tests': ['tsvgx', 19:44:03 INFO - 'tsvgr_opacity', 19:44:03 INFO - 'tart', 19:44:03 INFO - 'tscrollx', 19:44:03 INFO - 'cart']}, 19:44:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:03 INFO - 'tests': ['tp5o']}, 19:44:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:03 INFO - 'talos_options': ['--e10s'], 19:44:03 INFO - 'tests': ['tp5o']}, 19:44:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:03 INFO - 'talos_options': ['--xperf_path', 19:44:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:44:03 INFO - 'tests': ['tp5n']}, 19:44:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:44:03 INFO - 'talos_options': ['--e10s', 19:44:03 INFO - '--xperf_path', 19:44:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:44:03 INFO - 'tests': ['tp5n']}}, 19:44:03 INFO - 'talos.zip': {'path': '', 19:44:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:44:03 INFO - Running post-action listener: _resource_record_post_action 19:44:03 INFO - ##### 19:44:03 INFO - ##### Running create-virtualenv step. 19:44:03 INFO - ##### 19:44:03 INFO - Running pre-action listener: _resource_record_pre_action 19:44:03 INFO - Running main action method: create_virtualenv 19:44:03 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:44:03 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 19:44:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:44:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:44:03 INFO - Using real prefix '/usr' 19:44:03 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:44:03 INFO - Installing distribute.............................................................................................................................................................................................done. 19:44:05 INFO - Installing pip.................done. 19:44:05 INFO - Return code: 0 19:44:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:44:05 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')]} 19:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:05 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')]} 19:44:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f848a630f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd9a450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2ca50>, '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 0xd98550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd989e0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1452051832.534616-1894599926', '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 19:44:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 19:44:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 19:44:05 INFO - Using env: {'DISPLAY': ':0', 19:44:05 INFO - 'HOME': '/home/cltbld', 19:44:05 INFO - 'LANG': 'en_US.UTF-8', 19:44:05 INFO - 'LANGUAGE': 'en_US:en', 19:44:05 INFO - 'LOGNAME': 'cltbld', 19:44:05 INFO - 'MAIL': '/var/mail/cltbld', 19:44:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:05 INFO - 'MOZ_NO_REMOTE': '1', 19:44:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:05 INFO - 'NO_EM_RESTART': '1', 19:44:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:44:05 INFO - 'PWD': '/builds/slave/test-pgo', 19:44:05 INFO - 'SHELL': '/bin/bash', 19:44:05 INFO - 'SHLVL': '1', 19:44:05 INFO - 'TERM': 'linux', 19:44:05 INFO - 'TMOUT': '86400', 19:44:05 INFO - 'USER': 'cltbld', 19:44:05 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452051832.534616-1894599926', 19:44:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:05 INFO - '_': '/tools/buildbot/bin/python'} 19:44:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:06 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 19:44:06 INFO - Cleaning up... 19:44:06 INFO - Return code: 0 19:44:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:44: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')]} 19:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44: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')]} 19:44:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f848a630f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd9a450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2ca50>, '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 0xd98550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd989e0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1452051832.534616-1894599926', '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 19:44:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 19:44:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 19:44:06 INFO - Using env: {'DISPLAY': ':0', 19:44:06 INFO - 'HOME': '/home/cltbld', 19:44:06 INFO - 'LANG': 'en_US.UTF-8', 19:44:06 INFO - 'LANGUAGE': 'en_US:en', 19:44:06 INFO - 'LOGNAME': 'cltbld', 19:44:06 INFO - 'MAIL': '/var/mail/cltbld', 19:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:06 INFO - 'MOZ_NO_REMOTE': '1', 19:44:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:06 INFO - 'NO_EM_RESTART': '1', 19:44:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:44:06 INFO - 'PWD': '/builds/slave/test-pgo', 19:44:06 INFO - 'SHELL': '/bin/bash', 19:44:06 INFO - 'SHLVL': '1', 19:44:06 INFO - 'TERM': 'linux', 19:44:06 INFO - 'TMOUT': '86400', 19:44:06 INFO - 'USER': 'cltbld', 19:44:06 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452051832.534616-1894599926', 19:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:06 INFO - '_': '/tools/buildbot/bin/python'} 19:44:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:06 INFO - Downloading/unpacking psutil>=0.7.1 19:44:06 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 19:44:06 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 19:44:06 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 19:44:06 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 19:44:06 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 19:44:06 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 19:44:08 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:44:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:44:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:44:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:44:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:44:08 INFO - Installing collected packages: psutil 19:44:08 INFO - Running setup.py install for psutil 19:44:08 INFO - building 'psutil._psutil_linux' extension 19:44:08 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 19:44:08 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 19:44:08 INFO - building 'psutil._psutil_posix' extension 19:44:08 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 19:44:08 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 19:44:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:44:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:44:08 INFO - Successfully installed psutil 19:44:08 INFO - Cleaning up... 19:44:08 INFO - Return code: 0 19:44:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f848a630f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd9a450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2ca50>, '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 0xd98550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd989e0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1452051832.534616-1894599926', '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 19:44:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 19:44:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 19:44:08 INFO - Using env: {'DISPLAY': ':0', 19:44:08 INFO - 'HOME': '/home/cltbld', 19:44:08 INFO - 'LANG': 'en_US.UTF-8', 19:44:08 INFO - 'LANGUAGE': 'en_US:en', 19:44:08 INFO - 'LOGNAME': 'cltbld', 19:44:08 INFO - 'MAIL': '/var/mail/cltbld', 19:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:08 INFO - 'MOZ_NO_REMOTE': '1', 19:44:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:08 INFO - 'NO_EM_RESTART': '1', 19:44:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:44:08 INFO - 'PWD': '/builds/slave/test-pgo', 19:44:08 INFO - 'SHELL': '/bin/bash', 19:44:08 INFO - 'SHLVL': '1', 19:44:08 INFO - 'TERM': 'linux', 19:44:08 INFO - 'TMOUT': '86400', 19:44:08 INFO - 'USER': 'cltbld', 19:44:08 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452051832.534616-1894599926', 19:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:08 INFO - '_': '/tools/buildbot/bin/python'} 19:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:44:08 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 19:44:08 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 19:44:08 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 19:44:08 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 19:44:08 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 19:44:08 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 19:44:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:44:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:44:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:44:10 INFO - Installing collected packages: mozsystemmonitor 19:44:10 INFO - Running setup.py install for mozsystemmonitor 19:44:10 INFO - Successfully installed mozsystemmonitor 19:44:10 INFO - Cleaning up... 19:44:10 INFO - Return code: 0 19:44:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:44: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')]} 19:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44: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')]} 19:44:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f848a630f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd9a450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2ca50>, '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 0xd98550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd989e0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1452051832.534616-1894599926', '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 19:44:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 19:44:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 19:44:10 INFO - Using env: {'DISPLAY': ':0', 19:44:10 INFO - 'HOME': '/home/cltbld', 19:44:10 INFO - 'LANG': 'en_US.UTF-8', 19:44:10 INFO - 'LANGUAGE': 'en_US:en', 19:44:10 INFO - 'LOGNAME': 'cltbld', 19:44:10 INFO - 'MAIL': '/var/mail/cltbld', 19:44:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:10 INFO - 'MOZ_NO_REMOTE': '1', 19:44:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:10 INFO - 'NO_EM_RESTART': '1', 19:44:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:44:10 INFO - 'PWD': '/builds/slave/test-pgo', 19:44:10 INFO - 'SHELL': '/bin/bash', 19:44:10 INFO - 'SHLVL': '1', 19:44:10 INFO - 'TERM': 'linux', 19:44:10 INFO - 'TMOUT': '86400', 19:44:10 INFO - 'USER': 'cltbld', 19:44:10 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452051832.534616-1894599926', 19:44:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:10 INFO - '_': '/tools/buildbot/bin/python'} 19:44:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:10 INFO - Downloading/unpacking blobuploader==1.2.4 19:44: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 19:44: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 19:44: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 19:44: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 19:44: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 19:44: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 19:44:12 INFO - Downloading blobuploader-1.2.4.tar.gz 19:44:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:44:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:44:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:44: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 19:44: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 19:44: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 19:44: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 19:44: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 19:44: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 19:44:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:44:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:44:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:44: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 19:44: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 19:44: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 19:44: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 19:44: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 19:44: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 19:44:13 INFO - Downloading docopt-0.6.1.tar.gz 19:44:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:44:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:44:13 INFO - Installing collected packages: blobuploader, requests, docopt 19:44:13 INFO - Running setup.py install for blobuploader 19:44:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:44:13 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:44:13 INFO - Running setup.py install for requests 19:44:13 INFO - Running setup.py install for docopt 19:44:13 INFO - Successfully installed blobuploader requests docopt 19:44:13 INFO - Cleaning up... 19:44:14 INFO - Return code: 0 19:44:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:44:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f848a630f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd9a450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2ca50>, '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 0xd98550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd989e0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1452051832.534616-1894599926', '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 19:44:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 19:44:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --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 19:44:14 INFO - Using env: {'DISPLAY': ':0', 19:44:14 INFO - 'HOME': '/home/cltbld', 19:44:14 INFO - 'LANG': 'en_US.UTF-8', 19:44:14 INFO - 'LANGUAGE': 'en_US:en', 19:44:14 INFO - 'LOGNAME': 'cltbld', 19:44:14 INFO - 'MAIL': '/var/mail/cltbld', 19:44:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:14 INFO - 'MOZ_NO_REMOTE': '1', 19:44:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:14 INFO - 'NO_EM_RESTART': '1', 19:44:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:44:14 INFO - 'PWD': '/builds/slave/test-pgo', 19:44:14 INFO - 'SHELL': '/bin/bash', 19:44:14 INFO - 'SHLVL': '1', 19:44:14 INFO - 'TERM': 'linux', 19:44:14 INFO - 'TMOUT': '86400', 19:44:14 INFO - 'USER': 'cltbld', 19:44:14 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452051832.534616-1894599926', 19:44:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:14 INFO - '_': '/tools/buildbot/bin/python'} 19:44:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:44:14 INFO - Running setup.py (path:/tmp/pip-863Tfm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:44:14 INFO - Running setup.py (path:/tmp/pip-Y_2Oeq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:44:14 INFO - Running setup.py (path:/tmp/pip-DAsXxm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:44:14 INFO - Running setup.py (path:/tmp/pip-UuEVCM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:44:14 INFO - Running setup.py (path:/tmp/pip-ayfaWa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:44:14 INFO - Running setup.py (path:/tmp/pip-JjjTuW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:44:14 INFO - Running setup.py (path:/tmp/pip-Tsa_Kq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:44:14 INFO - Running setup.py (path:/tmp/pip-ix70zu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:44:14 INFO - Running setup.py (path:/tmp/pip-2Jw_RO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:44:14 INFO - Running setup.py (path:/tmp/pip-ic7L_C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:44:14 INFO - Running setup.py (path:/tmp/pip-DBwcgI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:44:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:44:15 INFO - Running setup.py (path:/tmp/pip-rc90VW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:44:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:44:15 INFO - Running setup.py (path:/tmp/pip-nRYQeH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:44:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:44:15 INFO - Running setup.py (path:/tmp/pip-ogLj3Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:44:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:44:15 INFO - Running setup.py (path:/tmp/pip-OGoMaj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:44:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:44:15 INFO - Running setup.py (path:/tmp/pip-tmAZcC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:44:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:44:15 INFO - Running setup.py (path:/tmp/pip-XujsmU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:44:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:44:15 INFO - Running setup.py install for manifestparser 19:44:15 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:44:15 INFO - Running setup.py install for mozcrash 19:44:15 INFO - Running setup.py install for mozdebug 19:44:15 INFO - Running setup.py install for mozdevice 19:44:15 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:44:15 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:44:15 INFO - Running setup.py install for mozfile 19:44:15 INFO - Running setup.py install for mozhttpd 19:44:16 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:44:16 INFO - Running setup.py install for mozinfo 19:44:16 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:44:16 INFO - Running setup.py install for mozInstall 19:44:16 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:44:16 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:44:16 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:44:16 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:44:16 INFO - Running setup.py install for mozleak 19:44:16 INFO - Running setup.py install for mozlog 19:44:16 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:44:16 INFO - Running setup.py install for moznetwork 19:44:16 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:44:16 INFO - Running setup.py install for mozprocess 19:44:16 INFO - Running setup.py install for mozprofile 19:44:16 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:44:16 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:44:16 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:44:16 INFO - Running setup.py install for mozrunner 19:44:16 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:44:16 INFO - Running setup.py install for mozscreenshot 19:44:16 INFO - Running setup.py install for moztest 19:44:17 INFO - Running setup.py install for mozversion 19:44:17 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:44:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:44:17 INFO - Cleaning up... 19:44:17 INFO - Return code: 0 19:44:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:44:17 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')]} 19:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:17 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')]} 19:44:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f848a630f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd9a450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2ca50>, '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 0xd98550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd989e0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1452051832.534616-1894599926', '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 19:44:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 19:44:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 19:44:17 INFO - Using env: {'DISPLAY': ':0', 19:44:17 INFO - 'HOME': '/home/cltbld', 19:44:17 INFO - 'LANG': 'en_US.UTF-8', 19:44:17 INFO - 'LANGUAGE': 'en_US:en', 19:44:17 INFO - 'LOGNAME': 'cltbld', 19:44:17 INFO - 'MAIL': '/var/mail/cltbld', 19:44:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:17 INFO - 'MOZ_NO_REMOTE': '1', 19:44:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:17 INFO - 'NO_EM_RESTART': '1', 19:44:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:44:17 INFO - 'PWD': '/builds/slave/test-pgo', 19:44:17 INFO - 'SHELL': '/bin/bash', 19:44:17 INFO - 'SHLVL': '1', 19:44:17 INFO - 'TERM': 'linux', 19:44:17 INFO - 'TMOUT': '86400', 19:44:17 INFO - 'USER': 'cltbld', 19:44:17 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452051832.534616-1894599926', 19:44:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:17 INFO - '_': '/tools/buildbot/bin/python'} 19:44:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:44:17 INFO - Running setup.py (path:/tmp/pip-PtBoh4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:44:17 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)) 19:44:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:44:17 INFO - Running setup.py (path:/tmp/pip-ht0wAX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:44:17 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)) 19:44:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:44:17 INFO - Running setup.py (path:/tmp/pip-aFquBg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:44:17 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)) 19:44:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:44:17 INFO - Running setup.py (path:/tmp/pip-APrPKg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:44:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 19:44:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:44:17 INFO - Running setup.py (path:/tmp/pip-shcIwI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:44:17 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)) 19:44:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:44:17 INFO - Running setup.py (path:/tmp/pip-2TAujK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:44:17 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)) 19:44:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:44:17 INFO - Running setup.py (path:/tmp/pip-KZ5JOq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:44:17 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)) 19:44:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:44:17 INFO - Running setup.py (path:/tmp/pip-cRtsce-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:44:18 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)) 19:44:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:44:18 INFO - Running setup.py (path:/tmp/pip-zdQMPN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:44:18 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)) 19:44:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:44:18 INFO - Running setup.py (path:/tmp/pip-VuO3zp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:44:18 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)) 19:44:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:44:18 INFO - Running setup.py (path:/tmp/pip-xwD6G_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:44:18 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)) 19:44:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:44:18 INFO - Running setup.py (path:/tmp/pip-9XihM_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:44:18 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)) 19:44:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:44:18 INFO - Running setup.py (path:/tmp/pip-yjqDps-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:44:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 19:44:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:44:18 INFO - Running setup.py (path:/tmp/pip-NiLFQh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:44:18 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)) 19:44:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:44:18 INFO - Running setup.py (path:/tmp/pip-wtZQ5B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:44:18 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)) 19:44:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:44:18 INFO - Running setup.py (path:/tmp/pip-fa1gX3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:44:18 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)) 19:44:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:44:18 INFO - Running setup.py (path:/tmp/pip-wG8tJB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:44:18 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)) 19:44:18 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)) 19:44:18 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)) 19:44:18 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)) 19:44:18 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:44:18 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:44:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:44:18 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 19:44:18 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 19:44:18 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 19:44:18 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 19:44:18 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 19:44:18 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 19:44:20 INFO - Downloading blessings-1.5.1.tar.gz 19:44:20 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 19:44:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:44:20 INFO - Installing collected packages: blessings 19:44:20 INFO - Running setup.py install for blessings 19:44:20 INFO - Successfully installed blessings 19:44:20 INFO - Cleaning up... 19:44:20 INFO - Return code: 0 19:44:20 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:44:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:44:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:44:20 INFO - Reading from file tmpfile_stdout 19:44:20 INFO - Current package versions: 19:44:20 INFO - argparse == 1.2.1 19:44:20 INFO - blessings == 1.5.1 19:44:20 INFO - blobuploader == 1.2.4 19:44:20 INFO - docopt == 0.6.1 19:44:20 INFO - manifestparser == 1.1 19:44:20 INFO - mozInstall == 1.12 19:44:20 INFO - mozcrash == 0.16 19:44:20 INFO - mozdebug == 0.1 19:44:20 INFO - mozdevice == 0.47 19:44:20 INFO - mozfile == 1.2 19:44:20 INFO - mozhttpd == 0.7 19:44:20 INFO - mozinfo == 0.9 19:44:20 INFO - mozleak == 0.1 19:44:20 INFO - mozlog == 3.1 19:44:20 INFO - moznetwork == 0.27 19:44:20 INFO - mozprocess == 0.22 19:44:20 INFO - mozprofile == 0.27 19:44:20 INFO - mozrunner == 6.11 19:44:20 INFO - mozscreenshot == 0.1 19:44:20 INFO - mozsystemmonitor == 0.0 19:44:20 INFO - moztest == 0.7 19:44:20 INFO - mozversion == 1.4 19:44:20 INFO - psutil == 3.1.1 19:44:20 INFO - requests == 1.2.3 19:44:20 INFO - wsgiref == 0.1.2 19:44:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:20 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f848a630f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd9a450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2ca50>, '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 0xd98550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd989e0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1452051832.534616-1894599926', '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 19:44:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 19:44:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 19:44:20 INFO - Using env: {'DISPLAY': ':0', 19:44:20 INFO - 'HOME': '/home/cltbld', 19:44:20 INFO - 'LANG': 'en_US.UTF-8', 19:44:20 INFO - 'LANGUAGE': 'en_US:en', 19:44:20 INFO - 'LOGNAME': 'cltbld', 19:44:20 INFO - 'MAIL': '/var/mail/cltbld', 19:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:20 INFO - 'MOZ_NO_REMOTE': '1', 19:44:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:20 INFO - 'NO_EM_RESTART': '1', 19:44:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:44:20 INFO - 'PWD': '/builds/slave/test-pgo', 19:44:20 INFO - 'SHELL': '/bin/bash', 19:44:20 INFO - 'SHLVL': '1', 19:44:20 INFO - 'TERM': 'linux', 19:44:20 INFO - 'TMOUT': '86400', 19:44:20 INFO - 'USER': 'cltbld', 19:44:20 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452051832.534616-1894599926', 19:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:20 INFO - '_': '/tools/buildbot/bin/python'} 19:44:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:21 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 1)) 19:44:21 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 2)) 19:44:21 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 3)) 19:44:21 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 4)) 19:44:21 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 5)) 19:44:21 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 6)) 19:44:21 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 7)) 19:44:21 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 8)) 19:44:21 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:44:21 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 3)) 19:44:21 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:44:21 INFO - Cleaning up... 19:44:21 INFO - Return code: 0 19:44:21 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f848a630f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd9a450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2ca50>, '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 0xd98550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd989e0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1452051832.534616-1894599926', '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 19:44:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 19:44:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 19:44:21 INFO - Using env: {'DISPLAY': ':0', 19:44:21 INFO - 'HOME': '/home/cltbld', 19:44:21 INFO - 'LANG': 'en_US.UTF-8', 19:44:21 INFO - 'LANGUAGE': 'en_US:en', 19:44:21 INFO - 'LOGNAME': 'cltbld', 19:44:21 INFO - 'MAIL': '/var/mail/cltbld', 19:44:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:21 INFO - 'MOZ_NO_REMOTE': '1', 19:44:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:21 INFO - 'NO_EM_RESTART': '1', 19:44:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:44:21 INFO - 'PWD': '/builds/slave/test-pgo', 19:44:21 INFO - 'SHELL': '/bin/bash', 19:44:21 INFO - 'SHLVL': '1', 19:44:21 INFO - 'TERM': 'linux', 19:44:21 INFO - 'TMOUT': '86400', 19:44:21 INFO - 'USER': 'cltbld', 19:44:21 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452051832.534616-1894599926', 19:44:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:21 INFO - '_': '/tools/buildbot/bin/python'} 19:44:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:21 INFO - Downloading/unpacking jsonschema 19:44:21 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 19:44:21 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 19:44:21 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 19:44:21 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 19:44:21 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 19:44:21 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 19:44:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:44:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 19:44:23 INFO - Downloading/unpacking functools32 (from jsonschema) 19:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:23 INFO - Downloading functools32-3.2.3-2.tar.gz 19:44:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:44:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:44:23 INFO - warning: no files found matching '*.txt' 19:44:23 INFO - no previously-included directories found matching 'build' 19:44:23 INFO - no previously-included directories found matching 'dist' 19:44:23 INFO - no previously-included directories found matching '.git*' 19:44:23 INFO - Installing collected packages: jsonschema, functools32 19:44:23 INFO - Running setup.py install for functools32 19:44:23 INFO - warning: no files found matching '*.txt' 19:44:23 INFO - no previously-included directories found matching 'build' 19:44:23 INFO - no previously-included directories found matching 'dist' 19:44:23 INFO - no previously-included directories found matching '.git*' 19:44:23 INFO - Successfully installed jsonschema functools32 19:44:23 INFO - Cleaning up... 19:44:23 INFO - Return code: 0 19:44:23 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:44:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:44:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:44:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:44:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:44:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7f848a630f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xccc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd9a450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe2ca50>, '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 0xd98550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd989e0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1452051832.534616-1894599926', '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 19:44:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 19:44:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 19:44:23 INFO - Using env: {'DISPLAY': ':0', 19:44:23 INFO - 'HOME': '/home/cltbld', 19:44:23 INFO - 'LANG': 'en_US.UTF-8', 19:44:23 INFO - 'LANGUAGE': 'en_US:en', 19:44:23 INFO - 'LOGNAME': 'cltbld', 19:44:23 INFO - 'MAIL': '/var/mail/cltbld', 19:44:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:23 INFO - 'MOZ_NO_REMOTE': '1', 19:44:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:23 INFO - 'NO_EM_RESTART': '1', 19:44:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:44:23 INFO - 'PWD': '/builds/slave/test-pgo', 19:44:23 INFO - 'SHELL': '/bin/bash', 19:44:23 INFO - 'SHLVL': '1', 19:44:23 INFO - 'TERM': 'linux', 19:44:23 INFO - 'TMOUT': '86400', 19:44:23 INFO - 'USER': 'cltbld', 19:44:23 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452051832.534616-1894599926', 19:44:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:23 INFO - '_': '/tools/buildbot/bin/python'} 19:44:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:44:23 INFO - Downloading/unpacking flake8 19:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:44:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:44:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:44:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 19:44:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:44:25 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 19:44:25 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 19:44:25 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 19:44:25 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 19:44:25 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 19:44:25 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 19:44:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:44:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 19:44:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:44:25 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 19:44:25 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 19:44:25 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 19:44:25 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 19:44:25 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 19:44:25 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 19:44:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 19:44:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:44:25 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 19:44:25 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 19:44:25 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 19:44:25 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 19:44:25 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 19:44:25 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 19:44:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:44:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:44:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:44:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:44:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:44:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:44:26 INFO - no previously-included directories found matching 'docs/_build' 19:44:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:44:26 INFO - Running setup.py install for pep8 19:44:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:44:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:44:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:44:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:44:26 INFO - no previously-included directories found matching 'docs/_build' 19:44:26 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:44:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:44:26 INFO - Cleaning up... 19:44:26 INFO - Return code: 0 19:44:26 INFO - Running post-action listener: _resource_record_post_action 19:44:26 INFO - Running post-action listener: _start_resource_monitoring 19:44:26 INFO - Starting resource monitoring. 19:44:26 INFO - ##### 19:44:26 INFO - ##### Running install step. 19:44:26 INFO - ##### 19:44:26 INFO - Running pre-action listener: _resource_record_pre_action 19:44:26 INFO - Running main action method: install 19:44:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:44:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:44:26 INFO - Reading from file tmpfile_stdout 19:44:26 INFO - Detecting whether we're running mozinstall >=1.0... 19:44:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:44:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:44:26 INFO - Reading from file tmpfile_stdout 19:44:26 INFO - Output received: 19:44:26 INFO - Usage: mozinstall [options] installer 19:44:26 INFO - Options: 19:44:26 INFO - -h, --help show this help message and exit 19:44:26 INFO - -d DEST, --destination=DEST 19:44:26 INFO - Directory to install application into. [default: 19:44:26 INFO - "/builds/slave/test-pgo"] 19:44:26 INFO - --app=APP Application being installed. [default: firefox] 19:44:26 INFO - mkdir: /builds/slave/test-pgo/build/application 19:44:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 19:44:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 19:44:41 INFO - Reading from file tmpfile_stdout 19:44:41 INFO - Output received: 19:44:41 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:44:41 INFO - Running post-action listener: _resource_record_post_action 19:44:41 INFO - ##### 19:44:41 INFO - ##### Running run-tests step. 19:44:41 INFO - ##### 19:44:41 INFO - Running pre-action listener: _resource_record_pre_action 19:44:41 INFO - Running main action method: run_tests 19:44:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:44:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:44:41 INFO - Python 2.7.3 19:44:41 INFO - Return code: 0 19:44:41 INFO - grabbing minidump binary from tooltool 19: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')]} 19:44:41 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 0xe2ca50>, '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 0xd98550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd989e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:44:41 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 19:44:41 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 19:44:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:44:41 INFO - Return code: 0 19:44:41 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:44:41 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:44:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:44:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:44:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:44:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:44:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:44:42 INFO - Return code: 0 19:44:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 19:44:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost 19:44:42 INFO - Using env: {'DISPLAY': ':0', 19:44:42 INFO - 'HOME': '/home/cltbld', 19:44:42 INFO - 'LANG': 'en_US.UTF-8', 19:44:42 INFO - 'LANGUAGE': 'en_US:en', 19:44:42 INFO - 'LOGNAME': 'cltbld', 19:44:42 INFO - 'MAIL': '/var/mail/cltbld', 19:44:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:44:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:44:42 INFO - 'MOZ_NO_REMOTE': '1', 19:44:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:44:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:44:42 INFO - 'NO_EM_RESTART': '1', 19:44:42 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:44:42 INFO - 'PWD': '/builds/slave/test-pgo', 19:44:42 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:44:42 INFO - 'SHELL': '/bin/bash', 19:44:42 INFO - 'SHLVL': '1', 19:44:42 INFO - 'TERM': 'linux', 19:44:42 INFO - 'TMOUT': '86400', 19:44:42 INFO - 'USER': 'cltbld', 19:44:42 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1452051832.534616-1894599926', 19:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:44:42 INFO - '_': '/tools/buildbot/bin/python'} 19:44:42 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost'] with output_timeout 3600 19:44:42 INFO - mozversion INFO | application_buildid: 20160105173105 19:44:42 INFO - mozversion INFO | application_changeset: 5cb754f869c7d481e73344642e4f941f08357b8b 19:44:42 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 19:44:42 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:44:42 INFO - mozversion INFO | application_name: Firefox 19:44:42 INFO - mozversion INFO | application_remotingname: firefox-dev 19:44:42 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:44:42 INFO - mozversion INFO | application_vendor: Mozilla 19:44:42 INFO - mozversion INFO | application_version: 45.0a2 19:44:42 INFO - mozversion INFO | platform_buildid: 20160105173105 19:44:42 INFO - mozversion INFO | platform_changeset: 5cb754f869c7d481e73344642e4f941f08357b8b 19:44:42 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:44:42 INFO - mozversion INFO | platform_version: 45.0a2 19:44:42 INFO - 2016-01-05 19:44:42,377 DEBUG : using testdate: 1452051882 19:44:42 INFO - 2016-01-05 19:44:42,377 DEBUG : actual date: 1452051882 19:44:42 INFO - 2016-01-05 19:44:42,386 INFO : starting webserver on 'localhost:34703' 19:44:42 INFO - 2016-01-05 19:44:42,387 INFO : Starting test suite talos-linux64-ix-002.e 19:44:42 INFO - 2016-01-05 19:44:42,387 INFO : Starting test dromaeo_css 19:44:42 INFO - 2016-01-05 19:44:42,387 DEBUG : operating with platform_type : linux_ 19:44:42 INFO - 2016-01-05 19:44:42,388 INFO : Initialising browser for dromaeo_css test... 19:44:42 INFO - 2016-01-05 19:44:42,402 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpga4B02/profile http://localhost:34703/getInfo.html 19:44:46 INFO - 2016-01-05 19:44:46,966 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:44:46 INFO - 2016-01-05 19:44:46,966 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:44:46 INFO - 2016-01-05 19:44:46,966 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:44:46 INFO - 2016-01-05 19:44:46,967 DEBUG : BROWSER_OUTPUT: __metrics 19:44:47 INFO - 2016-01-05 19:44:47,933 INFO : Browser initialized. 19:44:47 INFO - 2016-01-05 19:44:47,934 INFO : Running cycle 1/1 for dromaeo_css test... 19:44:47 INFO - 2016-01-05 19:44:47,934 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpga4B02/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:44:59 INFO - 2016-01-05 19:44:59,648 DEBUG : BROWSER_OUTPUT: RSS: Main: 136781824 19:44:59 INFO - 2016-01-05 19:44:59,649 DEBUG : BROWSER_OUTPUT: 19:45:49 INFO - 2016-01-05 19:45:49,269 DEBUG : BROWSER_OUTPUT: 1452051949268 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] 19:47:57 INFO - 2016-01-05 19:47:57,069 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34703/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34703/tests/dromaeo/cssquery-ext.html) 19:47:58 INFO - 2016-01-05 19:47:58,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 141877248 19:47:58 INFO - 2016-01-05 19:47:58,114 DEBUG : BROWSER_OUTPUT: 19:50:59 INFO - 2016-01-05 19:50:59,831 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34703/tests/dromaeo/cssquery-ext.html (next: http://localhost:34703/tests/dromaeo/cssquery-jquery.html) 19:51:00 INFO - 2016-01-05 19:51:00,416 DEBUG : BROWSER_OUTPUT: RSS: Main: 140517376 19:51:00 INFO - 2016-01-05 19:51:00,416 DEBUG : BROWSER_OUTPUT: 19:54:01 INFO - 2016-01-05 19:54:01,914 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34703/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34703/tests/dromaeo/cssquery-mootools.html) 19:54:02 INFO - 2016-01-05 19:54:02,497 DEBUG : BROWSER_OUTPUT: RSS: Main: 139755520 19:54:02 INFO - 2016-01-05 19:54:02,497 DEBUG : BROWSER_OUTPUT: 19:57:04 INFO - 2016-01-05 19:57:04,075 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34703/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34703/tests/dromaeo/cssquery-prototype.html) 19:57:04 INFO - 2016-01-05 19:57:04,664 DEBUG : BROWSER_OUTPUT: RSS: Main: 139509760 19:57:04 INFO - 2016-01-05 19:57:04,664 DEBUG : BROWSER_OUTPUT: 20:00:06 INFO - 2016-01-05 20:00:06,883 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34703/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34703/tests/dromaeo/cssquery-yui.html) 20:00:07 INFO - 2016-01-05 20:00:07,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 138690560 20:00:07 INFO - 2016-01-05 20:00:07,485 DEBUG : BROWSER_OUTPUT: 20:03:09 INFO - 2016-01-05 20:03:09,413 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34703/tests/dromaeo/cssquery-yui.html (next: http://localhost:34703/tests/dromaeo/cssquery-dojo.html) 20:03:09 INFO - 2016-01-05 20:03:09,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 140660736 20:03:09 INFO - 2016-01-05 20:03:09,664 DEBUG : BROWSER_OUTPUT: 20:03:09 INFO - 2016-01-05 20:03:09,664 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:03:09 INFO - 2016-01-05 20:03:09,664 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:03:09 INFO - 2016-01-05 20:03:09,664 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:03:09 INFO - 2016-01-05 20:03:09,664 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:03:09 INFO - 2016-01-05 20:03:09,665 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3346.548215990841;3392.1350055735784;3403.234272288734;3428.7599868009233;3429.434143366345;5438.809641662542;5450.700211488366;5468.808591699291;5487.643303185295;5494.230807686917;5512.669239845602;5553.583481238903;5569.053260945639;5600.411956744544;5614.129809879465;5075.162598171307;5111.718855462948;5157.510036546522;5165.509276618715;5203.505666961632;4936.531029552205;4966.801327946878;5062.26597143414;5077.441481437039;5088.54203121719;5058.645894787366;5112.054269960069;5119.692818430887;5126.974365128169;5168.379794424674;5075.517825806561;5132.769025393866;5140.357455318085;5140.537351638333;5173.922391164117;4869.878253043702;4947.950520494821;5014.89970200594;5047.4952504749235;5063.594912406998;5338.252644629755;5360.303160589137;5370.5435038021815;5423.701696406696;5428.4842939920645;5924.881502369972;5952.315483719384;5965.313988891289;5975.671338076404;5980.611260268069;5763.250777398953;5871.588988770788;6054.545909056795;6057.697115144269;6075.301340345873;5569.526590239794;5574.136008918624;5580.107182850765;5583.609147359686;5608.663480191201;6043.365446628129;6046.697665116727;6050.6672133032225;6058.666773327421;6063.302720187235;5629.549636029108;5650.74571644277;5860.413958604106;5874.853128671732;5945.40545945402;6040.154378387029;6051.485623721945;6069;6075.939240607626;6099.603525770811;5982.551308651869;6026.668533230627;6026.6986650667295;6030.577859549877;6044.395560443921;5757.0788673811985;5831.454664513907;5911.674857882772;5991.760329586855;6050.152978583002;4626.629869610423;4646.303054541778;4652.441706995182;4667.556582124693;4693.342931989524;4159.5008598967715;4169.791510424528;4170.749755014648;4179.477565304337;4208.936865947013;5489.149181876815;5561.833145005576;5655.293088363955;5740.712964351849;5805.651660900359;6039.758409663652;6066.636001839815;6068.241469816273;6076.4531192192035;6077.544184186204;5500.257465242221;5645.971770141123;5704.372519022904;5706.600537962386;5725;5210.062188806051;5243;5284.524392804666;5291.232771248147;5294.54996325309;6156.045812899008;6197.25632924052;6202.627842329474;6213.409726076015;6223.502119830403;5729.427057294404;5838.503727183067;6034.969825150846;6059.515238780798;6066.484348830399;6135.263289243823;6192.318844926965;6244.875102497834;6247.5001999840815;6247.812565623039;5944.108383742473;5970.609904223256;5981.2822461303185;6011.27864656244;6033.366496517978;5868.2664666916635;5995.940040599538;6033.577649564489;6108.725107370268;6123.969380153071;5872.207252021093;5917.497012753792;5917.497012753965;5928.644281343133;5938.465538101592;5861.062230043172;5878.265216847894;5908.734106965283;5909.763609455746;5933.258342707161;5532.391436942014;5614.494695477427;5797.449242321973;5813.505852002627;5951.345352011362;5932.406759324033;5991.310999234969;5996.220491336098;5999.4900433463645;6010.098485227076;5816.069428891357;5835.708214589169;5851.795187168429;5856.765729370948;5872 20:03:09 INFO - 2016-01-05 20:03:09,667 DEBUG : BROWSER_OUTPUT: |1;ext.html;593.8693487432766;634.9904751428729;640.9935900640997;644.6937704590318;664.4418688301826;32745.345093098123;41028.58971410285;41056.384154237676;41167.794161029226;41246;46537.7673111634;46719.76640116803;46726.76636616812;46972.530274697245;47155.056898862;8906.465612063264;9065.546722663841;9090;9090.54547272637;9105.590248438803;8988.550572471382;9122.452652840851;9137.725868223964;9141.725748227564;9145.817083658323;9103.044180361067;9158.175764181222;9177.724668259963;9182.08179182083;9195.954020229923;9040.321975851837;9050.818983620324;9091.772610697537;9106.089391060907;9119.772005699844;9020.503872287021;9191.770205744842;9194.678186263516;9198;9208;43488.56511434877;43491.565084349066;43583;43783.34324985128;43817.561824381664;3283.097148284217;3304.5043243513664;3343.3480471308103;3387.8644854205804;3613.8735144270086;32239.677603223903;32503.51244731331;32584.83707581447;32714.182145446317;32840;3612.24142929985;3730.8880733578035;3770.9434358484646;3797.886063418074;3828.157805282833;285438;288959;289232;289590;290208;45678.314825277645;62083.37916620776;62131.378686213466;62248;62463.6876815613;43791.56208437939;43989.78005110018;44080.338794918105;44094.559054409685;44332;14914.328855201542;14929.850701492845;14967.176805275814;15001.399944002336;15009.849901501064;13365.131266467843;13375.464981400635;13383.397747101404;13401.195928244142;13497;14977.475788347356;15203.923980380026;15461.149636770086;15485.380584776709;15610.843891561166;6112.816615501542;6228.5017198624;6240.5319601030105;6276.6547839868335;6372.808815735535;1021.4839864730367;1036.875574930998;1039.2205845615788;1052.4369462337613;1099.1701265544464;28979.710202897702;29114.272143196165;29345.266368340963;29446.705532944823;29533.85233073821;1050.9527071281811;1066.828699783857;1067.1409515340226;1078.2398409121552;1124.9606263780893;14530.273486325641;14843.812495000375;14975;15219.847801522064;15489.845101549066;301959;303608;303969;342091;790689;57501;57950;58104;58229.4177058224;58321;1504.330572895051;1519.908805471653;1523.5048609202054;1530.2425299476831;1545.2737213509633;30887;31244.68755312418;31537.52693709642;31592.684073158973;31840.68159318377;49486;49658.255126172415;49966.25050624171;50285.74857125691;50516.74741626268;314221;315141;316286;317512;317598;35709.64290357063;36087;36214;36637.450438242915;36748;45123.32315015343;46011.079778403575;47005.294920576904;47171.764141179076;47267.52732472631;39996.20007599774;39997.40003899886;40171.196576067734;40739.38890916579;41052.1789564213;39715.602843972345;40116.7994160039;40413.393799093625;41070.79464602658;41115.1776964465;38519.614803851604;38873.611263886996;39012.609873900896;39146.41280380853;39648;34629;34974.300513990085;35139.82430087833;35343.82328088343;35464.290714186085;26587.867060664572;26992.190234293004;27278.181654550393;27335.726642734113;27892.721072789012 20:03:09 INFO - 2016-01-05 20:03:09,670 DEBUG : BROWSER_OUTPUT: |2;jquery.html;378.21142917018017;382.40535966572;382.6632563344257;392.5622930432568;397.8726807421625;15206.771898421532;15222.847771522296;16416.671666566675;18863.339783107593;19427.708584371212;11475.598354057609;13970.580882573513;15605.375784968588;16759.162041897886;16843.41048063318;5010.373703287099;5115.948840511584;5120.4623514530995;5130.256112863633;5132.204508301201;4228.133232687292;5201.86995325118;5204.713740744258;5252.71110088945;5258;5614.877024595077;5621.241132447109;5638.069718496443;5657.462541058593;5672.035753921822;5200.713960732158;5326.387465441485;5644.887102257952;5663.093904975205;5663.688497132676;4985.127602669519;4986.551210391082;5008.398992120932;5011.774470148815;5016.523430274118;13901.58295251134;15831.050136991817;16397.754033689504;21993.230236941632;21999.12003519873;2299.321700098475;2313.2944451942153;2380.131252092991;2394.5330660521204;2410.0480310277344;10120.493975301206;10480.895191048068;11061.557537698482;13635.318234088356;14403.135811851322;1836.5316844204776;1883.9905800471047;1927.6433859735994;1981.4749091490767;2011.8189362957257;58515.70742146305;58855;59279.11081333784;59365.703171484296;64572;10293.691189264335;10902.182336324808;11153.944230278797;11226.045786108109;11237.157213208879;14382.424703011762;14800.111993280438;14940;14971;14991;8400.831983360298;8601.13988601135;8741;8751.168638979287;8779.12208779117;8079.1516890725625;8080.39397045224;8091.635876385459;8164.265216130577;8193.303569196565;4742.976285118552;4753.9762301188275;4764.785584648699;4820.831270905502;4842;1866.9346572869883;1969.0154922538732;1994.0428594274829;2016.374923773635;2017.949551261201;955.2024059909915;959.0840747086655;979.8922118566952;1003.0020129970726;1058.8200005998845;16333;16480.917595411946;17188.398406055727;17368;17566;903.6024149374255;953.5232383808096;957.6600306891092;971.1162841813915;1014.1987829614669;9041.68354107603;9495.516476079501;9519.904800952041;9564.808703825884;9727.173190278905;601275;606858;613579;633776;646341;81081.59459202785;83098.58450707707;83289.58355208185;86966.56516717502;87587.56206218927;1214.8663646998823;1222.8226907098422;1226.589092653971;1227.6378468351857;1230.6677197156719;14939.402423903357;14962.700745984801;14985.100893946397;15092.471763488225;15329.540113796604;32444.51333229956;32531.18672033218;32710.672893270763;33919.321613567095;35497.82251088728;43235.13529729325;44807;45059.54940450554;46311;46576.53423465722;9608.519574021411;9951.601935922483;10070.345427547187;10092.444915529717;10097.949510252402;11676.06591472697;16522.339106435607;16842.494725158263;16884;17631.206595702966;13779.931100344435;13903.09629874055;13948.651283717581;14145.292735363397;14191.929040354733;13840.4463821446;14044.78932815988;14263.144211347353;14285.142891426132;14719.484818031318;14774.77837832412;14833.110013399231;14920.925395372953;15129.621759456102;15157.242137893281;10196.13332866685;10244.59021639156;10291.507731378759;10299.3820370778;10592.099671528007;14317.785233221302;14472.421103155755;14509.85490145085;14606.780898286746;14708.77936830927 20:03:09 INFO - 2016-01-05 20:03:09,671 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1372.3824279074418;1433.4051368681999;1605.2214675882194;1704.164959170007;1845.9907700461495;7183.425325973923;7329.780106596797;7907.920920790791;8340.70807521736;8397.202265784756;7664.501807382516;7862.96068519658;7931.206879312066;8193.30356919661;8207.384446166532;2373.2761507740133;2391.4380120671717;2398.256540472459;2404.855708657486;2409.759024097585;2394.6767186429784;2439.3047981325326;2471.8393304435153;2485.639582260571;2486.266551367342;2321.3732292281156;2329.126577533425;2335.1126571902737;2357.787799098081;2365.3731761083327;2335.7781010803947;2368.0882860098814;2390;2394.7605239476;2400.0399840063938;2333.346662934381;2342.051469154995;2360.3391050505884;2375.121205154087;2384.616922185146;8198.139195384518;8250.504969701837;8256.876146857801;8258.587070646503;8269.751907442786;4877.975610121962;4914.852554423373;4929.482404347564;4931.876703082416;4964.404271487409;3138.4037032963665;3142.402943440739;3161.5889934308393;3172;3258.429774789426;979.1725991537139;996.795656890343;998.8451789972565;1022.4683164754287;1037.8287582548871;11151.944240278746;11230.101591872712;11266.43667816606;11277.774444511146;11279.887201128047;4386.254336762694;4403.801828917706;4423.712458690175;4476.440444944382;4485.304777759453;9169.449833010041;9188.173064424234;9193.586288617029;9209.17117459432;9224.677136300197;4948.084604348207;4974.651774375759;5000.824971125993;5002.399712034579;5013.248012798036;4439.511653718088;4521.367008618796;4539.727616342964;4543.54564543543;4622.95377046232;3752.962470375261;3824.7513911595656;3827.6411873784964;3830.138218900725;3832.2335532893535;1158.6639874436487;1161.285809227336;1166.102101381931;1173.2549830857467;1173.7417768091177;987.9209663226925;995.7361299255703;1000.7248006798043;1085.9294145880492;1239.9566015189605;7607.125180604301;7632.923670763333;7642.4650274480255;7647.082350118021;7652.120006199359;1238.9380530973594;1286.311823174597;1290.5225066725372;1305.2755720575171;1306.790913453843;5290.365156181206;5301.602379821529;5324.1747529133045;5339.199120131933;5353.598480114007;9463.290253231035;9532.094451027142;9701.417914925127;10100.737407824023;10124.291299608956;9858;9915.206783457306;10020.849687254697;10042.799144017079;10079.143272821892;7685.077790665156;7797.57113358782;7801.882971755428;7826.099998500245;7865.331446826969;7148.142222933281;7171.748988785576;7183.497155199086;7215.639218038972;7228.060352154186;8662.177093176138;8794.472331660121;9091.409058411182;9123.270138389045;9149.496777677292;9016.323775716979;9094.954525227331;9141.725748227564;9222.815543688954;9225.031371705874;6361.522885783677;6640.667966601554;6678.398944094861;6984.895226571707;7041.612711300928;7523.360514356341;7774.572398518136;7795;7812.687492500237;7844.372450203856;7243.963780181065;7284.235155308828;7306.817329566803;7400.222976587381;7527.397808175442;6886.896696549656;6952.304769523007;7219.241979592067;7248.275172482709;7313.780586582411;7444.367228785614;7449.590272534846;7460.962695186489;7494.250574942462;7516.24837516244;6479.708413121515;6484.5460817742305;6508.576942498912;6534.771283005072;6534.83662908412;6176.382361763787;6248.968755156195;6262.655553944577;6269.310375858743;6276.215473065867 20:03:09 INFO - 2016-01-05 20:03:09,674 DEBUG : BROWSER_OUTPUT: |4;prototype.html;368.40134780980907;369.8723940240616;371.29639333463103;371.3056584187569;377.8073182676834;6256.562040657156;6367.713452894619;6375.776847810327;6403.263624683157;6443.194600674909;6189.164462797521;6275.46658534024;6306.936930630693;6320.4943604511645;6349.936500634993;4833.540813622709;4840.903181936359;4879.658423910328;4884.242942343943;4888.315635810972;4911.042346742387;4915.778789954461;4918.754062296889;4919.13915064864;4922.163232250526;4709.5055019223;4839.05638400512;4842.685225460352;4843.104025755247;4855.757212139397;4820.228763397857;4824.155772739757;4824.807007719704;4825.276208568707;4831.589314908237;4202.159568086395;4204.11713540157;4207.43199668044;4211.663066954637;4218.240716670998;5959.612625179349;6014.909776353315;6060.151578778975;6060.2424696912885;6075.33171351151;5616.9157462638095;5621.241132447149;5649.12438572022;5650.547956163538;5653.152027195953;6693.832654183636;6704.094947182117;6725.39471447572;6735.393814556714;6752.93247067528;4672.299155126724;4678.064387122555;4680.134175177569;4683.391159149289;4696.882577935545;6846.349596788297;6938.895916561256;6954.513184077116;6977.197622273402;6982.057422247983;4799.136155491975;4832.830850920201;4834.879128021757;4837.05677392912;4837.153498137812;4891.510848915151;4892.804287828518;4894.486078961729;4897.069556784271;4899.730514821719;5564.972175139098;5658.575606829504;5659.490645841894;5663.575231857545;5664.631798933056;6724.327567243335;6768;6784.626845523445;6785.728570857209;6790.151231096113;1696.6776312500833;1718.458685514059;1740.7911050674;1741.8519425848945;1742.6863164630236;1161.0189389965465;1174.0783484964263;1179.351356753782;1191.0888170549536;1192.5110704611068;6454.806355809334;6502.869942601122;6519.511036672268;6527.804165875032;6541.378569035934;6957.79126626202;6965.791026269118;6976.988336691152;6984.4412447004115;6995.125609298838;6384.648844313514;6478.4169424752;6487.124238227873;6515.185601799775;6539.182602174728;3757.3988161894513;3784.1674831537566;3801.847926082981;3804.068003339144;3806.790626515513;7165.498415110997;7178.712851485987;7211.711531538785;7216.458765592602;7235.493515453868;7125.1093613298335;7148.499605027599;7149.7497587584185;7171.89242161368;7300.123985121713;7360.190379058299;7370.820668693091;7371.152317483558;7379.225181355988;7382.077240344957;7117.3238542338395;7122.679479423335;7126.037984872183;7126.536775109601;7133.928660713534;6868.347506986828;7007.194172670004;7009.649517524205;7019.5788252705;7027.472939529658;7189.424846012411;7245.456590755609;7261.818454538467;7264.854702906018;7356.411487081128;4822.228443449031;4879.926801098058;4888.60891128716;4898.265260210855;4910.06708725341;6956.652167391711;6965.825854353681;7078.716851325889;7092.751753688596;7093.6453177341955;6906.93093069083;6926.06498122747;6928.4803639726215;6944.618046007518;6945.756898508528;6877.415419689382;6903.585784852925;6910.481713871379;6918.584884906922;6918.896216556655;6650.3682150195655;6779.050932869303;6793.72825086991;6802.01370801241;6804.047433359433;6925.099737034153;6936.445084393337;6936.79189624312;6944.270851560514;6950;6642.501812363996;6737.157855268091;6756;6757.358050985148;6758.8648227036165 20:03:09 INFO - 2016-01-05 20:03:09,674 DEBUG : BROWSER_OUTPUT: |5;yui.html;790.5691398187987;793.4208028139458;799.188823344306;806.685392696848;814.8573999550081;13061.216327020386;13219.999999999987;13261.535846245384;13262.801057984138;13299.268540230283;12536.81194782079;12579.056570757184;12608.873911260886;12630.684232894182;13851.93074034631;888.9599968001439;912.2337236721153;913.7030465098836;917.6421195733669;918.5040078357712;903.3631289940577;907.0294784580468;910.1444642036498;911.4531281231275;911.7811725185941;931.1573026411108;948.6158105967095;949.5062567464914;951.8477043673014;955.1212884146602;938.1087966431883;942.4204114469586;943.1323182671958;943.7216021273741;944.4616568555925;694.0491526608579;694.472201127142;696.053367420308;696.1889398850333;696.5959743348845;13017.21896686202;13102.344882755824;13122.671933201651;13160.934195329059;13199.802002969964;11854.170208085437;11951.940240298829;12203.633890983285;12850.594592433014;12962.092653514257;10276.89723102767;10479.895201047968;10517.775189399617;10544.420056896868;10608.15134789215;3691.7600355977042;3745.606711295302;3752.4746535485056;3756.868509602178;3772.1889793694486;48804;48809.75595122002;49331;49561.504384956046;49717.25424118641;9935.354201976848;10095.798084038279;10108.24188185889;10136.442495662663;10226.948865255627;18482.630347392977;18569.628607427774;18709.625807483775;18898.244070237313;19154.52113697169;7822.452428330076;7966.0839003514175;7986.2812346887895;8065.516069035759;8169.42814003026;4449.532799056117;4477.328400739915;4487.125010622897;4529.456465224194;4601.056783359403;3230.5315729219133;3262.6737326267657;3266.6080070391704;3266.836658167082;3275.950860737091;580.6400031980199;591.0779184472151;592.3957563285425;592.6651441935379;600.198734689186;550.686108917913;570.6148349863909;604.0878273806584;630.4074170279922;650.5803756577076;9046.81906361869;9382.5308734563;9388.389754665925;9467.195288400562;9585.760355991017;509.4294390282907;622.8723111762168;641.9037144428373;645.0131299112365;664.8404382948154;3662.359087159736;3838.9232215356096;3920.0395903003377;3926.155876486569;3929.7838618876235;56056;57682.7115864418;57977;58831;58878.41121588815;53573.73213133987;53763;54110;54242;54367;45677.771611142394;45838.31242531365;46477.767611161726;46993;47657.76171119122;7721.189275126256;7757.92242077572;7785.338246249133;7844.21557844211;7966.522008679498;35422.291554169286;36152.27695446129;36585;36708.06335493101;36871.815640921624;43033.13933721371;43057.138857223305;45391.31913021241;47374;47989;9377.953110234404;9569.282303827102;9602.279829012712;9629.711108666752;9751.512424378894;10753.838692419464;10977.890221097687;11038.061764750086;11221.66335009951;11604.361760102938;9415.764605884908;9670.56482458305;9724;9836.508174591385;10348.913364096661;9377.531123443938;9456.479893605643;9466.148046675557;9702.466364350028;9843.704688859345;9356.204722598655;9601.279904007088;9617.2306215504;9724.611015559298;9914.950425247827;8667.566621669017;8758.386912916034;8853.026167121483;8872.911270887209;8902.955485222532;8454.408191426786;8553.95723021381;8596.699115530926;8620.13798620133;8635.568221589021 20:03:09 INFO - 2016-01-05 20:03:09,674 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:03:09 INFO - 2016-01-05 20:03:09,674 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:03:09 INFO - 2016-01-05 20:03:09,675 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,294 20:03:09 INFO - 2016-01-05 20:03:09,675 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:03:09 INFO - 2016-01-05 20:03:09,675 DEBUG : BROWSER_OUTPUT: __startTimestamp1452052989663__endTimestamp 20:03:09 INFO - 2016-01-05 20:03:09,675 DEBUG : BROWSER_OUTPUT: 20:03:09 INFO - 2016-01-05 20:03:09,675 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:03:09 INFO - 2016-01-05 20:03:09,675 DEBUG : BROWSER_OUTPUT: Number of tests: 6 20:03:09 INFO - 2016-01-05 20:03:09,675 DEBUG : BROWSER_OUTPUT: 20:03:09 INFO - 2016-01-05 20:03:09,675 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5570.05 Median:5805.65 stddev:610.50 (10.5%) stddev-sans-first:586.93 20:03:09 INFO - 2016-01-05 20:03:09,676 DEBUG : BROWSER_OUTPUT: Values: 3346.5 3392.1 3403.2 3428.8 3429.4 5438.8 5450.7 5468.8 5487.6 5494.2 5512.7 5553.6 5569.1 5600.4 5614.1 5075.2 5111.7 5157.5 5165.5 5203.5 4936.5 4966.8 5062.3 5077.4 5088.5 5058.6 5112.1 5119.7 5127.0 5168.4 5075.5 5132.8 5140.4 5140.5 5173.9 4869.9 4948.0 5014.9 5047.5 5063.6 5338.3 5360.3 5370.5 5423.7 5428.5 5924.9 5952.3 5965.3 5975.7 5980.6 5763.3 5871.6 6054.5 6057.7 6075.3 5569.5 5574.1 5580.1 5583.6 5608.7 6043.4 6046.7 6050.7 6058.7 6063.3 5629.5 5650.7 5860.4 5874.9 5945.4 6040.2 6051.5 6069.0 6075.9 6099.6 5982.6 6026.7 6026.7 6030.6 6044.4 5757.1 5831.5 5911.7 5991.8 6050.2 4626.6 4646.3 4652.4 4667.6 4693.3 4159.5 4169.8 4170.7 4179.5 4208.9 5489.1 5561.8 5655.3 5740.7 5805.7 6039.8 6066.6 6068.2 6076.5 6077.5 5500.3 5646.0 5704.4 5706.6 5725.0 5210.1 5243.0 5284.5 5291.2 5294.5 6156.0 6197.3 6202.6 6213.4 6223.5 5729.4 5838.5 6035.0 6059.5 6066.5 6135.3 6192.3 6244.9 6247.5 6247.8 5944.1 5970.6 5981.3 6011.3 6033.4 5868.3 5995.9 6033.6 6108.7 6124.0 5872.2 5917.5 5917.5 5928.6 5938.5 5861.1 5878.3 5908.7 5909.8 5933.3 5532.4 5614.5 5797.4 5813.5 5951.3 5932.4 5991.3 5996.2 5999.5 6010.1 5816.1 5835.7 5851.8 5856.8 5872.0 20:03:09 INFO - 2016-01-05 20:03:09,676 DEBUG : BROWSER_OUTPUT: 20:03:09 INFO - 2016-01-05 20:03:09,676 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:50957.54 Median:38696.61 stddev:95265.03 (246.2%) stddev-sans-first:95457.23 20:03:09 INFO - 2016-01-05 20:03:09,677 DEBUG : BROWSER_OUTPUT: Values: 593.9 635.0 641.0 644.7 664.4 32745.3 41028.6 41056.4 41167.8 41246.0 46537.8 46719.8 46726.8 46972.5 47155.1 8906.5 9065.5 9090.0 9090.5 9105.6 8988.6 9122.5 9137.7 9141.7 9145.8 9103.0 9158.2 9177.7 9182.1 9196.0 9040.3 9050.8 9091.8 9106.1 9119.8 9020.5 9191.8 9194.7 9198.0 9208.0 43488.6 43491.6 43583.0 43783.3 43817.6 3283.1 3304.5 3343.3 3387.9 3613.9 32239.7 32503.5 32584.8 32714.2 32840.0 3612.2 3730.9 3770.9 3797.9 3828.2 285438.0 288959.0 289232.0 289590.0 290208.0 45678.3 62083.4 62131.4 62248.0 62463.7 43791.6 43989.8 44080.3 44094.6 44332.0 14914.3 14929.9 14967.2 15001.4 15009.8 13365.1 13375.5 13383.4 13401.2 13497.0 14977.5 15203.9 15461.1 15485.4 15610.8 6112.8 6228.5 6240.5 6276.7 6372.8 1021.5 1036.9 1039.2 1052.4 1099.2 28979.7 29114.3 29345.3 29446.7 29533.9 1051.0 1066.8 1067.1 1078.2 1125.0 14530.3 14843.8 14975.0 15219.8 15489.8 301959.0 303608.0 303969.0 342091.0 790689.0 57501.0 57950.0 58104.0 58229.4 58321.0 1504.3 1519.9 1523.5 1530.2 1545.3 30887.0 31244.7 31537.5 31592.7 31840.7 49486.0 49658.3 49966.3 50285.7 50516.7 314221.0 315141.0 316286.0 317512.0 317598.0 35709.6 36087.0 36214.0 36637.5 36748.0 45123.3 46011.1 47005.3 47171.8 47267.5 39996.2 39997.4 40171.2 40739.4 41052.2 39715.6 40116.8 40413.4 41070.8 41115.2 38519.6 38873.6 39012.6 39146.4 39648.0 34629.0 34974.3 35139.8 35343.8 35464.3 26587.9 26992.2 27278.2 27335.7 27892.7 20:03:09 INFO - 2016-01-05 20:03:09,677 DEBUG : BROWSER_OUTPUT: 20:03:09 INFO - 2016-01-05 20:03:09,677 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31230.46 Median:12149.22 stddev:101319.00 (834.0%) stddev-sans-first:101576.74 20:03:09 INFO - 2016-01-05 20:03:09,677 DEBUG : BROWSER_OUTPUT: Values: 378.2 382.4 382.7 392.6 397.9 15206.8 15222.8 16416.7 18863.3 19427.7 11475.6 13970.6 15605.4 16759.2 16843.4 5010.4 5115.9 5120.5 5130.3 5132.2 4228.1 5201.9 5204.7 5252.7 5258.0 5614.9 5621.2 5638.1 5657.5 5672.0 5200.7 5326.4 5644.9 5663.1 5663.7 4985.1 4986.6 5008.4 5011.8 5016.5 13901.6 15831.1 16397.8 21993.2 21999.1 2299.3 2313.3 2380.1 2394.5 2410.0 10120.5 10480.9 11061.6 13635.3 14403.1 1836.5 1884.0 1927.6 1981.5 2011.8 58515.7 58855.0 59279.1 59365.7 64572.0 10293.7 10902.2 11153.9 11226.0 11237.2 14382.4 14800.1 14940.0 14971.0 14991.0 8400.8 8601.1 8741.0 8751.2 8779.1 8079.2 8080.4 8091.6 8164.3 8193.3 4743.0 4754.0 4764.8 4820.8 4842.0 1866.9 1969.0 1994.0 2016.4 2017.9 955.2 959.1 979.9 1003.0 1058.8 16333.0 16480.9 17188.4 17368.0 17566.0 903.6 953.5 957.7 971.1 1014.2 9041.7 9495.5 9519.9 9564.8 9727.2 601275.0 606858.0 613579.0 633776.0 646341.0 81081.6 83098.6 83289.6 86966.6 87587.6 1214.9 1222.8 1226.6 1227.6 1230.7 14939.4 14962.7 14985.1 15092.5 15329.5 32444.5 32531.2 32710.7 33919.3 35497.8 43235.1 44807.0 45059.5 46311.0 46576.5 9608.5 9951.6 10070.3 10092.4 10097.9 11676.1 16522.3 16842.5 16884.0 17631.2 13779.9 13903.1 13948.7 14145.3 14191.9 13840.4 14044.8 14263.1 14285.1 14719.5 14774.8 14833.1 14920.9 15129.6 15157.2 10196.1 10244.6 10291.5 10299.4 10592.1 14317.8 14472.4 14509.9 14606.8 14708.8 20:03:09 INFO - 2016-01-05 20:03:09,678 DEBUG : BROWSER_OUTPUT: 20:03:09 INFO - 2016-01-05 20:03:09,678 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5650.31 Median:6212.68 stddev:2948.24 (47.5%) stddev-sans-first:2938.97 20:03:09 INFO - 2016-01-05 20:03:09,679 DEBUG : BROWSER_OUTPUT: Values: 1372.4 1433.4 1605.2 1704.2 1846.0 7183.4 7329.8 7907.9 8340.7 8397.2 7664.5 7863.0 7931.2 8193.3 8207.4 2373.3 2391.4 2398.3 2404.9 2409.8 2394.7 2439.3 2471.8 2485.6 2486.3 2321.4 2329.1 2335.1 2357.8 2365.4 2335.8 2368.1 2390.0 2394.8 2400.0 2333.3 2342.1 2360.3 2375.1 2384.6 8198.1 8250.5 8256.9 8258.6 8269.8 4878.0 4914.9 4929.5 4931.9 4964.4 3138.4 3142.4 3161.6 3172.0 3258.4 979.2 996.8 998.8 1022.5 1037.8 11151.9 11230.1 11266.4 11277.8 11279.9 4386.3 4403.8 4423.7 4476.4 4485.3 9169.4 9188.2 9193.6 9209.2 9224.7 4948.1 4974.7 5000.8 5002.4 5013.2 4439.5 4521.4 4539.7 4543.5 4623.0 3753.0 3824.8 3827.6 3830.1 3832.2 1158.7 1161.3 1166.1 1173.3 1173.7 987.9 995.7 1000.7 1085.9 1240.0 7607.1 7632.9 7642.5 7647.1 7652.1 1238.9 1286.3 1290.5 1305.3 1306.8 5290.4 5301.6 5324.2 5339.2 5353.6 9463.3 9532.1 9701.4 10100.7 10124.3 9858.0 9915.2 10020.8 10042.8 10079.1 7685.1 7797.6 7801.9 7826.1 7865.3 7148.1 7171.7 7183.5 7215.6 7228.1 8662.2 8794.5 9091.4 9123.3 9149.5 9016.3 9095.0 9141.7 9222.8 9225.0 6361.5 6640.7 6678.4 6984.9 7041.6 7523.4 7774.6 7795.0 7812.7 7844.4 7244.0 7284.2 7306.8 7400.2 7527.4 6886.9 6952.3 7219.2 7248.3 7313.8 7444.4 7449.6 7461.0 7494.3 7516.2 6479.7 6484.5 6508.6 6534.8 6534.8 6176.4 6249.0 6262.7 6269.3 6276.2 20:03:09 INFO - 2016-01-05 20:03:09,679 DEBUG : BROWSER_OUTPUT: 20:03:09 INFO - 2016-01-05 20:03:09,679 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5688.85 Median:6449.00 stddev:1719.69 (26.7%) stddev-sans-first:1677.50 20:03:09 INFO - 2016-01-05 20:03:09,679 DEBUG : BROWSER_OUTPUT: Values: 368.4 369.9 371.3 371.3 377.8 6256.6 6367.7 6375.8 6403.3 6443.2 6189.2 6275.5 6306.9 6320.5 6349.9 4833.5 4840.9 4879.7 4884.2 4888.3 4911.0 4915.8 4918.8 4919.1 4922.2 4709.5 4839.1 4842.7 4843.1 4855.8 4820.2 4824.2 4824.8 4825.3 4831.6 4202.2 4204.1 4207.4 4211.7 4218.2 5959.6 6014.9 6060.2 6060.2 6075.3 5616.9 5621.2 5649.1 5650.5 5653.2 6693.8 6704.1 6725.4 6735.4 6752.9 4672.3 4678.1 4680.1 4683.4 4696.9 6846.3 6938.9 6954.5 6977.2 6982.1 4799.1 4832.8 4834.9 4837.1 4837.2 4891.5 4892.8 4894.5 4897.1 4899.7 5565.0 5658.6 5659.5 5663.6 5664.6 6724.3 6768.0 6784.6 6785.7 6790.2 1696.7 1718.5 1740.8 1741.9 1742.7 1161.0 1174.1 1179.4 1191.1 1192.5 6454.8 6502.9 6519.5 6527.8 6541.4 6957.8 6965.8 6977.0 6984.4 6995.1 6384.6 6478.4 6487.1 6515.2 6539.2 3757.4 3784.2 3801.8 3804.1 3806.8 7165.5 7178.7 7211.7 7216.5 7235.5 7125.1 7148.5 7149.7 7171.9 7300.1 7360.2 7370.8 7371.2 7379.2 7382.1 7117.3 7122.7 7126.0 7126.5 7133.9 6868.3 7007.2 7009.6 7019.6 7027.5 7189.4 7245.5 7261.8 7264.9 7356.4 4822.2 4879.9 4888.6 4898.3 4910.1 6956.7 6965.8 7078.7 7092.8 7093.6 6906.9 6926.1 6928.5 6944.6 6945.8 6877.4 6903.6 6910.5 6918.6 6918.9 6650.4 6779.1 6793.7 6802.0 6804.0 6925.1 6936.4 6936.8 6944.3 6950.0 6642.5 6737.2 6756.0 6757.4 6758.9 20:03:09 INFO - 2016-01-05 20:03:09,679 DEBUG : BROWSER_OUTPUT: 20:03:09 INFO - 2016-01-05 20:03:09,679 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13748.81 Median:29278.82 stddev:16370.43 (55.9%) stddev-sans-first:16387.43 20:03:09 INFO - 2016-01-05 20:03:09,680 DEBUG : BROWSER_OUTPUT: Values: 790.6 793.4 799.2 806.7 814.9 13061.2 13220.0 13261.5 13262.8 13299.3 12536.8 12579.1 12608.9 12630.7 13851.9 889.0 912.2 913.7 917.6 918.5 903.4 907.0 910.1 911.5 911.8 931.2 948.6 949.5 951.8 955.1 938.1 942.4 943.1 943.7 944.5 694.0 694.5 696.1 696.2 696.6 13017.2 13102.3 13122.7 13160.9 13199.8 11854.2 11951.9 12203.6 12850.6 12962.1 10276.9 10479.9 10517.8 10544.4 10608.2 3691.8 3745.6 3752.5 3756.9 3772.2 48804.0 48809.8 49331.0 49561.5 49717.3 9935.4 10095.8 10108.2 10136.4 10226.9 18482.6 18569.6 18709.6 18898.2 19154.5 7822.5 7966.1 7986.3 8065.5 8169.4 4449.5 4477.3 4487.1 4529.5 4601.1 3230.5 3262.7 3266.6 3266.8 3276.0 580.6 591.1 592.4 592.7 600.2 550.7 570.6 604.1 630.4 650.6 9046.8 9382.5 9388.4 9467.2 9585.8 509.4 622.9 641.9 645.0 664.8 3662.4 3838.9 3920.0 3926.2 3929.8 56056.0 57682.7 57977.0 58831.0 58878.4 53573.7 53763.0 54110.0 54242.0 54367.0 45677.8 45838.3 46477.8 46993.0 47657.8 7721.2 7757.9 7785.3 7844.2 7966.5 35422.3 36152.3 36585.0 36708.1 36871.8 43033.1 43057.1 45391.3 47374.0 47989.0 9378.0 9569.3 9602.3 9629.7 9751.5 10753.8 10977.9 11038.1 11221.7 11604.4 9415.8 9670.6 9724.0 9836.5 10348.9 9377.5 9456.5 9466.1 9702.5 9843.7 9356.2 9601.3 9617.2 9724.6 9915.0 8667.6 8758.4 8853.0 8872.9 8903.0 8454.4 8554.0 8596.7 8620.1 8635.6 20:03:09 INFO - 2016-01-05 20:03:09,680 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:03:09 INFO - 2016-01-05 20:03:09,680 DEBUG : BROWSER_OUTPUT: 20:03:10 INFO - 2016-01-05 20:03:10,381 INFO : Browser exited with error code: 0 20:03:10 INFO - 2016-01-05 20:03:10,400 INFO : Completed test dromaeo_css (00:18:28) 20:03:10 INFO - 2016-01-05 20:03:10,400 INFO : Starting test kraken 20:03:10 INFO - 2016-01-05 20:03:10,400 DEBUG : operating with platform_type : linux_ 20:03:10 INFO - 2016-01-05 20:03:10,400 INFO : Initialising browser for kraken test... 20:03:10 INFO - 2016-01-05 20:03:10,407 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGZUzrB/profile http://localhost:34703/getInfo.html 20:03:14 INFO - 2016-01-05 20:03:14,731 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:03:14 INFO - 2016-01-05 20:03:14,731 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:03:14 INFO - 2016-01-05 20:03:14,731 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:03:14 INFO - 2016-01-05 20:03:14,732 DEBUG : BROWSER_OUTPUT: __metrics 20:03:15 INFO - 2016-01-05 20:03:15,713 INFO : Browser initialized. 20:03:15 INFO - 2016-01-05 20:03:15,714 INFO : Running cycle 1/1 for kraken test... 20:03:15 INFO - 2016-01-05 20:03:15,714 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGZUzrB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:03:27 INFO - 2016-01-05 20:03:27,552 DEBUG : BROWSER_OUTPUT: RSS: Main: 136753152 20:03:27 INFO - 2016-01-05 20:03:27,552 DEBUG : BROWSER_OUTPUT: 20:03:30 INFO - 2016-01-05 20:03:30,013 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34703/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34703/tests/kraken/driver.html?testName=audio-beat-detection) 20:03:30 INFO - 2016-01-05 20:03:30,615 DEBUG : BROWSER_OUTPUT: RSS: Main: 138964992 20:03:30 INFO - 2016-01-05 20:03:30,616 DEBUG : BROWSER_OUTPUT: 20:03:33 INFO - 2016-01-05 20:03:33,218 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34703/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34703/tests/kraken/driver.html?testName=audio-dft) 20:03:33 INFO - 2016-01-05 20:03:33,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 137723904 20:03:33 INFO - 2016-01-05 20:03:33,820 DEBUG : BROWSER_OUTPUT: 20:03:36 INFO - 2016-01-05 20:03:36,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34703/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34703/tests/kraken/driver.html?testName=audio-fft) 20:03:37 INFO - 2016-01-05 20:03:37,221 DEBUG : BROWSER_OUTPUT: RSS: Main: 138817536 20:03:37 INFO - 2016-01-05 20:03:37,221 DEBUG : BROWSER_OUTPUT: 20:03:39 INFO - 2016-01-05 20:03:39,238 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34703/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34703/tests/kraken/driver.html?testName=audio-oscillator) 20:03:39 INFO - 2016-01-05 20:03:39,832 DEBUG : BROWSER_OUTPUT: RSS: Main: 139366400 20:03:39 INFO - 2016-01-05 20:03:39,832 DEBUG : BROWSER_OUTPUT: 20:03:42 INFO - 2016-01-05 20:03:42,050 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34703/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34703/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:03:42 INFO - 2016-01-05 20:03:42,624 DEBUG : BROWSER_OUTPUT: RSS: Main: 138510336 20:03:42 INFO - 2016-01-05 20:03:42,624 DEBUG : BROWSER_OUTPUT: 20:03:45 INFO - 2016-01-05 20:03:45,583 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34703/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34703/tests/kraken/driver.html?testName=imaging-darkroom) 20:03:46 INFO - 2016-01-05 20:03:46,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 137371648 20:03:46 INFO - 2016-01-05 20:03:46,166 DEBUG : BROWSER_OUTPUT: 20:03:49 INFO - 2016-01-05 20:03:49,473 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34703/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34703/tests/kraken/driver.html?testName=imaging-desaturate) 20:03:50 INFO - 2016-01-05 20:03:50,066 DEBUG : BROWSER_OUTPUT: RSS: Main: 138190848 20:03:50 INFO - 2016-01-05 20:03:50,067 DEBUG : BROWSER_OUTPUT: 20:03:52 INFO - 2016-01-05 20:03:52,826 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34703/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34703/tests/kraken/driver.html?testName=json-parse-financial) 20:03:53 INFO - 2016-01-05 20:03:53,432 DEBUG : BROWSER_OUTPUT: RSS: Main: 138145792 20:03:53 INFO - 2016-01-05 20:03:53,432 DEBUG : BROWSER_OUTPUT: 20:03:55 INFO - 2016-01-05 20:03:55,025 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34703/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34703/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:03:55 INFO - 2016-01-05 20:03:55,606 DEBUG : BROWSER_OUTPUT: RSS: Main: 138661888 20:03:55 INFO - 2016-01-05 20:03:55,606 DEBUG : BROWSER_OUTPUT: 20:03:57 INFO - 2016-01-05 20:03:57,361 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34703/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34703/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:03:57 INFO - 2016-01-05 20:03:57,975 DEBUG : BROWSER_OUTPUT: RSS: Main: 138371072 20:03:57 INFO - 2016-01-05 20:03:57,975 DEBUG : BROWSER_OUTPUT: 20:04:00 INFO - 2016-01-05 20:04:00,034 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34703/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34703/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:04:00 INFO - 2016-01-05 20:04:00,620 DEBUG : BROWSER_OUTPUT: RSS: Main: 140075008 20:04:00 INFO - 2016-01-05 20:04:00,621 DEBUG : BROWSER_OUTPUT: 20:04:03 INFO - 2016-01-05 20:04:03,023 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34703/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34703/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:04:03 INFO - 2016-01-05 20:04:03,625 DEBUG : BROWSER_OUTPUT: RSS: Main: 139223040 20:04:03 INFO - 2016-01-05 20:04:03,625 DEBUG : BROWSER_OUTPUT: 20:04:06 INFO - 2016-01-05 20:04:06,140 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34703/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34703/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:04:06 INFO - 2016-01-05 20:04:06,728 DEBUG : BROWSER_OUTPUT: RSS: Main: 139190272 20:04:06 INFO - 2016-01-05 20:04:06,728 DEBUG : BROWSER_OUTPUT: 20:04:08 INFO - 2016-01-05 20:04:08,378 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34703/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34703/tests/kraken/driver.html?testName=ai-astar) 20:04:08 INFO - 2016-01-05 20:04:08,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 140115968 20:04:08 INFO - 2016-01-05 20:04:08,629 DEBUG : BROWSER_OUTPUT: 20:04:08 INFO - 2016-01-05 20:04:08,630 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:04:08 INFO - 2016-01-05 20:04:08,630 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:04:08 INFO - 2016-01-05 20:04:08,630 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:04:08 INFO - 2016-01-05 20:04:08,631 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:04:08 INFO - 2016-01-05 20:04:08,631 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;106;112;111;112;121;111;112;114;113 20:04:08 INFO - 2016-01-05 20:04:08,631 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;127;154;158;124;150;152;130;161;125 20:04:08 INFO - 2016-01-05 20:04:08,632 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;163;163;162;162;162;163;161;165;162 20:04:08 INFO - 2016-01-05 20:04:08,632 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;74;73;171;78;72;72;71;153;73 20:04:08 INFO - 2016-01-05 20:04:08,632 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;94;135;94;93;92;137;93;93;142 20:04:08 INFO - 2016-01-05 20:04:08,632 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;110;110;110;110;110;110;110 20:04:08 INFO - 2016-01-05 20:04:08,633 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;145;146;147;148;149;147;146;147 20:04:08 INFO - 2016-01-05 20:04:08,633 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;96;96;96;97;99;96;95 20:04:08 INFO - 2016-01-05 20:04:08,633 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;60;59;59;59;61;60;60;59;58 20:04:08 INFO - 2016-01-05 20:04:08,633 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;66;64;64;64;65;64;64;64 20:04:08 INFO - 2016-01-05 20:04:08,633 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;81;81;82;83;83;81;89;89;82 20:04:08 INFO - 2016-01-05 20:04:08,633 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;110;120;112;124;123;122;118;116;117 20:04:08 INFO - 2016-01-05 20:04:08,633 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;146;147;149;145;144;137;145;145;145 20:04:08 INFO - 2016-01-05 20:04:08,634 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;68;67;64;65;66;67;65;65;66 20:04:08 INFO - 2016-01-05 20:04:08,634 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:04:08 INFO - 2016-01-05 20:04:08,634 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:04:08 INFO - 2016-01-05 20:04:08,634 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,716 20:04:08 INFO - 2016-01-05 20:04:08,634 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:04:08 INFO - 2016-01-05 20:04:08,634 DEBUG : BROWSER_OUTPUT: __startTimestamp1452053048629__endTimestamp 20:04:08 INFO - 2016-01-05 20:04:08,634 DEBUG : BROWSER_OUTPUT: 20:04:08 INFO - 2016-01-05 20:04:08,638 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:04:08 INFO - 2016-01-05 20:04:08,638 DEBUG : BROWSER_OUTPUT: Number of tests: 14 20:04:08 INFO - 2016-01-05 20:04:08,638 DEBUG : BROWSER_OUTPUT: 20:04:08 INFO - 2016-01-05 20:04:08,638 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:3.71 (3.3%) stddev-sans-first:3.91 20:04:08 INFO - 2016-01-05 20:04:08,638 DEBUG : BROWSER_OUTPUT: Values: 111.0 106.0 112.0 111.0 112.0 121.0 111.0 112.0 114.0 113.0 20:04:08 INFO - 2016-01-05 20:04:08,639 DEBUG : BROWSER_OUTPUT: 20:04:08 INFO - 2016-01-05 20:04:08,639 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.90 Median:151.00 stddev:14.66 (9.7%) stddev-sans-first:15.44 20:04:08 INFO - 2016-01-05 20:04:08,639 DEBUG : BROWSER_OUTPUT: Values: 148.0 127.0 154.0 158.0 124.0 150.0 152.0 130.0 161.0 125.0 20:04:08 INFO - 2016-01-05 20:04:08,639 DEBUG : BROWSER_OUTPUT: 20:04:08 INFO - 2016-01-05 20:04:08,639 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:1.17 (0.7%) stddev-sans-first:1.13 20:04:08 INFO - 2016-01-05 20:04:08,639 DEBUG : BROWSER_OUTPUT: Values: 161.0 163.0 163.0 162.0 162.0 162.0 163.0 161.0 165.0 162.0 20:04:08 INFO - 2016-01-05 20:04:08,640 DEBUG : BROWSER_OUTPUT: 20:04:08 INFO - 2016-01-05 20:04:08,640 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:91.10 Median:73.00 stddev:37.65 (51.6%) stddev-sans-first:39.43 20:04:08 INFO - 2016-01-05 20:04:08,640 DEBUG : BROWSER_OUTPUT: Values: 74.0 74.0 73.0 171.0 78.0 72.0 72.0 71.0 153.0 73.0 20:04:08 INFO - 2016-01-05 20:04:08,640 DEBUG : BROWSER_OUTPUT: 20:04:08 INFO - 2016-01-05 20:04:08,640 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.60 Median:93.00 stddev:21.74 (23.4%) stddev-sans-first:22.50 20:04:08 INFO - 2016-01-05 20:04:08,640 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 135.0 94.0 93.0 92.0 137.0 93.0 93.0 142.0 20:04:08 INFO - 2016-01-05 20:04:08,641 DEBUG : BROWSER_OUTPUT: 20:04:08 INFO - 2016-01-05 20:04:08,641 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:04:08 INFO - 2016-01-05 20:04:08,641 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 20:04:08 INFO - 2016-01-05 20:04:08,641 DEBUG : BROWSER_OUTPUT: 20:04:08 INFO - 2016-01-05 20:04:08,641 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 20:04:08 INFO - 2016-01-05 20:04:08,641 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 145.0 146.0 147.0 148.0 149.0 147.0 146.0 147.0 20:04:08 INFO - 2016-01-05 20:04:08,641 DEBUG : BROWSER_OUTPUT: 20:04:08 INFO - 2016-01-05 20:04:08,641 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:1.14 (1.2%) stddev-sans-first:1.20 20:04:08 INFO - 2016-01-05 20:04:08,642 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 96.0 96.0 96.0 97.0 99.0 96.0 95.0 20:04:08 INFO - 2016-01-05 20:04:08,642 DEBUG : BROWSER_OUTPUT: 20:04:08 INFO - 2016-01-05 20:04:08,642 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.20 Median:59.50 stddev:1.14 (1.9%) stddev-sans-first:0.88 20:04:08 INFO - 2016-01-05 20:04:08,642 DEBUG : BROWSER_OUTPUT: Values: 57.0 60.0 59.0 59.0 59.0 61.0 60.0 60.0 59.0 58.0 20:04:08 INFO - 2016-01-05 20:04:08,642 DEBUG : BROWSER_OUTPUT: 20:04:08 INFO - 2016-01-05 20:04:08,642 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.79 (1.2%) stddev-sans-first:0.71 20:04:08 INFO - 2016-01-05 20:04:08,642 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 66.0 64.0 64.0 64.0 65.0 64.0 64.0 64.0 20:04:08 INFO - 2016-01-05 20:04:08,642 DEBUG : BROWSER_OUTPUT: 20:04:08 INFO - 2016-01-05 20:04:08,642 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:82.50 stddev:3.09 (3.7%) stddev-sans-first:3.24 20:04:08 INFO - 2016-01-05 20:04:08,642 DEBUG : BROWSER_OUTPUT: Values: 82.0 81.0 81.0 82.0 83.0 83.0 81.0 89.0 89.0 82.0 20:04:08 INFO - 2016-01-05 20:04:08,642 DEBUG : BROWSER_OUTPUT: 20:04:08 INFO - 2016-01-05 20:04:08,642 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.30 Median:120.50 stddev:4.64 (3.9%) stddev-sans-first:4.82 20:04:08 INFO - 2016-01-05 20:04:08,642 DEBUG : BROWSER_OUTPUT: Values: 121.0 110.0 120.0 112.0 124.0 123.0 122.0 118.0 116.0 117.0 20:04:08 INFO - 2016-01-05 20:04:08,643 DEBUG : BROWSER_OUTPUT: 20:04:08 INFO - 2016-01-05 20:04:08,643 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.90 Median:145.50 stddev:3.11 (2.1%) stddev-sans-first:3.27 20:04:08 INFO - 2016-01-05 20:04:08,643 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 147.0 149.0 145.0 144.0 137.0 145.0 145.0 145.0 20:04:08 INFO - 2016-01-05 20:04:08,643 DEBUG : BROWSER_OUTPUT: 20:04:08 INFO - 2016-01-05 20:04:08,643 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.50 stddev:1.25 (1.9%) stddev-sans-first:1.27 20:04:08 INFO - 2016-01-05 20:04:08,643 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 67.0 64.0 65.0 66.0 67.0 65.0 65.0 66.0 20:04:08 INFO - 2016-01-05 20:04:08,643 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:04:08 INFO - 2016-01-05 20:04:08,643 DEBUG : BROWSER_OUTPUT: 20:04:09 INFO - 2016-01-05 20:04:09,485 INFO : Browser exited with error code: 0 20:04:09 INFO - 2016-01-05 20:04:09,578 INFO : Completed test kraken (00:00:59) 20:04:09 INFO - 2016-01-05 20:04:09,578 INFO : Starting test v8_7 20:04:09 INFO - 2016-01-05 20:04:09,578 DEBUG : operating with platform_type : linux_ 20:04:09 INFO - 2016-01-05 20:04:09,578 INFO : Initialising browser for v8_7 test... 20:04:09 INFO - 2016-01-05 20:04:09,584 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaGO5Ds/profile http://localhost:34703/getInfo.html 20:04:13 INFO - 2016-01-05 20:04:13,927 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:04:13 INFO - 2016-01-05 20:04:13,927 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:04:13 INFO - 2016-01-05 20:04:13,928 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:04:13 INFO - 2016-01-05 20:04:13,928 DEBUG : BROWSER_OUTPUT: __metrics 20:04:14 INFO - 2016-01-05 20:04:14,889 INFO : Browser initialized. 20:04:14 INFO - 2016-01-05 20:04:14,890 INFO : Running cycle 1/1 for v8_7 test... 20:04:14 INFO - 2016-01-05 20:04:14,890 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaGO5Ds/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:04:26 INFO - 2016-01-05 20:04:26,559 DEBUG : BROWSER_OUTPUT: RSS: Main: 136556544 20:04:26 INFO - 2016-01-05 20:04:26,559 DEBUG : BROWSER_OUTPUT: 20:04:47 INFO - 2016-01-05 20:04:47,926 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34703/tests/v8_7/run.html (next: http://localhost:34703/tests/v8_7/run.html) 20:04:48 INFO - 2016-01-05 20:04:48,184 DEBUG : BROWSER_OUTPUT: RSS: Main: 136228864 20:04:48 INFO - 2016-01-05 20:04:48,184 DEBUG : BROWSER_OUTPUT: 20:04:48 INFO - 2016-01-05 20:04:48,184 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:04:48 INFO - 2016-01-05 20:04:48,185 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:04:48 INFO - 2016-01-05 20:04:48,185 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:04:48 INFO - 2016-01-05 20:04:48,185 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:04:48 INFO - 2016-01-05 20:04:48,185 DEBUG : BROWSER_OUTPUT: |0;Richards;165.59032952475576 20:04:48 INFO - 2016-01-05 20:04:48,185 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;172.89073305670817 20:04:48 INFO - 2016-01-05 20:04:48,185 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.08676307007784 20:04:48 INFO - 2016-01-05 20:04:48,185 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5170.103092783505 20:04:48 INFO - 2016-01-05 20:04:48,186 DEBUG : BROWSER_OUTPUT: |4;RayTrace;902.5270758122743 20:04:48 INFO - 2016-01-05 20:04:48,186 DEBUG : BROWSER_OUTPUT: |5;Earley;550.9641873278237 20:04:48 INFO - 2016-01-05 20:04:48,186 DEBUG : BROWSER_OUTPUT: |6;Boyer;11087.912087912087 20:04:48 INFO - 2016-01-05 20:04:48,186 DEBUG : BROWSER_OUTPUT: |7;RegExp;25075 20:04:48 INFO - 2016-01-05 20:04:48,186 DEBUG : BROWSER_OUTPUT: |8;Splay;510.39026862645716 20:04:48 INFO - 2016-01-05 20:04:48,186 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 20:04:48 INFO - 2016-01-05 20:04:48,186 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:04:48 INFO - 2016-01-05 20:04:48,186 DEBUG : BROWSER_OUTPUT: __startTimestamp1452053088177__endTimestamp 20:04:48 INFO - 2016-01-05 20:04:48,187 DEBUG : BROWSER_OUTPUT: 20:04:48 INFO - 2016-01-05 20:04:48,187 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:04:48 INFO - 2016-01-05 20:04:48,187 DEBUG : BROWSER_OUTPUT: Number of tests: 10 20:04:48 INFO - 2016-01-05 20:04:48,187 DEBUG : BROWSER_OUTPUT: 20:04:48 INFO - 2016-01-05 20:04:48,187 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.59 Median:165.59 stddev:0.00 (0.0%) 20:04:48 INFO - 2016-01-05 20:04:48,187 DEBUG : BROWSER_OUTPUT: Values: 165.6 20:04:48 INFO - 2016-01-05 20:04:48,187 DEBUG : BROWSER_OUTPUT: 20:04:48 INFO - 2016-01-05 20:04:48,188 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:172.89 Median:172.89 stddev:0.00 (0.0%) 20:04:48 INFO - 2016-01-05 20:04:48,188 DEBUG : BROWSER_OUTPUT: Values: 172.9 20:04:48 INFO - 2016-01-05 20:04:48,188 DEBUG : BROWSER_OUTPUT: 20:04:48 INFO - 2016-01-05 20:04:48,188 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.09 Median:278.09 stddev:0.00 (0.0%) 20:04:48 INFO - 2016-01-05 20:04:48,188 DEBUG : BROWSER_OUTPUT: Values: 278.1 20:04:48 INFO - 2016-01-05 20:04:48,188 DEBUG : BROWSER_OUTPUT: 20:04:48 INFO - 2016-01-05 20:04:48,188 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 20:04:48 INFO - 2016-01-05 20:04:48,188 DEBUG : BROWSER_OUTPUT: Values: 5170.1 20:04:48 INFO - 2016-01-05 20:04:48,189 DEBUG : BROWSER_OUTPUT: 20:04:48 INFO - 2016-01-05 20:04:48,189 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:902.53 Median:902.53 stddev:0.00 (0.0%) 20:04:48 INFO - 2016-01-05 20:04:48,189 DEBUG : BROWSER_OUTPUT: Values: 902.5 20:04:48 INFO - 2016-01-05 20:04:48,189 DEBUG : BROWSER_OUTPUT: 20:04:48 INFO - 2016-01-05 20:04:48,189 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:550.96 Median:550.96 stddev:0.00 (0.0%) 20:04:48 INFO - 2016-01-05 20:04:48,189 DEBUG : BROWSER_OUTPUT: Values: 551.0 20:04:48 INFO - 2016-01-05 20:04:48,190 DEBUG : BROWSER_OUTPUT: 20:04:48 INFO - 2016-01-05 20:04:48,190 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11087.91 Median:11087.91 stddev:0.00 (0.0%) 20:04:48 INFO - 2016-01-05 20:04:48,190 DEBUG : BROWSER_OUTPUT: Values: 11087.9 20:04:48 INFO - 2016-01-05 20:04:48,190 DEBUG : BROWSER_OUTPUT: 20:04:48 INFO - 2016-01-05 20:04:48,190 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25075.00 Median:25075.00 stddev:0.00 (0.0%) 20:04:48 INFO - 2016-01-05 20:04:48,190 DEBUG : BROWSER_OUTPUT: Values: 25075.0 20:04:48 INFO - 2016-01-05 20:04:48,190 DEBUG : BROWSER_OUTPUT: 20:04:48 INFO - 2016-01-05 20:04:48,190 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:510.39 Median:510.39 stddev:0.00 (0.0%) 20:04:48 INFO - 2016-01-05 20:04:48,191 DEBUG : BROWSER_OUTPUT: Values: 510.4 20:04:48 INFO - 2016-01-05 20:04:48,191 DEBUG : BROWSER_OUTPUT: 20:04:48 INFO - 2016-01-05 20:04:48,191 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 20:04:48 INFO - 2016-01-05 20:04:48,191 DEBUG : BROWSER_OUTPUT: Values: 4835.7 20:04:48 INFO - 2016-01-05 20:04:48,191 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:04:48 INFO - 2016-01-05 20:04:48,191 DEBUG : BROWSER_OUTPUT: 20:04:49 INFO - 2016-01-05 20:04:49,006 INFO : Browser exited with error code: 0 20:04:49 INFO - 2016-01-05 20:04:49,022 INFO : Completed test v8_7 (00:00:39) 20:04:49 INFO - 2016-01-05 20:04:49,238 INFO : Completed test suite (00:20:06) 20:04:49 INFO - 2016-01-05 20:04:49,239 DEBUG : Working with test: dromaeo_css 20:04:49 INFO - 2016-01-05 20:04:49,239 DEBUG : Generating results file: dromaeo_css 20:04:49 INFO - 2016-01-05 20:04:49,240 DEBUG : Working with test: kraken 20:04:49 INFO - 2016-01-05 20:04:49,240 DEBUG : Generating results file: kraken 20:04:49 INFO - 2016-01-05 20:04:49,240 INFO : javascript benchmark 20:04:49 INFO - 2016-01-05 20:04:49,240 DEBUG : Working with test: v8_7 20:04:49 INFO - 2016-01-05 20:04:49,241 DEBUG : Generating results file: v8_7 20:04:49 INFO - 2016-01-05 20:04:49,241 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:04:49 INFO - 2016-01-05 20:04:49,301 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 20:04:49 INFO - 2016-01-05 20:04:49,301 DEBUG : process_Request line: dromaeo_css 7253.35 graph.html#tests=[[72,52,43]] 20:04:49 INFO - 2016-01-05 20:04:49,301 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:04:49 INFO - 2016-01-05 20:04:49,331 DEBUG : process_Request line: kraken 1504.20 graph.html#tests=[[232,52,43]] 20:04:49 INFO - 2016-01-05 20:04:49,332 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:04:49 INFO - 2016-01-05 20:04:49,364 DEBUG : process_Request line: v8_7 23158.00 graph.html#tests=[[230,52,43]] 20:04:49 INFO - 2016-01-05 20:04:49,365 INFO : javascript benchmark 20:04:49 INFO - 2016-01-05 20:04:49,368 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3346.548215990841, 3392.1350055735784, 3403.234272288734, 3428.7599868009233, 3429.434143366345, 5438.809641662542, 5450.700211488366, 5468.808591699291, 5487.643303185295, 5494.230807686917, 5512.669239845602, 5553.583481238903, 5569.053260945639, 5600.411956744544, 5614.129809879465, 5075.162598171307, 5111.718855462948, 5157.510036546522, 5165.509276618715, 5203.505666961632, 4936.531029552205, 4966.801327946878, 5062.26597143414, 5077.441481437039, 5088.54203121719, 5058.645894787366, 5112.054269960069, 5119.692818430887, 5126.974365128169, 5168.379794424674, 5075.517825806561, 5132.769025393866, 5140.357455318085, 5140.537351638333, 5173.922391164117, 4869.878253043702, 4947.950520494821, 5014.89970200594, 5047.4952504749235, 5063.594912406998, 5338.252644629755, 5360.303160589137, 5370.5435038021815, 5423.701696406696, 5428.4842939920645, 5924.881502369972, 5952.315483719384, 5965.313988891289, 5975.671338076404, 5980.611260268069, 5763.250777398953, 5871.588988770788, 6054.545909056795, 6057.697115144269, 6075.301340345873, 5569.526590239794, 5574.136008918624, 5580.107182850765, 5583.609147359686, 5608.663480191201, 6043.365446628129, 6046.697665116727, 6050.6672133032225, 6058.666773327421, 6063.302720187235, 5629.549636029108, 5650.74571644277, 5860.413958604106, 5874.853128671732, 5945.40545945402, 6040.154378387029, 6051.485623721945, 6069.0, 6075.939240607626, 6099.603525770811, 5982.551308651869, 6026.668533230627, 6026.6986650667295, 6030.577859549877, 6044.395560443921, 5757.0788673811985, 5831.454664513907, 5911.674857882772, 5991.760329586855, 6050.152978583002, 4626.629869610423, 4646.303054541778, 4652.441706995182, 4667.556582124693, 4693.342931989524, 4159.5008598967715, 4169.791510424528, 4170.749755014648, 4179.477565304337, 4208.936865947013, 5489.149181876815, 5561.833145005576, 5655.293088363955, 5740.712964351849, 5805.651660900359, 6039.758409663652, 6066.636001839815, 6068.241469816273, 6076.4531192192035, 6077.544184186204, 5500.257465242221, 5645.971770141123, 5704.372519022904, 5706.600537962386, 5725.0, 5210.062188806051, 5243.0, 5284.524392804666, 5291.232771248147, 5294.54996325309, 6156.045812899008, 6197.25632924052, 6202.627842329474, 6213.409726076015, 6223.502119830403, 5729.427057294404, 5838.503727183067, 6034.969825150846, 6059.515238780798, 6066.484348830399, 6135.263289243823, 6192.318844926965, 6244.875102497834, 6247.5001999840815, 6247.812565623039, 5944.108383742473, 5970.609904223256, 5981.2822461303185, 6011.27864656244, 6033.366496517978, 5868.2664666916635, 5995.940040599538, 6033.577649564489, 6108.725107370268, 6123.969380153071, 5872.207252021093, 5917.497012753792, 5917.497012753965, 5928.644281343133, 5938.465538101592, 5861.062230043172, 5878.265216847894, 5908.734106965283, 5909.763609455746, 5933.258342707161, 5532.391436942014, 5614.494695477427, 5797.449242321973, 5813.505852002627, 5951.345352011362, 5932.406759324033, 5991.310999234969, 5996.220491336098, 5999.4900433463645, 6010.098485227076, 5816.069428891357, 5835.708214589169, 5851.795187168429, 5856.765729370948, 5872.0], "unit": "ms", "name": "dojo.html", "value": 5531.437818419187}, {"lowerIsBetter": false, "replicates": [593.8693487432766, 634.9904751428729, 640.9935900640997, 644.6937704590318, 664.4418688301826, 32745.345093098123, 41028.58971410285, 41056.384154237676, 41167.794161029226, 41246.0, 46537.7673111634, 46719.76640116803, 46726.76636616812, 46972.530274697245, 47155.056898862, 8906.465612063264, 9065.546722663841, 9090.0, 9090.54547272637, 9105.590248438803, 8988.550572471382, 9122.452652840851, 9137.725868223964, 9141.725748227564, 9145.817083658323, 9103.044180361067, 9158.175764181222, 9177.724668259963, 9182.08179182083, 9195.954020229923, 9040.321975851837, 9050.818983620324, 9091.772610697537, 9106.089391060907, 9119.772005699844, 9020.503872287021, 9191.770205744842, 9194.678186263516, 9198.0, 9208.0, 43488.56511434877, 43491.565084349066, 43583.0, 43783.34324985128, 43817.561824381664, 3283.097148284217, 3304.5043243513664, 3343.3480471308103, 3387.8644854205804, 3613.8735144270086, 32239.677603223903, 32503.51244731331, 32584.83707581447, 32714.182145446317, 32840.0, 3612.24142929985, 3730.8880733578035, 3770.9434358484646, 3797.886063418074, 3828.157805282833, 285438.0, 288959.0, 289232.0, 289590.0, 290208.0, 45678.314825277645, 62083.37916620776, 62131.378686213466, 62248.0, 62463.6876815613, 43791.56208437939, 43989.78005110018, 44080.338794918105, 44094.559054409685, 44332.0, 14914.328855201542, 14929.850701492845, 14967.176805275814, 15001.399944002336, 15009.849901501064, 13365.131266467843, 13375.464981400635, 13383.397747101404, 13401.195928244142, 13497.0, 14977.475788347356, 15203.923980380026, 15461.149636770086, 15485.380584776709, 15610.843891561166, 6112.816615501542, 6228.5017198624, 6240.5319601030105, 6276.6547839868335, 6372.808815735535, 1021.4839864730367, 1036.875574930998, 1039.2205845615788, 1052.4369462337613, 1099.1701265544464, 28979.710202897702, 29114.272143196165, 29345.266368340963, 29446.705532944823, 29533.85233073821, 1050.9527071281811, 1066.828699783857, 1067.1409515340226, 1078.2398409121552, 1124.9606263780893, 14530.273486325641, 14843.812495000375, 14975.0, 15219.847801522064, 15489.845101549066, 301959.0, 303608.0, 303969.0, 342091.0, 790689.0, 57501.0, 57950.0, 58104.0, 58229.4177058224, 58321.0, 1504.330572895051, 1519.908805471653, 1523.5048609202054, 1530.2425299476831, 1545.2737213509633, 30887.0, 31244.68755312418, 31537.52693709642, 31592.684073158973, 31840.68159318377, 49486.0, 49658.255126172415, 49966.25050624171, 50285.74857125691, 50516.74741626268, 314221.0, 315141.0, 316286.0, 317512.0, 317598.0, 35709.64290357063, 36087.0, 36214.0, 36637.450438242915, 36748.0, 45123.32315015343, 46011.079778403575, 47005.294920576904, 47171.764141179076, 47267.52732472631, 39996.20007599774, 39997.40003899886, 40171.196576067734, 40739.38890916579, 41052.1789564213, 39715.602843972345, 40116.7994160039, 40413.393799093625, 41070.79464602658, 41115.1776964465, 38519.614803851604, 38873.611263886996, 39012.609873900896, 39146.41280380853, 39648.0, 34629.0, 34974.300513990085, 35139.82430087833, 35343.82328088343, 35464.290714186085, 26587.867060664572, 26992.190234293004, 27278.181654550393, 27335.726642734113, 27892.721072789012], "unit": "ms", "name": "ext.html", "value": 19260.582845870536}, {"lowerIsBetter": false, "replicates": [378.21142917018017, 382.40535966572, 382.6632563344257, 392.5622930432568, 397.8726807421625, 15206.771898421532, 15222.847771522296, 16416.671666566675, 18863.339783107593, 19427.708584371212, 11475.598354057609, 13970.580882573513, 15605.375784968588, 16759.162041897886, 16843.41048063318, 5010.373703287099, 5115.948840511584, 5120.4623514530995, 5130.256112863633, 5132.204508301201, 4228.133232687292, 5201.86995325118, 5204.713740744258, 5252.71110088945, 5258.0, 5614.877024595077, 5621.241132447109, 5638.069718496443, 5657.462541058593, 5672.035753921822, 5200.713960732158, 5326.387465441485, 5644.887102257952, 5663.093904975205, 5663.688497132676, 4985.127602669519, 4986.551210391082, 5008.398992120932, 5011.774470148815, 5016.523430274118, 13901.58295251134, 15831.050136991817, 16397.754033689504, 21993.230236941632, 21999.12003519873, 2299.321700098475, 2313.2944451942153, 2380.131252092991, 2394.5330660521204, 2410.0480310277344, 10120.493975301206, 10480.895191048068, 11061.557537698482, 13635.318234088356, 14403.135811851322, 1836.5316844204776, 1883.9905800471047, 1927.6433859735994, 1981.4749091490767, 2011.8189362957257, 58515.70742146305, 58855.0, 59279.11081333784, 59365.703171484296, 64572.0, 10293.691189264335, 10902.182336324808, 11153.944230278797, 11226.045786108109, 11237.157213208879, 14382.424703011762, 14800.111993280438, 14940.0, 14971.0, 14991.0, 8400.831983360298, 8601.13988601135, 8741.0, 8751.168638979287, 8779.12208779117, 8079.1516890725625, 8080.39397045224, 8091.635876385459, 8164.265216130577, 8193.303569196565, 4742.976285118552, 4753.9762301188275, 4764.785584648699, 4820.831270905502, 4842.0, 1866.9346572869883, 1969.0154922538732, 1994.0428594274829, 2016.374923773635, 2017.949551261201, 955.2024059909915, 959.0840747086655, 979.8922118566952, 1003.0020129970726, 1058.8200005998845, 16333.0, 16480.917595411946, 17188.398406055727, 17368.0, 17566.0, 903.6024149374255, 953.5232383808096, 957.6600306891092, 971.1162841813915, 1014.1987829614669, 9041.68354107603, 9495.516476079501, 9519.904800952041, 9564.808703825884, 9727.173190278905, 601275.0, 606858.0, 613579.0, 633776.0, 646341.0, 81081.59459202785, 83098.58450707707, 83289.58355208185, 86966.56516717502, 87587.56206218927, 1214.8663646998823, 1222.8226907098422, 1226.589092653971, 1227.6378468351857, 1230.6677197156719, 14939.402423903357, 14962.700745984801, 14985.100893946397, 15092.471763488225, 15329.540113796604, 32444.51333229956, 32531.18672033218, 32710.672893270763, 33919.321613567095, 35497.82251088728, 43235.13529729325, 44807.0, 45059.54940450554, 46311.0, 46576.53423465722, 9608.519574021411, 9951.601935922483, 10070.345427547187, 10092.444915529717, 10097.949510252402, 11676.06591472697, 16522.339106435607, 16842.494725158263, 16884.0, 17631.206595702966, 13779.931100344435, 13903.09629874055, 13948.651283717581, 14145.292735363397, 14191.929040354733, 13840.4463821446, 14044.78932815988, 14263.144211347353, 14285.142891426132, 14719.484818031318, 14774.77837832412, 14833.110013399231, 14920.925395372953, 15129.621759456102, 15157.242137893281, 10196.13332866685, 10244.59021639156, 10291.507731378759, 10299.3820370778, 10592.099671528007, 14317.785233221302, 14472.421103155755, 14509.85490145085, 14606.780898286746, 14708.77936830927], "unit": "ms", "name": "jquery.html", "value": 9141.53318634039}, {"lowerIsBetter": false, "replicates": [1372.3824279074418, 1433.4051368681999, 1605.2214675882194, 1704.164959170007, 1845.9907700461495, 7183.425325973923, 7329.780106596797, 7907.920920790791, 8340.70807521736, 8397.202265784756, 7664.501807382516, 7862.96068519658, 7931.206879312066, 8193.30356919661, 8207.384446166532, 2373.2761507740133, 2391.4380120671717, 2398.256540472459, 2404.855708657486, 2409.759024097585, 2394.6767186429784, 2439.3047981325326, 2471.8393304435153, 2485.639582260571, 2486.266551367342, 2321.3732292281156, 2329.126577533425, 2335.1126571902737, 2357.787799098081, 2365.3731761083327, 2335.7781010803947, 2368.0882860098814, 2390.0, 2394.7605239476, 2400.0399840063938, 2333.346662934381, 2342.051469154995, 2360.3391050505884, 2375.121205154087, 2384.616922185146, 8198.139195384518, 8250.504969701837, 8256.876146857801, 8258.587070646503, 8269.751907442786, 4877.975610121962, 4914.852554423373, 4929.482404347564, 4931.876703082416, 4964.404271487409, 3138.4037032963665, 3142.402943440739, 3161.5889934308393, 3172.0, 3258.429774789426, 979.1725991537139, 996.795656890343, 998.8451789972565, 1022.4683164754287, 1037.8287582548871, 11151.944240278746, 11230.101591872712, 11266.43667816606, 11277.774444511146, 11279.887201128047, 4386.254336762694, 4403.801828917706, 4423.712458690175, 4476.440444944382, 4485.304777759453, 9169.449833010041, 9188.173064424234, 9193.586288617029, 9209.17117459432, 9224.677136300197, 4948.084604348207, 4974.651774375759, 5000.824971125993, 5002.399712034579, 5013.248012798036, 4439.511653718088, 4521.367008618796, 4539.727616342964, 4543.54564543543, 4622.95377046232, 3752.962470375261, 3824.7513911595656, 3827.6411873784964, 3830.138218900725, 3832.2335532893535, 1158.6639874436487, 1161.285809227336, 1166.102101381931, 1173.2549830857467, 1173.7417768091177, 987.9209663226925, 995.7361299255703, 1000.7248006798043, 1085.9294145880492, 1239.9566015189605, 7607.125180604301, 7632.923670763333, 7642.4650274480255, 7647.082350118021, 7652.120006199359, 1238.9380530973594, 1286.311823174597, 1290.5225066725372, 1305.2755720575171, 1306.790913453843, 5290.365156181206, 5301.602379821529, 5324.1747529133045, 5339.199120131933, 5353.598480114007, 9463.290253231035, 9532.094451027142, 9701.417914925127, 10100.737407824023, 10124.291299608956, 9858.0, 9915.206783457306, 10020.849687254697, 10042.799144017079, 10079.143272821892, 7685.077790665156, 7797.57113358782, 7801.882971755428, 7826.099998500245, 7865.331446826969, 7148.142222933281, 7171.748988785576, 7183.497155199086, 7215.639218038972, 7228.060352154186, 8662.177093176138, 8794.472331660121, 9091.409058411182, 9123.270138389045, 9149.496777677292, 9016.323775716979, 9094.954525227331, 9141.725748227564, 9222.815543688954, 9225.031371705874, 6361.522885783677, 6640.667966601554, 6678.398944094861, 6984.895226571707, 7041.612711300928, 7523.360514356341, 7774.572398518136, 7795.0, 7812.687492500237, 7844.372450203856, 7243.963780181065, 7284.235155308828, 7306.817329566803, 7400.222976587381, 7527.397808175442, 6886.896696549656, 6952.304769523007, 7219.241979592067, 7248.275172482709, 7313.780586582411, 7444.367228785614, 7449.590272534846, 7460.962695186489, 7494.250574942462, 7516.24837516244, 6479.708413121515, 6484.5460817742305, 6508.576942498912, 6534.771283005072, 6534.83662908412, 6176.382361763787, 6248.968755156195, 6262.655553944577, 6269.310375858743, 6276.215473065867], "unit": "ms", "name": "mootools.html", "value": 4635.538686424826}, {"lowerIsBetter": false, "replicates": [368.40134780980907, 369.8723940240616, 371.29639333463103, 371.3056584187569, 377.8073182676834, 6256.562040657156, 6367.713452894619, 6375.776847810327, 6403.263624683157, 6443.194600674909, 6189.164462797521, 6275.46658534024, 6306.936930630693, 6320.4943604511645, 6349.936500634993, 4833.540813622709, 4840.903181936359, 4879.658423910328, 4884.242942343943, 4888.315635810972, 4911.042346742387, 4915.778789954461, 4918.754062296889, 4919.13915064864, 4922.163232250526, 4709.5055019223, 4839.05638400512, 4842.685225460352, 4843.104025755247, 4855.757212139397, 4820.228763397857, 4824.155772739757, 4824.807007719704, 4825.276208568707, 4831.589314908237, 4202.159568086395, 4204.11713540157, 4207.43199668044, 4211.663066954637, 4218.240716670998, 5959.612625179349, 6014.909776353315, 6060.151578778975, 6060.2424696912885, 6075.33171351151, 5616.9157462638095, 5621.241132447149, 5649.12438572022, 5650.547956163538, 5653.152027195953, 6693.832654183636, 6704.094947182117, 6725.39471447572, 6735.393814556714, 6752.93247067528, 4672.299155126724, 4678.064387122555, 4680.134175177569, 4683.391159149289, 4696.882577935545, 6846.349596788297, 6938.895916561256, 6954.513184077116, 6977.197622273402, 6982.057422247983, 4799.136155491975, 4832.830850920201, 4834.879128021757, 4837.05677392912, 4837.153498137812, 4891.510848915151, 4892.804287828518, 4894.486078961729, 4897.069556784271, 4899.730514821719, 5564.972175139098, 5658.575606829504, 5659.490645841894, 5663.575231857545, 5664.631798933056, 6724.327567243335, 6768.0, 6784.626845523445, 6785.728570857209, 6790.151231096113, 1696.6776312500833, 1718.458685514059, 1740.7911050674, 1741.8519425848945, 1742.6863164630236, 1161.0189389965465, 1174.0783484964263, 1179.351356753782, 1191.0888170549536, 1192.5110704611068, 6454.806355809334, 6502.869942601122, 6519.511036672268, 6527.804165875032, 6541.378569035934, 6957.79126626202, 6965.791026269118, 6976.988336691152, 6984.4412447004115, 6995.125609298838, 6384.648844313514, 6478.4169424752, 6487.124238227873, 6515.185601799775, 6539.182602174728, 3757.3988161894513, 3784.1674831537566, 3801.847926082981, 3804.068003339144, 3806.790626515513, 7165.498415110997, 7178.712851485987, 7211.711531538785, 7216.458765592602, 7235.493515453868, 7125.1093613298335, 7148.499605027599, 7149.7497587584185, 7171.89242161368, 7300.123985121713, 7360.190379058299, 7370.820668693091, 7371.152317483558, 7379.225181355988, 7382.077240344957, 7117.3238542338395, 7122.679479423335, 7126.037984872183, 7126.536775109601, 7133.928660713534, 6868.347506986828, 7007.194172670004, 7009.649517524205, 7019.5788252705, 7027.472939529658, 7189.424846012411, 7245.456590755609, 7261.818454538467, 7264.854702906018, 7356.411487081128, 4822.228443449031, 4879.926801098058, 4888.60891128716, 4898.265260210855, 4910.06708725341, 6956.652167391711, 6965.825854353681, 7078.716851325889, 7092.751753688596, 7093.6453177341955, 6906.93093069083, 6926.06498122747, 6928.4803639726215, 6944.618046007518, 6945.756898508528, 6877.415419689382, 6903.585784852925, 6910.481713871379, 6918.584884906922, 6918.896216556655, 6650.3682150195655, 6779.050932869303, 6793.72825086991, 6802.01370801241, 6804.047433359433, 6925.099737034153, 6936.445084393337, 6936.79189624312, 6944.270851560514, 6950.0, 6642.501812363996, 6737.157855268091, 6756.0, 6757.358050985148, 6758.8648227036165], "unit": "ms", "name": "prototype.html", "value": 5135.730732459122}, {"lowerIsBetter": false, "replicates": [790.5691398187987, 793.4208028139458, 799.188823344306, 806.685392696848, 814.8573999550081, 13061.216327020386, 13219.999999999987, 13261.535846245384, 13262.801057984138, 13299.268540230283, 12536.81194782079, 12579.056570757184, 12608.873911260886, 12630.684232894182, 13851.93074034631, 888.9599968001439, 912.2337236721153, 913.7030465098836, 917.6421195733669, 918.5040078357712, 903.3631289940577, 907.0294784580468, 910.1444642036498, 911.4531281231275, 911.7811725185941, 931.1573026411108, 948.6158105967095, 949.5062567464914, 951.8477043673014, 955.1212884146602, 938.1087966431883, 942.4204114469586, 943.1323182671958, 943.7216021273741, 944.4616568555925, 694.0491526608579, 694.472201127142, 696.053367420308, 696.1889398850333, 696.5959743348845, 13017.21896686202, 13102.344882755824, 13122.671933201651, 13160.934195329059, 13199.802002969964, 11854.170208085437, 11951.940240298829, 12203.633890983285, 12850.594592433014, 12962.092653514257, 10276.89723102767, 10479.895201047968, 10517.775189399617, 10544.420056896868, 10608.15134789215, 3691.7600355977042, 3745.606711295302, 3752.4746535485056, 3756.868509602178, 3772.1889793694486, 48804.0, 48809.75595122002, 49331.0, 49561.504384956046, 49717.25424118641, 9935.354201976848, 10095.798084038279, 10108.24188185889, 10136.442495662663, 10226.948865255627, 18482.630347392977, 18569.628607427774, 18709.625807483775, 18898.244070237313, 19154.52113697169, 7822.452428330076, 7966.0839003514175, 7986.2812346887895, 8065.516069035759, 8169.42814003026, 4449.532799056117, 4477.328400739915, 4487.125010622897, 4529.456465224194, 4601.056783359403, 3230.5315729219133, 3262.6737326267657, 3266.6080070391704, 3266.836658167082, 3275.950860737091, 580.6400031980199, 591.0779184472151, 592.3957563285425, 592.6651441935379, 600.198734689186, 550.686108917913, 570.6148349863909, 604.0878273806584, 630.4074170279922, 650.5803756577076, 9046.81906361869, 9382.5308734563, 9388.389754665925, 9467.195288400562, 9585.760355991017, 509.4294390282907, 622.8723111762168, 641.9037144428373, 645.0131299112365, 664.8404382948154, 3662.359087159736, 3838.9232215356096, 3920.0395903003377, 3926.155876486569, 3929.7838618876235, 56056.0, 57682.7115864418, 57977.0, 58831.0, 58878.41121588815, 53573.73213133987, 53763.0, 54110.0, 54242.0, 54367.0, 45677.771611142394, 45838.31242531365, 46477.767611161726, 46993.0, 47657.76171119122, 7721.189275126256, 7757.92242077572, 7785.338246249133, 7844.21557844211, 7966.522008679498, 35422.291554169286, 36152.27695446129, 36585.0, 36708.06335493101, 36871.815640921624, 43033.13933721371, 43057.138857223305, 45391.31913021241, 47374.0, 47989.0, 9377.953110234404, 9569.282303827102, 9602.279829012712, 9629.711108666752, 9751.512424378894, 10753.838692419464, 10977.890221097687, 11038.061764750086, 11221.66335009951, 11604.361760102938, 9415.764605884908, 9670.56482458305, 9724.0, 9836.508174591385, 10348.913364096661, 9377.531123443938, 9456.479893605643, 9466.148046675557, 9702.466364350028, 9843.704688859345, 9356.204722598655, 9601.279904007088, 9617.2306215504, 9724.611015559298, 9914.950425247827, 8667.566621669017, 8758.386912916034, 8853.026167121483, 8872.911270887209, 8902.955485222532, 8454.408191426786, 8553.95723021381, 8596.699115530926, 8620.13798620133, 8635.568221589021], "unit": "ms", "name": "yui.html", "value": 6280.066281372478}], "name": "dromaeo_css", "value": 7253.3446933888945}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 112.0, 111.0, 112.0, 121.0, 111.0, 112.0, 114.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [148.0, 127.0, 154.0, 158.0, 124.0, 150.0, 152.0, 130.0, 161.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.9}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 163.0, 162.0, 162.0, 162.0, 163.0, 161.0, 165.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 73.0, 171.0, 78.0, 72.0, 72.0, 71.0, 153.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 91.1}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 135.0, 94.0, 93.0, 92.0, 137.0, 93.0, 93.0, 142.0], "unit": "ms", "name": "audio-oscillator", "value": 106.6}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 145.0, 146.0, 147.0, 148.0, 149.0, 147.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 97.0, 99.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [57.0, 60.0, 59.0, 59.0, 59.0, 61.0, 60.0, 60.0, 59.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 59.2}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 66.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 81.0, 82.0, 83.0, 83.0, 81.0, 89.0, 89.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [121.0, 110.0, 120.0, 112.0, 124.0, 123.0, 122.0, 118.0, 116.0, 117.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.3}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 149.0, 145.0, 144.0, 137.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.9}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 64.0, 65.0, 66.0, 67.0, 65.0, 65.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.0}], "name": "kraken", "value": 1504.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.59032952475576], "unit": "score", "name": "Richards", "value": 213.18877800000007}, {"lowerIsBetter": false, "replicates": [172.89073305670817], "unit": "score", "name": "DeltaBlue", "value": 382.42651200000006}, {"lowerIsBetter": false, "replicates": [278.08676307007784], "unit": "score", "name": "Encrypt", "value": 957.1868759999999}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [902.5270758122743], "unit": "score", "name": "RayTrace", "value": 819.9078120000003}, {"lowerIsBetter": false, "replicates": [550.9641873278237], "unit": "score", "name": "Earley", "value": 1209.6303449999996}, {"lowerIsBetter": false, "replicates": [11087.912087912087], "unit": "score", "name": "Boyer", "value": 60.107168483647186}, {"lowerIsBetter": false, "replicates": [25075.0], "unit": "score", "name": "RegExp", "value": 36.33040877367896}, {"lowerIsBetter": false, "replicates": [510.39026862645716], "unit": "score", "name": "Splay", "value": 159.66409433962272}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 23158.002854117858}]} 20:04:49 INFO - RETURN: dromaeo_css: 7253.35 20:04:49 INFO - RETURN: kraken: 1504.20 20:04:49 INFO - RETURN: v8_7: 23158.00 20:04:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23158.00"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1504.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7253.35"}}} 20:04:49 INFO - Return code: 0 20:04:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:04:49 INFO - # TBPL SUCCESS # 20:04:49 INFO - Running post-action listener: _resource_record_post_action 20:04:49 INFO - Running post-run listener: _resource_record_post_run 20:04:50 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 0; Write bytes: 529342464; Read time: 0; Write time: 410232 20:04:50 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 252194816; Read time: 0; Write time: 280964 20:04:50 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 0; Write bytes: 276283392; Read time: 0; Write time: 129224 20:04:50 INFO - Running post-run listener: _upload_blobber_files 20:04:50 INFO - Blob upload gear active. 20:04:50 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 20:04:50 INFO - Copying logs to upload dir... 20:04:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1255.329089 ========= master_lag: 36.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-01-05 20:05:26.344826) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-05 20:05:26.348682) ========= 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=a0d2d2de893abaa8702a9954000001a7-1452051832.534616-1894599926 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010008 build_url: 'https://queue.taskcluster.net/v1/task/NSOK6XqjSkKoD2jPxfY3kQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.13 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-05 20:05:26.489464) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 20:05:26.489841) ========= 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=a0d2d2de893abaa8702a9954000001a7-1452051832.534616-1894599926 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.21 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 20:05:26.704587) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 20:05:26.704921) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 20:05:26.705365) ========= ========= Total master_lag: 36.51 =========