builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1456761606.38 results: success (0) buildid: 20160229053003 builduid: 6436ae5f6f8046b6bc328b8bd4c782d4 revision: 76c51477853faeac91211c2adee7adfee858b276 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:06.384899) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:06.385321) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:06.385602) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009053 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:06.412718) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:06.412982) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:06.428371) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:06.428639) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004653 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:06.477619) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:06.477879) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:06.480217) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:06.480510) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-29 08:00:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-02-29 08:00:07 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.327871 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:06.820127) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:06.820443) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015977 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:06.874045) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:06.874402) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 76c51477853faeac91211c2adee7adfee858b276 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 76c51477853faeac91211c2adee7adfee858b276 --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=9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-29 08:00:07,580 truncating revision to first 12 chars 2016-02-29 08:00:07,580 Setting DEBUG logging. 2016-02-29 08:00:07,580 attempt 1/10 2016-02-29 08:00:07,580 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/76c51477853f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-29 08:00:07,854 unpacking tar archive at: fx-team-76c51477853f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.572072 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:07.458571) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:07.458875) ========= echo 76c51477853faeac91211c2adee7adfee858b276 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'76c51477853faeac91211c2adee7adfee858b276'] 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=9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 76c51477853faeac91211c2adee7adfee858b276 program finished with exit code 0 elapsedTime=0.004649 script_repo_revision: '76c51477853faeac91211c2adee7adfee858b276' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:07.510504) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:07.510795) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 08:00:07.522650) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-02-29 08:00:07.522921) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:00:08 INFO - MultiFileLogger online at 20160229 08:00:08 in /builds/slave/test-pgo 08:00:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:00:08 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:00:08 INFO - {'append_to_log': False, 08:00:08 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:00:08 INFO - 'blob_upload_branch': 'Fx-Team', 08:00:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:00:08 INFO - 'branch': 'Fx-Team', 08:00:08 INFO - 'buildbot_json_path': 'buildprops.json', 08:00:08 INFO - 'config_files': ('talos/linux_config.py',), 08:00:08 INFO - 'default_actions': ('clobber', 08:00:08 INFO - 'read-buildbot-config', 08:00:08 INFO - 'download-and-extract', 08:00:08 INFO - 'populate-webroot', 08:00:08 INFO - 'create-virtualenv', 08:00:08 INFO - 'install', 08:00:08 INFO - 'run-tests'), 08:00:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:00:08 INFO - 'download_minidump_stackwalk': True, 08:00:08 INFO - 'download_symbols': 'ondemand', 08:00:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:00:08 INFO - 'tooltool.py': '/tools/tooltool.py', 08:00:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:00:08 INFO - '/tools/misc-python/virtualenv.py')}, 08:00:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:00:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:00:08 INFO - 'installer_path': 'installer.exe', 08:00:08 INFO - 'log_level': 'info', 08:00:08 INFO - 'log_name': 'talos', 08:00:08 INFO - 'log_to_console': True, 08:00:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:00:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:00:08 INFO - 'opt_config_files': (), 08:00:08 INFO - 'pip_index': False, 08:00:08 INFO - 'sps_profile': False, 08:00:08 INFO - 'sps_profile_interval': 0, 08:00:08 INFO - 'suite': 'dromaeojs-e10s', 08:00:08 INFO - 'system_bits': '32', 08:00:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:00:08 INFO - 'title': 'talos-linux64-ix-022', 08:00:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:00:08 INFO - 'use_talos_json': True, 08:00:08 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:00:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:00:08 INFO - 'work_dir': 'build'} 08:00:08 INFO - ##### 08:00:08 INFO - ##### Running clobber step. 08:00:08 INFO - ##### 08:00:08 INFO - Running pre-action listener: _resource_record_pre_action 08:00:08 INFO - Running main action method: clobber 08:00:08 INFO - rmtree: /builds/slave/test-pgo/build 08:00:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:00:08 INFO - Running post-action listener: _resource_record_post_action 08:00:08 INFO - ##### 08:00:08 INFO - ##### Running read-buildbot-config step. 08:00:08 INFO - ##### 08:00:08 INFO - Running pre-action listener: _resource_record_pre_action 08:00:08 INFO - Running main action method: read_buildbot_config 08:00:08 INFO - Using buildbot properties: 08:00:08 INFO - { 08:00:08 INFO - "project": "", 08:00:08 INFO - "product": "firefox", 08:00:08 INFO - "script_repo_revision": "production", 08:00:08 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:00:08 INFO - "repository": "", 08:00:08 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:00:08 INFO - "buildid": "20160229053003", 08:00:08 INFO - "pgo_build": "True", 08:00:08 INFO - "basedir": "/builds/slave/test-pgo", 08:00:08 INFO - "buildnumber": 207, 08:00:08 INFO - "slavename": "talos-linux64-ix-022", 08:00:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:00:08 INFO - "platform": "ubuntu64_hw", 08:00:08 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:00:08 INFO - "branch": "fx-team", 08:00:08 INFO - "repo_path": "integration/fx-team", 08:00:08 INFO - "revision": "76c51477853faeac91211c2adee7adfee858b276", 08:00:08 INFO - "stage_platform": "linux64-pgo", 08:00:08 INFO - "builduid": "6436ae5f6f8046b6bc328b8bd4c782d4", 08:00:08 INFO - "slavebuilddir": "test" 08:00:08 INFO - } 08:00:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 08:00:08 INFO - Running post-action listener: _resource_record_post_action 08:00:08 INFO - ##### 08:00:08 INFO - ##### Running download-and-extract step. 08:00:08 INFO - ##### 08:00:08 INFO - Running pre-action listener: _resource_record_pre_action 08:00:08 INFO - Running main action method: download_and_extract 08:00:08 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:00: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')]} 08:00:08 INFO - https://queue.taskcluster.net/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:00:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/test_packages.json 08:00:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/test_packages.json 08:00:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:00:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:00:09 INFO - Downloaded 1448 bytes. 08:00:09 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:00:09 INFO - Using the following test package requirements: 08:00:09 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:00:09 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:09 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:00:09 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:09 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:00:09 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:09 INFO - u'jsshell-linux-x86_64.zip'], 08:00:09 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:09 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:00:09 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:00:09 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:09 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:00:09 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:09 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:00:09 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:09 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:00:09 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:00:09 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:00:09 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:00:09 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:00:09 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')]} 08:00:09 INFO - https://queue.taskcluster.net/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:00:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:00:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:00:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:00:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:00:10 INFO - Downloaded 23372317 bytes. 08:00:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:00:10 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:00:11 INFO - Return code: 0 08:00:11 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:00:11 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')]} 08:00:11 INFO - https://queue.taskcluster.net/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:00:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:00:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:00:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:00:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:00:18 INFO - Downloaded 23372317 bytes. 08:00:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:00:18 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:00:19 INFO - Return code: 0 08:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:19 INFO - https://queue.taskcluster.net/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:00:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:00:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:00:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:00:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:00:20 INFO - Downloaded 10713410 bytes. 08:00:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:00:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 08:00:20 INFO - Return code: 0 08:00: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')]} 08:00:20 INFO - https://queue.taskcluster.net/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:00:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:00:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:00:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:00:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:00:23 INFO - Downloaded 56634934 bytes. 08:00:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:00:23 INFO - mkdir: /builds/slave/test-pgo/properties 08:00:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:00:23 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:00:23 INFO - Contents: 08:00:23 INFO - build_url:https://queue.taskcluster.net/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:00:23 INFO - Running post-action listener: _resource_record_post_action 08:00:23 INFO - Running post-action listener: set_extra_try_arguments 08:00:23 INFO - ##### 08:00:23 INFO - ##### Running populate-webroot step. 08:00:23 INFO - ##### 08:00:23 INFO - Running pre-action listener: _resource_record_pre_action 08:00:23 INFO - Running main action method: populate_webroot 08:00:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:00:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:00:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:00:23 INFO - '--tppagecycles', 08:00:23 INFO - '7'], 08:00:23 INFO - 'tests': ['tsvgm']}}, 08:00:23 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:00:23 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:00:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:00:23 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:00:23 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:00:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:00:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:00:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:23 INFO - 'talos_options': ['--e10s'], 08:00:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:00:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:23 INFO - 'tests': ['damp', 'tps']}, 08:00:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:23 INFO - 'talos_options': ['--e10s'], 08:00:23 INFO - 'tests': ['damp', 'tps']}, 08:00:23 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:00:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:00:23 INFO - 'other': {'tests': ['a11yr', 08:00:23 INFO - 'ts_paint', 08:00:23 INFO - 'tpaint', 08:00:23 INFO - 'sessionrestore', 08:00:23 INFO - 'sessionrestore_no_auto_restore']}, 08:00:23 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:00:23 INFO - 'tests': ['a11yr', 08:00:23 INFO - 'ts_paint', 08:00:23 INFO - 'tpaint', 08:00:23 INFO - 'sessionrestore', 08:00:23 INFO - 'sessionrestore_no_auto_restore']}, 08:00:23 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:00:23 INFO - 'tests': ['a11yr', 08:00:23 INFO - 'ts_paint', 08:00:23 INFO - 'tpaint', 08:00:23 INFO - 'sessionrestore', 08:00:23 INFO - 'sessionrestore_no_auto_restore']}, 08:00:23 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:00:23 INFO - 'tests': ['a11yr', 08:00:23 INFO - 'ts_paint', 08:00:23 INFO - 'tpaint', 08:00:23 INFO - 'sessionrestore', 08:00:23 INFO - 'sessionrestore_no_auto_restore']}, 08:00:23 INFO - 'other_l64': {'tests': ['a11yr', 08:00:23 INFO - 'ts_paint', 08:00:23 INFO - 'tpaint', 08:00:23 INFO - 'sessionrestore', 08:00:23 INFO - 'sessionrestore_no_auto_restore']}, 08:00:23 INFO - 'other_nol64': {'tests': ['a11yr', 08:00:23 INFO - 'ts_paint', 08:00:23 INFO - 'tpaint', 08:00:23 INFO - 'sessionrestore', 08:00:23 INFO - 'sessionrestore_no_auto_restore']}, 08:00:23 INFO - 'svgr': {'tests': ['tsvgx', 08:00:23 INFO - 'tsvgr_opacity', 08:00:23 INFO - 'tart', 08:00:23 INFO - 'tscrollx', 08:00:23 INFO - 'cart']}, 08:00:23 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:00:23 INFO - 'tests': ['tsvgx', 08:00:23 INFO - 'tsvgr_opacity', 08:00:23 INFO - 'tart', 08:00:23 INFO - 'tscrollx', 08:00:23 INFO - 'cart']}, 08:00:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:23 INFO - 'tests': ['tp5o']}, 08:00:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:23 INFO - 'talos_options': ['--e10s'], 08:00:23 INFO - 'tests': ['tp5o']}, 08:00:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:23 INFO - 'talos_options': ['--xperf_path', 08:00:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:00:23 INFO - 'tests': ['tp5n']}, 08:00:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:23 INFO - 'talos_options': ['--e10s', 08:00:23 INFO - '--xperf_path', 08:00:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:00:23 INFO - 'tests': ['tp5n']}}, 08:00:23 INFO - 'talos.zip': {'path': '', 08:00:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:00:23 INFO - Running post-action listener: _resource_record_post_action 08:00:23 INFO - ##### 08:00:23 INFO - ##### Running create-virtualenv step. 08:00:23 INFO - ##### 08:00:23 INFO - Running pre-action listener: _resource_record_pre_action 08:00:23 INFO - Running main action method: create_virtualenv 08:00:23 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:00:23 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 08:00:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:00:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:00:23 INFO - Using real prefix '/usr' 08:00:23 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:00:24 INFO - Installing distribute.............................................................................................................................................................................................done. 08:00:26 INFO - Installing pip.................done. 08:00:26 INFO - Return code: 0 08:00:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:26 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb404553f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec9670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f588c0>, '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 0x1f597c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f59c50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025', '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 08:00:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 08:00:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:00:26 INFO - Using env: {'DISPLAY': ':0', 08:00:26 INFO - 'HOME': '/home/cltbld', 08:00:26 INFO - 'LANG': 'en_US.UTF-8', 08:00:26 INFO - 'LANGUAGE': 'en_US:en', 08:00:26 INFO - 'LOGNAME': 'cltbld', 08:00:26 INFO - 'MAIL': '/var/mail/cltbld', 08:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:26 INFO - 'MOZ_NO_REMOTE': '1', 08:00:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:26 INFO - 'NO_EM_RESTART': '1', 08:00:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:26 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:26 INFO - 'SHELL': '/bin/bash', 08:00:26 INFO - 'SHLVL': '1', 08:00:26 INFO - 'TERM': 'linux', 08:00:26 INFO - 'TMOUT': '86400', 08:00:26 INFO - 'USER': 'cltbld', 08:00:26 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025', 08:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:26 INFO - '_': '/tools/buildbot/bin/python'} 08:00:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:26 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 08:00:26 INFO - Cleaning up... 08:00:26 INFO - Return code: 0 08:00:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:26 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb404553f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec9670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f588c0>, '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 0x1f597c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f59c50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025', '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 08:00:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 08:00:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:00:26 INFO - Using env: {'DISPLAY': ':0', 08:00:26 INFO - 'HOME': '/home/cltbld', 08:00:26 INFO - 'LANG': 'en_US.UTF-8', 08:00:26 INFO - 'LANGUAGE': 'en_US:en', 08:00:26 INFO - 'LOGNAME': 'cltbld', 08:00:26 INFO - 'MAIL': '/var/mail/cltbld', 08:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:26 INFO - 'MOZ_NO_REMOTE': '1', 08:00:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:26 INFO - 'NO_EM_RESTART': '1', 08:00:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:26 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:26 INFO - 'SHELL': '/bin/bash', 08:00:26 INFO - 'SHLVL': '1', 08:00:26 INFO - 'TERM': 'linux', 08:00:26 INFO - 'TMOUT': '86400', 08:00:26 INFO - 'USER': 'cltbld', 08:00:26 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025', 08:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:26 INFO - '_': '/tools/buildbot/bin/python'} 08:00:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:26 INFO - Downloading/unpacking psutil>=0.7.1 08:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:00:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:00:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:00:28 INFO - Installing collected packages: psutil 08:00:28 INFO - Running setup.py install for psutil 08:00:28 INFO - building 'psutil._psutil_linux' extension 08:00:28 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 08:00:29 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 08:00:29 INFO - building 'psutil._psutil_posix' extension 08:00:29 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 08:00:29 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 08:00:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:00:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:00:29 INFO - Successfully installed psutil 08:00:29 INFO - Cleaning up... 08:00:29 INFO - Return code: 0 08:00:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb404553f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec9670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f588c0>, '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 0x1f597c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f59c50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025', '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 08:00:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 08:00:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:00:29 INFO - Using env: {'DISPLAY': ':0', 08:00:29 INFO - 'HOME': '/home/cltbld', 08:00:29 INFO - 'LANG': 'en_US.UTF-8', 08:00:29 INFO - 'LANGUAGE': 'en_US:en', 08:00:29 INFO - 'LOGNAME': 'cltbld', 08:00:29 INFO - 'MAIL': '/var/mail/cltbld', 08:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:29 INFO - 'MOZ_NO_REMOTE': '1', 08:00:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:29 INFO - 'NO_EM_RESTART': '1', 08:00:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:29 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:29 INFO - 'SHELL': '/bin/bash', 08:00:29 INFO - 'SHLVL': '1', 08:00:29 INFO - 'TERM': 'linux', 08:00:29 INFO - 'TMOUT': '86400', 08:00:29 INFO - 'USER': 'cltbld', 08:00:29 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025', 08:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:29 INFO - '_': '/tools/buildbot/bin/python'} 08:00:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:00:29 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 08:00:29 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 08:00:29 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 08:00:29 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 08:00:29 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 08:00:29 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 08:00:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:00:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:00:31 INFO - Installing collected packages: mozsystemmonitor 08:00:31 INFO - Running setup.py install for mozsystemmonitor 08:00:31 INFO - Successfully installed mozsystemmonitor 08:00:31 INFO - Cleaning up... 08:00:31 INFO - Return code: 0 08:00:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:31 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb404553f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec9670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f588c0>, '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 0x1f597c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f59c50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025', '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 08:00:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 08:00:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:00:31 INFO - Using env: {'DISPLAY': ':0', 08:00:31 INFO - 'HOME': '/home/cltbld', 08:00:31 INFO - 'LANG': 'en_US.UTF-8', 08:00:31 INFO - 'LANGUAGE': 'en_US:en', 08:00:31 INFO - 'LOGNAME': 'cltbld', 08:00:31 INFO - 'MAIL': '/var/mail/cltbld', 08:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:31 INFO - 'MOZ_NO_REMOTE': '1', 08:00:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:31 INFO - 'NO_EM_RESTART': '1', 08:00:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:31 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:31 INFO - 'SHELL': '/bin/bash', 08:00:31 INFO - 'SHLVL': '1', 08:00:31 INFO - 'TERM': 'linux', 08:00:31 INFO - 'TMOUT': '86400', 08:00:31 INFO - 'USER': 'cltbld', 08:00:31 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025', 08:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:31 INFO - '_': '/tools/buildbot/bin/python'} 08:00:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:31 INFO - Downloading/unpacking blobuploader==1.2.4 08:00:31 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 08:00:31 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 08:00:31 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 08:00:31 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 08:00:31 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 08:00:31 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 08:00:33 INFO - Downloading blobuploader-1.2.4.tar.gz 08:00:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:00:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:00:33 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 08:00:33 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 08:00:33 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 08:00:33 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 08:00:33 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 08:00:33 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 08:00:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:00:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:34 INFO - Downloading docopt-0.6.1.tar.gz 08:00:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:00:34 INFO - Installing collected packages: blobuploader, requests, docopt 08:00:34 INFO - Running setup.py install for blobuploader 08:00:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:00:34 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:00:34 INFO - Running setup.py install for requests 08:00:34 INFO - Running setup.py install for docopt 08:00:34 INFO - Successfully installed blobuploader requests docopt 08:00:34 INFO - Cleaning up... 08:00:34 INFO - Return code: 0 08:00:34 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb404553f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec9670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f588c0>, '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 0x1f597c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f59c50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025', '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 08:00:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 08:00:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:00:34 INFO - Using env: {'DISPLAY': ':0', 08:00:34 INFO - 'HOME': '/home/cltbld', 08:00:34 INFO - 'LANG': 'en_US.UTF-8', 08:00:34 INFO - 'LANGUAGE': 'en_US:en', 08:00:34 INFO - 'LOGNAME': 'cltbld', 08:00:34 INFO - 'MAIL': '/var/mail/cltbld', 08:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:34 INFO - 'MOZ_NO_REMOTE': '1', 08:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:34 INFO - 'NO_EM_RESTART': '1', 08:00:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:34 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:34 INFO - 'SHELL': '/bin/bash', 08:00:34 INFO - 'SHLVL': '1', 08:00:34 INFO - 'TERM': 'linux', 08:00:34 INFO - 'TMOUT': '86400', 08:00:34 INFO - 'USER': 'cltbld', 08:00:34 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025', 08:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:34 INFO - '_': '/tools/buildbot/bin/python'} 08:00:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:00:35 INFO - Running setup.py (path:/tmp/pip-Om2Rhe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:00:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:00:35 INFO - Running setup.py (path:/tmp/pip-ZWkuz5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:00:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:00:35 INFO - Running setup.py (path:/tmp/pip-ETkkO1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:00:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:00:35 INFO - Running setup.py (path:/tmp/pip-pBKGUB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:00:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:00:35 INFO - Running setup.py (path:/tmp/pip-t6HCdE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:00:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:00:35 INFO - Running setup.py (path:/tmp/pip-i6id6p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:00:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:00:35 INFO - Running setup.py (path:/tmp/pip-UgQxnc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:00:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:00:35 INFO - Running setup.py (path:/tmp/pip-kTDqJ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:00:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:00:35 INFO - Running setup.py (path:/tmp/pip-0vRxpf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:00:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:00:35 INFO - Running setup.py (path:/tmp/pip-75kfKK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:00:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:00:35 INFO - Running setup.py (path:/tmp/pip-HRxUjG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:00:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:00:35 INFO - Running setup.py (path:/tmp/pip-H0JMWj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:00:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:00:36 INFO - Running setup.py (path:/tmp/pip-qJeULi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:00:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:00:36 INFO - Running setup.py (path:/tmp/pip-BLnqJ2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:00:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:00:36 INFO - Running setup.py (path:/tmp/pip-f9SDPE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:00:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:00:36 INFO - Running setup.py (path:/tmp/pip-H_HKW5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:00:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:00:36 INFO - Running setup.py (path:/tmp/pip-ZDaRrA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:00:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:00:36 INFO - Running setup.py install for manifestparser 08:00:36 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:00:36 INFO - Running setup.py install for mozcrash 08:00:36 INFO - Running setup.py install for mozdebug 08:00:36 INFO - Running setup.py install for mozdevice 08:00:36 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:00:36 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:00:36 INFO - Running setup.py install for mozfile 08:00:36 INFO - Running setup.py install for mozhttpd 08:00:36 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:00:37 INFO - Running setup.py install for mozinfo 08:00:37 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:00:37 INFO - Running setup.py install for mozInstall 08:00:37 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:00:37 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:00:37 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:00:37 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:00:37 INFO - Running setup.py install for mozleak 08:00:37 INFO - Running setup.py install for mozlog 08:00:37 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:00:37 INFO - Running setup.py install for moznetwork 08:00:37 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:00:37 INFO - Running setup.py install for mozprocess 08:00:37 INFO - Running setup.py install for mozprofile 08:00:37 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:00:37 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:00:37 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:00:37 INFO - Running setup.py install for mozrunner 08:00:37 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:00:37 INFO - Running setup.py install for mozscreenshot 08:00:37 INFO - Running setup.py install for moztest 08:00:38 INFO - Running setup.py install for mozversion 08:00:38 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:00:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:00:38 INFO - Cleaning up... 08:00:38 INFO - Return code: 0 08:00:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fb404553f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec9670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f588c0>, '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 0x1f597c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f59c50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025', '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 08:00:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 08:00:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:00:38 INFO - Using env: {'DISPLAY': ':0', 08:00:38 INFO - 'HOME': '/home/cltbld', 08:00:38 INFO - 'LANG': 'en_US.UTF-8', 08:00:38 INFO - 'LANGUAGE': 'en_US:en', 08:00:38 INFO - 'LOGNAME': 'cltbld', 08:00:38 INFO - 'MAIL': '/var/mail/cltbld', 08:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:38 INFO - 'MOZ_NO_REMOTE': '1', 08:00:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:38 INFO - 'NO_EM_RESTART': '1', 08:00:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:38 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:38 INFO - 'SHELL': '/bin/bash', 08:00:38 INFO - 'SHLVL': '1', 08:00:38 INFO - 'TERM': 'linux', 08:00:38 INFO - 'TMOUT': '86400', 08:00:38 INFO - 'USER': 'cltbld', 08:00:38 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025', 08:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:38 INFO - '_': '/tools/buildbot/bin/python'} 08:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:00:38 INFO - Running setup.py (path:/tmp/pip-XkeLPA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:00:38 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)) 08:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:00:38 INFO - Running setup.py (path:/tmp/pip-8wZaRY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:00:38 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)) 08:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:00:38 INFO - Running setup.py (path:/tmp/pip-dY21Kh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:00:38 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)) 08:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:00:38 INFO - Running setup.py (path:/tmp/pip-2f2lCM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:00:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:00:38 INFO - Running setup.py (path:/tmp/pip-06kxFZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:00:38 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)) 08:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:00:38 INFO - Running setup.py (path:/tmp/pip-p7iCjb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:00:38 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)) 08:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:00:38 INFO - Running setup.py (path:/tmp/pip-scui2U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:00:38 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)) 08:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:00:38 INFO - Running setup.py (path:/tmp/pip-8tqFnu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:00:38 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)) 08:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:00:38 INFO - Running setup.py (path:/tmp/pip-zx6lnP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:00:39 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)) 08:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:00:39 INFO - Running setup.py (path:/tmp/pip-_T0ZPN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:00:39 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)) 08:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:00:39 INFO - Running setup.py (path:/tmp/pip-zrFMql-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:00:39 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)) 08:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:00:39 INFO - Running setup.py (path:/tmp/pip-lRbc7U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:00:39 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)) 08:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:00:39 INFO - Running setup.py (path:/tmp/pip-JD0EbT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:00:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 08:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:00:39 INFO - Running setup.py (path:/tmp/pip-bgsw8k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:00:39 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)) 08:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:00:39 INFO - Running setup.py (path:/tmp/pip-gNvSf4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:00:39 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)) 08:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:00:39 INFO - Running setup.py (path:/tmp/pip-4F1usN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:00:39 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)) 08:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:00:39 INFO - Running setup.py (path:/tmp/pip-9s44FB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:00:39 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)) 08:00:39 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)) 08:00:39 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)) 08:00:39 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)) 08:00:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:00:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:00:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:41 INFO - Downloading blessings-1.6.tar.gz 08:00:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:00:41 INFO - Installing collected packages: blessings 08:00:41 INFO - Running setup.py install for blessings 08:00:41 INFO - Successfully installed blessings 08:00:41 INFO - Cleaning up... 08:00:41 INFO - Return code: 0 08:00:41 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:00:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:00:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:00:41 INFO - Reading from file tmpfile_stdout 08:00:41 INFO - Current package versions: 08:00:41 INFO - argparse == 1.2.1 08:00:41 INFO - blessings == 1.6 08:00:41 INFO - blobuploader == 1.2.4 08:00:41 INFO - docopt == 0.6.1 08:00:41 INFO - manifestparser == 1.1 08:00:41 INFO - mozInstall == 1.12 08:00:41 INFO - mozcrash == 0.16 08:00:41 INFO - mozdebug == 0.1 08:00:41 INFO - mozdevice == 0.48 08:00:41 INFO - mozfile == 1.2 08:00:41 INFO - mozhttpd == 0.7 08:00:41 INFO - mozinfo == 0.9 08:00:41 INFO - mozleak == 0.1 08:00:41 INFO - mozlog == 3.1 08:00:41 INFO - moznetwork == 0.27 08:00:41 INFO - mozprocess == 0.22 08:00:41 INFO - mozprofile == 0.28 08:00:41 INFO - mozrunner == 6.11 08:00:41 INFO - mozscreenshot == 0.1 08:00:41 INFO - mozsystemmonitor == 0.0 08:00:41 INFO - moztest == 0.7 08:00:41 INFO - mozversion == 1.4 08:00:41 INFO - psutil == 3.1.1 08:00:41 INFO - requests == 1.2.3 08:00:41 INFO - wsgiref == 0.1.2 08:00:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:00: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')]} 08:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00: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')]} 08:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb404553f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec9670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f588c0>, '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 0x1f597c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f59c50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025', '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 08:00:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 08:00:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:00:41 INFO - Using env: {'DISPLAY': ':0', 08:00:41 INFO - 'HOME': '/home/cltbld', 08:00:41 INFO - 'LANG': 'en_US.UTF-8', 08:00:41 INFO - 'LANGUAGE': 'en_US:en', 08:00:41 INFO - 'LOGNAME': 'cltbld', 08:00:41 INFO - 'MAIL': '/var/mail/cltbld', 08:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:41 INFO - 'MOZ_NO_REMOTE': '1', 08:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:41 INFO - 'NO_EM_RESTART': '1', 08:00:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:41 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:41 INFO - 'SHELL': '/bin/bash', 08:00:41 INFO - 'SHLVL': '1', 08:00:41 INFO - 'TERM': 'linux', 08:00:41 INFO - 'TMOUT': '86400', 08:00:41 INFO - 'USER': 'cltbld', 08:00:41 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025', 08:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:41 INFO - '_': '/tools/buildbot/bin/python'} 08:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 08:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 08:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 08:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 08:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 08:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 08:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 08:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 08:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 08:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 08:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 08:00:42 INFO - Cleaning up... 08:00:42 INFO - Return code: 0 08:00:42 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb404553f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec9670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f588c0>, '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 0x1f597c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f59c50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025', '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 08:00:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 08:00:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:00:42 INFO - Using env: {'DISPLAY': ':0', 08:00:42 INFO - 'HOME': '/home/cltbld', 08:00:42 INFO - 'LANG': 'en_US.UTF-8', 08:00:42 INFO - 'LANGUAGE': 'en_US:en', 08:00:42 INFO - 'LOGNAME': 'cltbld', 08:00:42 INFO - 'MAIL': '/var/mail/cltbld', 08:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:42 INFO - 'MOZ_NO_REMOTE': '1', 08:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:42 INFO - 'NO_EM_RESTART': '1', 08:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:42 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:42 INFO - 'SHELL': '/bin/bash', 08:00:42 INFO - 'SHLVL': '1', 08:00:42 INFO - 'TERM': 'linux', 08:00:42 INFO - 'TMOUT': '86400', 08:00:42 INFO - 'USER': 'cltbld', 08:00:42 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025', 08:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:42 INFO - '_': '/tools/buildbot/bin/python'} 08:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:42 INFO - Downloading/unpacking jsonschema 08:00:42 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 08:00:42 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 08:00:42 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 08:00:42 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 08:00:42 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 08:00:42 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 08:00:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:00:44 INFO - Downloading/unpacking functools32 (from jsonschema) 08:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:44 INFO - Downloading functools32-3.2.3-2.tar.gz 08:00:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:00:44 INFO - warning: no files found matching '*.txt' 08:00:44 INFO - no previously-included directories found matching 'build' 08:00:44 INFO - no previously-included directories found matching 'dist' 08:00:44 INFO - no previously-included directories found matching '.git*' 08:00:44 INFO - Installing collected packages: jsonschema, functools32 08:00:44 INFO - Running setup.py install for functools32 08:00:44 INFO - warning: no files found matching '*.txt' 08:00:44 INFO - no previously-included directories found matching 'build' 08:00:44 INFO - no previously-included directories found matching 'dist' 08:00:44 INFO - no previously-included directories found matching '.git*' 08:00:44 INFO - Successfully installed jsonschema functools32 08:00:44 INFO - Cleaning up... 08:00:44 INFO - Return code: 0 08:00:44 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:00:44 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')]} 08:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:44 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')]} 08:00:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb404553f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec9670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f588c0>, '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 0x1f597c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f59c50>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025', '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 08:00:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 08:00:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:00:44 INFO - Using env: {'DISPLAY': ':0', 08:00:44 INFO - 'HOME': '/home/cltbld', 08:00:44 INFO - 'LANG': 'en_US.UTF-8', 08:00:44 INFO - 'LANGUAGE': 'en_US:en', 08:00:44 INFO - 'LOGNAME': 'cltbld', 08:00:44 INFO - 'MAIL': '/var/mail/cltbld', 08:00:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:44 INFO - 'MOZ_NO_REMOTE': '1', 08:00:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:44 INFO - 'NO_EM_RESTART': '1', 08:00:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:00:44 INFO - 'PWD': '/builds/slave/test-pgo', 08:00:44 INFO - 'SHELL': '/bin/bash', 08:00:44 INFO - 'SHLVL': '1', 08:00:44 INFO - 'TERM': 'linux', 08:00:44 INFO - 'TMOUT': '86400', 08:00:44 INFO - 'USER': 'cltbld', 08:00:44 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025', 08:00:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:44 INFO - '_': '/tools/buildbot/bin/python'} 08:00:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:44 INFO - Downloading/unpacking flake8 08:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:00:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:00:46 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 08:00:46 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 08:00:46 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 08:00:46 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 08:00:46 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 08:00:46 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 08:00:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:00:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:00:46 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 08:00:46 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 08:00:46 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 08:00:46 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 08:00:46 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 08:00:46 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 08:00:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:00:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:00:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:00:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:00:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:00:47 INFO - no previously-included directories found matching 'docs/_build' 08:00:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:00:47 INFO - Running setup.py install for pep8 08:00:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:00:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:00:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:00:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:00:47 INFO - no previously-included directories found matching 'docs/_build' 08:00:47 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:00:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:00:47 INFO - Cleaning up... 08:00:47 INFO - Return code: 0 08:00:47 INFO - Running post-action listener: _resource_record_post_action 08:00:47 INFO - Running post-action listener: _start_resource_monitoring 08:00:47 INFO - Starting resource monitoring. 08:00:47 INFO - ##### 08:00:47 INFO - ##### Running install step. 08:00:47 INFO - ##### 08:00:47 INFO - Running pre-action listener: _resource_record_pre_action 08:00:47 INFO - Running main action method: install 08:00:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:00:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:00:47 INFO - Reading from file tmpfile_stdout 08:00:47 INFO - Detecting whether we're running mozinstall >=1.0... 08:00:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:00:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:00:47 INFO - Reading from file tmpfile_stdout 08:00:47 INFO - Output received: 08:00:47 INFO - Usage: mozinstall [options] installer 08:00:47 INFO - Options: 08:00:47 INFO - -h, --help show this help message and exit 08:00:47 INFO - -d DEST, --destination=DEST 08:00:47 INFO - Directory to install application into. [default: 08:00:47 INFO - "/builds/slave/test-pgo"] 08:00:47 INFO - --app=APP Application being installed. [default: firefox] 08:00:47 INFO - mkdir: /builds/slave/test-pgo/build/application 08:00:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 08:00:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 08:01:04 INFO - Reading from file tmpfile_stdout 08:01:04 INFO - Output received: 08:01:04 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:01:04 INFO - Running post-action listener: _resource_record_post_action 08:01:04 INFO - ##### 08:01:04 INFO - ##### Running run-tests step. 08:01:04 INFO - ##### 08:01:04 INFO - Running pre-action listener: _resource_record_pre_action 08:01:04 INFO - Running main action method: run_tests 08:01:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:01:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:01:04 INFO - Python 2.7.3 08:01:04 INFO - Return code: 0 08:01:04 INFO - grabbing minidump binary from tooltool 08:01:04 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')]} 08:01:04 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 0x1f588c0>, '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 0x1f597c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f59c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:01:04 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 08:01:04 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 08:01:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:01:04 INFO - Return code: 0 08:01:04 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:01:04 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:01:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:01:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:01:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:01:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:01:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:01:05 INFO - Return code: 0 08:01:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 08:01:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:01:05 INFO - Using env: {'DISPLAY': ':0', 08:01:05 INFO - 'HOME': '/home/cltbld', 08:01:05 INFO - 'LANG': 'en_US.UTF-8', 08:01:05 INFO - 'LANGUAGE': 'en_US:en', 08:01:05 INFO - 'LOGNAME': 'cltbld', 08:01:05 INFO - 'MAIL': '/var/mail/cltbld', 08:01:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:01:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:01:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:05 INFO - 'MOZ_NO_REMOTE': '1', 08:01:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:01:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:05 INFO - 'NO_EM_RESTART': '1', 08:01:05 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:01:05 INFO - 'PWD': '/builds/slave/test-pgo', 08:01:05 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:01:05 INFO - 'SHELL': '/bin/bash', 08:01:05 INFO - 'SHLVL': '1', 08:01:05 INFO - 'TERM': 'linux', 08:01:05 INFO - 'TMOUT': '86400', 08:01:05 INFO - 'USER': 'cltbld', 08:01:05 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025', 08:01:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:05 INFO - '_': '/tools/buildbot/bin/python'} 08:01:05 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:01:05 INFO - mozversion application_buildid: 20160229053003 08:01:05 INFO - mozversion application_changeset: 76c51477853faeac91211c2adee7adfee858b276 08:01:05 INFO - mozversion application_display_name: Nightly 08:01:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:01:05 INFO - mozversion application_name: Firefox 08:01:05 INFO - mozversion application_remotingname: firefox 08:01:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:01:05 INFO - mozversion application_vendor: Mozilla 08:01:05 INFO - mozversion application_version: 47.0a1 08:01:05 INFO - mozversion platform_buildid: 20160229053003 08:01:05 INFO - mozversion platform_changeset: 76c51477853faeac91211c2adee7adfee858b276 08:01:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:01:05 INFO - mozversion platform_version: 47.0a1 08:01:05 INFO - using testdate: 1456761665 08:01:05 INFO - actual date: 1456761665 08:01:05 INFO - starting webserver on 'localhost:40474' 08:01:05 INFO - SUITE-START | Running 2 tests 08:01:05 INFO - TEST-START | dromaeo_css 08:01:05 INFO - operating with platform_type : linux_ 08:01:05 INFO - Initialising browser for dromaeo_css test... 08:01:05 INFO - TEST-INFO | started process 3897 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpv3u7of/profile http://localhost:40474/getInfo.html) 08:01:09 INFO - PROCESS | 3897 | 08:01:09 INFO - PROCESS | 3897 | (process:3983): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:01:10 INFO - PROCESS | 3897 | __metrics Screen width/height:1600/1200 08:01:10 INFO - PROCESS | 3897 | colorDepth:24 08:01:10 INFO - PROCESS | 3897 | Browser inner width/height: 1024/697 08:01:10 INFO - PROCESS | 3897 | __metrics 08:01:11 ERROR - PROCESS | 3897 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 08:01:11 INFO - PROCESS | 3897 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:01:11 INFO - PROCESS | 3897 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:01:11 INFO - PROCESS | 3897 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:01:11 INFO - PROCESS | 3897 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:01:11 INFO - PROCESS | 3897 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:01:11 INFO - PROCESS | 3897 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:01:11 INFO - PROCESS | 3897 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:01:11 INFO - PROCESS | 3897 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:01:11 INFO - PROCESS | 3897 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:01:11 INFO - TEST-INFO | 3897: exit 0 08:01:11 INFO - Browser initialized. 08:01:11 INFO - Running cycle 1/1 for dromaeo_css test... 08:01:12 INFO - TEST-INFO | started process 4034 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpv3u7of/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:01:13 INFO - PROCESS | 4034 | 08:01:13 INFO - PROCESS | 4034 | (process:4093): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:01:23 INFO - PROCESS | 4034 | RSS: Main: 161263616 08:01:23 INFO - PROCESS | 4034 | 08:02:13 INFO - PROCESS | 4034 | 1456761733449 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] 08:04:22 INFO - PROCESS | 4034 | Cycle 1(1): loaded http://localhost:40474/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40474/tests/dromaeo/cssquery-ext.html) 08:04:23 INFO - PROCESS | 4034 | RSS: Main: 170196992 08:04:23 INFO - PROCESS | 4034 | 08:07:25 INFO - PROCESS | 4034 | Cycle 1(1): loaded http://localhost:40474/tests/dromaeo/cssquery-ext.html (next: http://localhost:40474/tests/dromaeo/cssquery-jquery.html) 08:07:26 INFO - PROCESS | 4034 | RSS: Main: 166625280 08:07:26 INFO - PROCESS | 4034 | 08:10:27 INFO - PROCESS | 4034 | Cycle 1(1): loaded http://localhost:40474/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40474/tests/dromaeo/cssquery-mootools.html) 08:10:28 INFO - PROCESS | 4034 | RSS: Main: 167243776 08:10:28 INFO - PROCESS | 4034 | 08:13:30 INFO - PROCESS | 4034 | Cycle 1(1): loaded http://localhost:40474/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40474/tests/dromaeo/cssquery-prototype.html) 08:13:30 INFO - PROCESS | 4034 | RSS: Main: 164663296 08:13:30 INFO - PROCESS | 4034 | 08:16:33 INFO - PROCESS | 4034 | Cycle 1(1): loaded http://localhost:40474/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40474/tests/dromaeo/cssquery-yui.html) 08:16:33 INFO - PROCESS | 4034 | RSS: Main: 166248448 08:16:33 INFO - PROCESS | 4034 | 08:19:36 INFO - PROCESS | 4034 | Cycle 1(1): loaded http://localhost:40474/tests/dromaeo/cssquery-yui.html (next: http://localhost:40474/tests/dromaeo/cssquery-dojo.html) 08:19:36 INFO - PROCESS | 4034 | RSS: Main: 168820736 08:19:36 INFO - PROCESS | 4034 | 08:19:36 INFO - PROCESS | 4034 | __start_tp_report 08:19:36 INFO - PROCESS | 4034 | _x_x_mozilla_page_load 08:19:36 INFO - PROCESS | 4034 | _x_x_mozilla_page_load_details 08:19:36 INFO - PROCESS | 4034 | |i|pagename|runs| 08:19:36 INFO - PROCESS | 4034 | |0;dojo.html;3163.066895265896;3210.1011716719327;3220.2432428379325;3276.3938671345795;3284.293876816484;5297.708626025567;5336.306280183576;5380.085385484467;5420.485053919876;5425.891482170354;5381.892362152755;5390.78436862525;5426;5436.374816896048;5500.22996780451;4900.975495122529;4945.703257804544;4964.081644895706;5005.924911126336;5083.389993200821;5000.299958005882;5009.398872135331;5038.067957427869;5042.773075211624;5116.513931176532;4845.927311090337;4920.384951880997;4954.157793175169;4962.727050012248;4978.402591688984;4915.5821755150855;4922.704637721712;4938.209886418192;4943.555080042777;4952;4789.114013907403;4898.21628539432;4909.7790599423115;4922.704637721748;4973.825916092956;5277.788888444457;5278.815241466568;5323.041852466555;5339.199120132012;5355.571554275649;5867.853303667443;5886.764529418818;5887.35239123696;5888.381719919433;5889.057750759858;5770.682612456313;5846.035404158309;5907.232059832194;5911.320198177222;5927.466528012456;5443.510084092451;5507.146392309199;5507.531859791922;5509.47659972306;5512.503874651301;5973.880522389528;5978.521718262528;5982.790602328984;5986.9401305986385;5987.042073268256;5691.231683722727;5706.3722990471015;5730.484256416942;5757.395473475225;5800.535957123504;5876.941230587639;5880.26496687914;5889;5890.234269545017;5904.232449781501;5690.118031705092;5751.827445176651;5822;5873.706314684248;5905.143754155623;5708.20085188074;5732.34078081026;5810.389909059572;5817.418258174149;5846.152307915413;4443.866683999485;4480.215962206601;4493.618042466362;4494.235979883428;4521.909561808746;3991.7604943703473;3999.3601023836045;4007.499062617173;4027.8993025174605;4031.8185681644395;5385.838424847182;5427.891442171213;5469.15228139639;5509.944900550943;5528.06022976095;5844.620099693507;5856.4143585641095;5875;5902.734376953047;5908.231929849092;5391;5460.5085542301385;5465.617406781566;5473.343198816167;5493.587980901449;4937.35814344133;4939.728314942641;4943.8516844494725;4953.6037117030555;4984.800607975713;6039.577229593886;6039.758409663565;6040.124181993587;6043.546733994968;6055.848603784941;5692.260006199168;5815.854603634773;5825.94174058271;5837.503812176013;5867.767768768435;6106.603070800384;6117.431594453822;6119.571769464861;6121.452487244962;6123.038605230386;5752.6836024019085;5796.101604251347;5810.012297909281;5821.388754180919;5862.062070068769;5822.301323840997;5833;5883.35283118848;5889.234399528034;5904.645721256738;5650.604457687922;5688.004599195207;5697.7151142443545;5733.71331433435;5765.250517432707;5553.305836770403;5579.4420557945505;5617.634853734494;5621.016322143527;5627.127795191752;5542.224088627515;5566.443355664564;5574.637648552831;5632.464915833153;5640.605157638925;5635.830925072254;5696.715164241688;5786.768529258782;5804.2744656917885;5807.361190268983;5624.606277560531;5634.183043458757;5640.858978525405;5643.858903527281;5673.716314184357 08:19:36 INFO - PROCESS | 4034 | |1;ext.html;523.2778765303881;534.1107056750508;536.241218675574;553.3194171169464;555.336373034224;34515;34557;34839.4774078389;34857.65142348576;34997.82501087494;35628.28743425137;36054.63945360546;36135.928446082115;36202.81898590503;36242.09394765132;8414.789630259247;8703.912960870373;8710.564471776417;8715.520646364448;8716.912830871705;8588.355873309496;8709.129087091273;8711.43375680582;8717.782055448633;8753.824923501526;8745.125487451267;8817.779555511099;8832.514211718353;8845.95577022114;8858.114188581123;8651.04838467768;8738.388312818106;8750.824983500326;8754.60604272806;8789.121087891224;8552.828943421158;8626.439281446748;8656.437331573428;8661;8716.694915677921;36742.8162859184;36951.445728314095;37162.62837371619;37254.81372593147;37303.813480932695;3223.6131664200448;3458.291050334675;3471.340445315382;3480.7215422766117;3550.4496802995577;27249.727502724916;27349.45301093987;27391.17826465209;27411.622384515547;27953.720462795314;3622.6196249393697;3647.252313275772;3724.718042315954;3875.4961854958956;3884.7086468514976;261091;263531;263628;263941;264472;59603.40396596065;60660;60672.696636517416;60748.69625651844;60849;64084.35915640877;64403;64654.67672661607;65158;66201.33798662048;15909.124998125215;16225.107619080827;16314.75527867083;16323.18384080815;16330.591735206715;12313.26120432777;12336.259824410565;12380.133390662568;12382.257064576153;12418.130730848754;19455.708164377545;20230.291939782037;20447.18211271562;20483.69274460884;20601.48496287605;7969.8406031880195;8089.110197878229;8170.550619715973;8282.012317043866;8339.83320333602;966.6906589891167;972.0813830929703;1020.2501161646184;1045.6183493025144;1121.870984836738;28325;28514.572281415796;28514.857425713155;28581.28546786347;28612.284692882844;1074.6937122920087;1090.111559079348;1100.8403781451646;1105.6848798092506;1186.258588382261;14653.706925861636;14755.77866332006;14782.48261310849;14827.851721482863;15228.847711522743;309042;311293;312347;313836;315018;50839.74580127076;51531;51800;51822;51865.48134518607;1331.5472739268696;1379.593020059085;1390.0547627613118;1392.470861072786;1397.1477398786733;26957.865210673823;27771.722282776915;28269.293267668472;28324.150275491767;28635.856820716595;44763.32855007112;45109;45194;45211.54788452073;45225.773871130434;291260;294592;296463;298978;300025;31548.211294717814;31749.20626984344;32058.6794132065;32229.51655725213;32299.19252018718;42605.5739442614;42622.147557049306;43398.566014340715;43543.346849796646;43747;35547.28905421825;35825;36228.4565731509;36350.45474317834;36546.8172659135;36569.08577285589;36645.450318244715;36996.815015924745;37160.44259336058;37218;36193;38435;39449.60550394459;39618.80190599029;39770.2045959085;28473.857630711715;32409.35181296408;32685.18287042843;33077;33528.329433410705;25339.239822805346;25557.233283000794;25685;25729.485410291316;26102 08:19:36 INFO - PROCESS | 4034 | |2;jquery.html;333.84809911490277;335.70290293090625;337.49712927737676;338.84582514955684;343.354493552122;16270.755938660915;16423.753643695338;17096.059716715576;17693.55766105848;17760.822391776077;16392.426265080725;16541.090240036792;16913.985160890355;17292.56768580783;17294.654106917853;5263.236830659552;5267.525922666969;5416.539594134503;5430.945690543103;5450.236966824647;5306.4958828911385;5345.1714984177515;5351.384590772072;5353.5984801139875;5403.2705584746145;5169.198774190007;5311.097113490716;5311.787528498855;5312.123499622558;5325.733713314338;5257.737113144347;5346.91979620304;5352.91970620441;5374.973125134388;5388.757505912244;4737.8341758038305;4755.476897541268;4770.904581908342;4782.545658162504;4783.019481006385;20366.389008329774;20421.081051352725;20459.38621841347;20627;20948.790512094838;2150.2151714624206;2234;2275.2605403243847;2305.5388922215625;2314.6412306092584;13045.282509461977;13094.279814610192;13182.340882955814;13333.133346332554;13337.066405351628;1875.0530981854213;1901.3060233014987;1905.3807512558335;1927.5952050069502;1955.8141976512209;51676.48323516754;55984.440155598735;57007.144892827055;60496.69751651258;64271.357286427;9032.593533291018;9090.181883630505;9404;9449.858252126223;9454.90545094554;12227.388630568614;12230.021598272117;12315.568955086528;12342.074344424203;12396.876031239752;7621;7749;7768.106667733283;7783.455158138989;7829.3345065670055;7790.688372465038;7838.137804841463;7865.764027079197;7902.881456778153;7913.841723165505;5633.605647604629;5751.59738818287;5824.6796426196115;5833.88332233353;5851.795187168429;1731.463246393622;1762.1101343821545;1766.1963806468027;1779.661864245789;1788.3115000724554;905.3526728389234;946.6355453150586;1001.5242759689089;1015.7816069545083;1074.7474343529263;15476.76784848228;15678.216089195495;16833;17195.22621482011;17328.566785830455;965.4979410706393;970.8592254123254;1005.3666190300064;1026.9537870795832;1114.5318966034285;9646.5530170475;9688.176504997155;9875.308728389087;9971.202303815677;10090.899091008996;321859;333657;337561;446849;450402;67630.32369676339;67918.3208167912;69099.30900690929;69658;72434.63782681053;1012.5089331674133;1035.021904300444;1054.546544985648;1056.1339701444742;1066.2376400873259;14797.778033329294;15105.244737763287;15219.701107194456;15432.151231682365;15482.380704771684;22570.887145564167;23367.41581460477;30743.385132297677;33900;35565.82217088898;43767.78116109399;48023.5197648033;48127;48345;48735.75632121817;7521.4734968551675;7606.239376062349;7791.883121753065;7805.570693611906;7811.531308121531;8721.956390218009;11423.428828558373;12425.751484970431;12597;12597.811032834697;10211.642592509226;10692.251542391958;10745.623903163352;10801.243912926335;10882.075023623082;10795.514201860778;10895.291806032583;10906.236563440483;11142.387168705798;11231.494582743633;10674.412907290174;10986.505607247533;10998.670039898816;11105.833412498658;11179.273347232729;7426.925730742623;7644.464887457824;7779.338756205786;7823.608819558885;7936.325412339785;9302;10487.475626218506;10590.735231619272;10621;11166.72083197894 08:19:36 INFO - PROCESS | 4034 | |3;mootools.html;1472.3374481483331;1523.756199008159;1685.662867426515;1802.9008404537744;1814.156417265971;6989.89515157273;7664.271894170059;7853.48952318099;8066.959665201681;8073.919260807397;7622.695092196319;7643.808904777384;7721.30508254257;7731.574763388011;7773.455858089936;2278.2481781012266;2282.7032485776826;2285.0631241191113;2287.5081857400655;2302.8157747380255;2236.4856083100894;2244.820414366855;2254.797068263856;2274.1471948019494;2287.748347681754;2224.67742177385;2233.6091184042807;2263.128695452246;2265.7054582904198;2273.443006463419;2199.9340019799433;2207.9558408831895;2210.7568167501563;2222.744384395799;2229.6321107017325;2263.6265016272296;2264.9320520384413;2268.2514770125817;2270.9545809083893;2279.338991692407;8028.956235689381;8048.430556041574;8093.028836539653;8102.959485202595;8115.634796434175;4771.403574553181;4859.684120532154;4868.9269660955115;4879.536444037811;4890.902181956377;3012.9849350753325;3018.24543864034;3132;3132.37352529495;3166.62000559932;1052.3054783842704;1053.4153544782644;1976.9209231630718;1992.5516758729316;1999.9200031998703;10710.571577136905;10712;10772.29980051302;10842.512086956027;10897.509612067397;4058.837646494166;4167.666586673059;4217.388478670576;4231.407602935591;4255.914881702349;8126.10612832588;8145;8146.185381461806;8189.344852411793;8192.918070819334;4763.476017638057;4765.714057156512;4788.162071637449;4795.664303498791;4812;4347.4348334716915;4447.132809102259;4448.110377924428;4477.619402350771;4493.438320209973;3486.1981744198974;3514.38498262803;3535;3542.787432754043;3546.929061418757;1087.342157994402;1106.1261603333437;1114.1699433921617;1117.502711293483;1128.1707944660668;1102.6416414665266;1109.8168802147716;1122.7586068995206;1283.6020833541631;1373.0525937103366;7216.278372162742;7224.277572242839;7253.274672532704;7258.564486130849;7719.768406947801;496.7565892712617;497.4329264638315;503.92189210672404;506.11177383691387;507.88318686701524;5466.535344495763;5516.365617953907;5556.611037227436;5585.972070139624;5601.187827764951;9212.907870921339;9427.198688111588;9429.62281508732;9467.526623668928;9509.619615215452;9510.191633711074;9645.131938125602;9680.854787178198;9710.417374957526;9727.221822254203;7373.635877362705;7564.4704870659625;7576.052993375828;7604.315611594983;7616.771496855104;7041.612711300722;7046.436285097077;7056.364927156581;7080.681369338495;7097.609631470319;8360.331173506227;8422.326213902996;8557.35819813504;8681.479111253346;8689.956550217208;8528.445651032664;8557.786055348666;8611.741647750578;8655.437396569203;8758.60586273632;6370.77702280418;6612.702428390638;6775.288594697486;6961.547499412522;7023.543469674455;7367.447441441806;7410.481266311306;7440.776776696708;7446.106467223751;7446.664900079618;6600.768973085919;6745.460363171032;6789.1852977643;6865.5537390069485;6914.51598388108;6694.163229596301;6714.899276510759;6785.660716964231;6796.082528858541;6916.20463646687;6809.659517024228;6817.659117044227;6843.452523797984;6849.869771487649;6852.177738671391;6430.421262086247;6507.414332710079;6510.934890651033;6520.608763474207;6530.67346632676;6452.35476452351;6476.676166191766;6502.122213501306;6508.60948343101;6521.67391630426 08:19:36 INFO - PROCESS | 4034 | |4;prototype.html;313.4452019924733;323.6989599672304;325.2373184881452;326.84311530465374;330.1844444222769;6286.9685651571735;6313;6361.554691171608;6372.617642941421;6404.359564043593;6230.096635987779;6257.687115644211;6259.405356491126;6275;6276.592021518598;4564.6348292136545;4605.631549476034;4644.6516511261625;4707.011527579212;4784.282357646346;4689.62483001359;4693.108309421199;4694.859154225362;4697.882552936187;4709.693869898446;4613.169629466712;4631.189541830183;4633.351330813689;4637.026224492861;4662.207424737802;4626.884327891796;4647.907041859161;4659.138059458977;4672.322513235562;4675;4003.799810009488;4009.67922566194;4015.277250095011;4020.839166433339;4024.517057953035;5788.797392091299;5963.582549221556;5977.7608895644125;5985.371535988702;5993.0710739835395;5370.731463426852;5387.653086728318;5405.351357837046;5442.537384322298;5447.809326673548;6600.834979125512;6644.036614690891;6670.6331151786635;6687.632180230085;6696.933030669679;4379.978100109511;4399.318105693623;4409.11817636474;4412.183746006999;4422.071365013351;6880.380765731108;6929.965350173217;6943.513954023271;6972.058772065757;6980.581165130108;4414.888337468983;4526.615237704832;4529.048899731093;4529.728216307032;4534.501204867528;4536.047430039663;4550.408446901882;4556.24821904382;4556.726596404226;4581.610563102174;5338.626296159309;5385.407605163429;5395.2986111806;5407.594430417735;5415.431379705153;6667.533272670964;6699.062131301622;6778.661066946633;6781.6609169541325;6788.864222715518;1662.81709012011;1666.8833181677167;1669.0403018264547;1675.9106580722628;1676.6227598790174;1066;1097.8353247013013;1112.7051331397186;1117.519466629341;1122.971925701864;6238.095476155932;6248.687565621701;6255.437010669061;6255.562110652301;6272.153259310026;6813.7955861324235;6847.691853866489;6855.108835851307;6862.862742745117;6870.244273129952;6130.969345153246;6209.534284928648;6249.281332646713;6362.363763623694;6371.904421433682;3733.1227161617;3742.6631603155847;3743.494628225209;3756.286305601927;3757.8496860125833;7307.451941104438;7310.96344518274;7314.670839812221;7317.231690672509;7336.339729424378;7092.893606595905;7108.928910710827;7144.214136444987;7149.964250178716;7162;7047.506674532836;7261.745838895613;7296.890546641805;7299.817504562322;7315.963420182971;6877.965610171917;6932.445404367538;6934.549254298455;6936.20233673134;6954.79135625932;6853.417459515997;6893.931060689329;6897.2757860423935;6909.7581584644295;6915.273896241023;7239.819004524929;7253.637318134178;7260.201377848327;7261.782146535613;7275.090613673291;4546.931796023128;4672.08894265615;4677.7193368398;4680.134175177603;4690.742009189391;6915.585064896122;6959.582425054513;6973.931470153117;6993.860122797617;6995.440364770908;6679.799606011828;6717.697703603448;6753.662316884234;6764.86470270582;6768.898466522907;6675.899861502178;6721.798346049626;6722.865542689216;6726.327367263235;6755.6622168892345;6492.707828147839;6613.107230523818;6627.403533681992;6627.9337206627315;6642.269350371552;6727.73089076451;6740.876623863467;6778.288279730755;6785.287544807724;6785.93214067853;6575.638339891352;6620.3710647488415;6634.568753031038;6636.170478690164;6644.568103073285 08:19:36 INFO - PROCESS | 4034 | |5;yui.html;746.8879668049793;800.1998001997998;804.2279411764702;805.8106345008925;818.5129847740596;13747.656308592277;13817.240051797135;13924.51264205753;13926.094803837743;13957.023008389391;13082.345882705875;13144.342782860867;13145.802812957812;13222.603321900335;13239.205647661147;803.3492870774662;811.4319976016783;831.9126491718373;832.5171400587644;835.6197929941862;814.1288820961573;818.2431251092745;822.5229366967175;825.3850881093593;826.1325608111489;857.9828403431927;860.0539406652663;863.7797361672796;865.2515574028452;865.7575878753928;852.4586887326531;853.714005808055;857.9313654907593;858.2361698088706;858.9141085891423;626.2891618013542;630.8044506203091;633.6261605652641;634.0679201573679;635.1742734445203;14265.857341426557;14307.92690548213;14329.283535823168;14337.928310358486;14376.64058398538;12320.568780092743;12480.188787728768;12684.42920068599;12779.233246005177;12934.094613377067;10547.419891905942;10637.893621063768;10710.732231694192;10738.785224295549;10962.376788829804;3652.196516766307;3657.2868290683327;3666.17511060012;3747.1006958330076;3826.693864490862;48053;48803.267950980764;48817.267740983916;48903.51096489061;49065;9957.103860652576;10037.197024238043;10051.547680354402;10225.590976360862;10596.682099537025;18114.63770724578;18160.727589086175;18178.818211817714;18219.180136893872;18249.361272355403;7710.306072453506;7767.18444563324;7782.766517004499;8023.558704271204;8044.477108988014;4231.4710661167355;4327.956720432819;4411.2721400968485;4414.867553973386;4461.843835465808;3276.639569647337;3305.1241421023446;3312.2381852174135;3319.186799234155;3319.286353434023;597.5578072226521;599.5173885022512;600.4655856287907;614.0390289197392;619.8574327904607;632.8386261503288;658.1082633032269;658.2495954611746;663.2604645819972;668.4819265069513;7486.812829679193;7750.341220996165;7782.844343113106;7807.921920780833;8020.839583208303;517.4385791416355;629.9762885311369;652.5203975078314;656.7734131724548;663.8207683925409;3683.7053035757076;3813.447577535326;3900.531936167621;3957.821898014596;4214.220369231702;54846.72576637091;56347;56847.43152568422;56864.43135568591;56925.71537142288;46800.29799553009;47337.763311183226;47921.76039119782;48161.277580836315;48993.510064898896;45454.77272613616;46031;46851.765741171075;48128;49084.75457622689;8368.288695460955;8464.915350846413;8504.404691671523;8692.608832602422;8699.304055675404;33878.66121338755;34515.82742086273;35293.47059794157;35323.64676353204;35692;39395.40906886457;40278.798606006785;42437;43183.35224971691;43884;11326.263792853439;11361.318320900773;11435;11441.771164576829;11659.06727461784;12424.503019879103;12451.750964980469;12587.74824503523;12793.87206127964;12958.249742990842;11241.437928103725;11597.18819682614;11612.419379030845;11892.821607676065;11952;11733.413329333329;11957.342346171044;11964.341961192218;12353;12383.19509231933;10741.731456713645;11415.315081094828;11865.288082715064;12004.2197257178;12078.698032549257;9965.750856228362;10241.897581024094;10284.742881428025;10361.4301213434;10404.485861951893;9100.362974591715;9355.719328420158;9591;9758.951205243928;9816.116549510578 08:19:36 INFO - PROCESS | 4034 | __end_tp_report 08:19:36 INFO - PROCESS | 4034 | __start_cc_report 08:19:36 INFO - PROCESS | 4034 | _x_x_mozilla_cycle_collect,321 08:19:36 INFO - PROCESS | 4034 | __end_cc_report 08:19:36 INFO - PROCESS | 4034 | __startTimestamp1456762776542__endTimestamp 08:19:36 INFO - PROCESS | 4034 | 08:19:36 INFO - PROCESS | 4034 | ------- Summary: start ------- 08:19:36 INFO - PROCESS | 4034 | Number of tests: 6 08:19:36 INFO - PROCESS | 4034 | 08:19:36 INFO - PROCESS | 4034 | [#0] dojo.html Cycles:165 Average:5417.07 Median:5624.61 stddev:611.09 (10.9%) stddev-sans-first:586.83 08:19:36 INFO - PROCESS | 4034 | Values: 3163.1 3210.1 3220.2 3276.4 3284.3 5297.7 5336.3 5380.1 5420.5 5425.9 5381.9 5390.8 5426.0 5436.4 5500.2 4901.0 4945.7 4964.1 5005.9 5083.4 5000.3 5009.4 5038.1 5042.8 5116.5 4845.9 4920.4 4954.2 4962.7 4978.4 4915.6 4922.7 4938.2 4943.6 4952.0 4789.1 4898.2 4909.8 4922.7 4973.8 5277.8 5278.8 5323.0 5339.2 5355.6 5867.9 5886.8 5887.4 5888.4 5889.1 5770.7 5846.0 5907.2 5911.3 5927.5 5443.5 5507.1 5507.5 5509.5 5512.5 5973.9 5978.5 5982.8 5986.9 5987.0 5691.2 5706.4 5730.5 5757.4 5800.5 5876.9 5880.3 5889.0 5890.2 5904.2 5690.1 5751.8 5822.0 5873.7 5905.1 5708.2 5732.3 5810.4 5817.4 5846.2 4443.9 4480.2 4493.6 4494.2 4521.9 3991.8 3999.4 4007.5 4027.9 4031.8 5385.8 5427.9 5469.2 5509.9 5528.1 5844.6 5856.4 5875.0 5902.7 5908.2 5391.0 5460.5 5465.6 5473.3 5493.6 4937.4 4939.7 4943.9 4953.6 4984.8 6039.6 6039.8 6040.1 6043.5 6055.8 5692.3 5815.9 5825.9 5837.5 5867.8 6106.6 6117.4 6119.6 6121.5 6123.0 5752.7 5796.1 5810.0 5821.4 5862.1 5822.3 5833.0 5883.4 5889.2 5904.6 5650.6 5688.0 5697.7 5733.7 5765.3 5553.3 5579.4 5617.6 5621.0 5627.1 5542.2 5566.4 5574.6 5632.5 5640.6 5635.8 5696.7 5786.8 5804.3 5807.4 5624.6 5634.2 5640.9 5643.9 5673.7 08:19:36 INFO - PROCESS | 4034 | 08:19:36 INFO - PROCESS | 4034 | [#1] ext.html Cycles:180 Average:46029.85 Median:35939.82 stddev:76124.68 (211.8%) stddev-sans-first:76261.55 08:19:36 INFO - PROCESS | 4034 | Values: 523.3 534.1 536.2 553.3 555.3 34515.0 34557.0 34839.5 34857.7 34997.8 35628.3 36054.6 36135.9 36202.8 36242.1 8414.8 8703.9 8710.6 8715.5 8716.9 8588.4 8709.1 8711.4 8717.8 8753.8 8745.1 8817.8 8832.5 8846.0 8858.1 8651.0 8738.4 8750.8 8754.6 8789.1 8552.8 8626.4 8656.4 8661.0 8716.7 36742.8 36951.4 37162.6 37254.8 37303.8 3223.6 3458.3 3471.3 3480.7 3550.4 27249.7 27349.5 27391.2 27411.6 27953.7 3622.6 3647.3 3724.7 3875.5 3884.7 261091.0 263531.0 263628.0 263941.0 264472.0 59603.4 60660.0 60672.7 60748.7 60849.0 64084.4 64403.0 64654.7 65158.0 66201.3 15909.1 16225.1 16314.8 16323.2 16330.6 12313.3 12336.3 12380.1 12382.3 12418.1 19455.7 20230.3 20447.2 20483.7 20601.5 7969.8 8089.1 8170.6 8282.0 8339.8 966.7 972.1 1020.3 1045.6 1121.9 28325.0 28514.6 28514.9 28581.3 28612.3 1074.7 1090.1 1100.8 1105.7 1186.3 14653.7 14755.8 14782.5 14827.9 15228.8 309042.0 311293.0 312347.0 313836.0 315018.0 50839.7 51531.0 51800.0 51822.0 51865.5 1331.5 1379.6 1390.1 1392.5 1397.1 26957.9 27771.7 28269.3 28324.2 28635.9 44763.3 45109.0 45194.0 45211.5 45225.8 291260.0 294592.0 296463.0 298978.0 300025.0 31548.2 31749.2 32058.7 32229.5 32299.2 42605.6 42622.1 43398.6 43543.3 43747.0 35547.3 35825.0 36228.5 36350.5 36546.8 36569.1 36645.5 36996.8 37160.4 37218.0 36193.0 38435.0 39449.6 39618.8 39770.2 28473.9 32409.4 32685.2 33077.0 33528.3 25339.2 25557.2 25685.0 25729.5 26102.0 08:19:36 INFO - PROCESS | 4034 | 08:19:36 INFO - PROCESS | 4034 | [#2] jquery.html Cycles:180 Average:23324.34 Median:166996.35 stddev:62768.78 (37.6%) stddev-sans-first:62921.12 08:19:36 INFO - PROCESS | 4034 | Values: 333.8 335.7 337.5 338.8 343.4 16270.8 16423.8 17096.1 17693.6 17760.8 16392.4 16541.1 16914.0 17292.6 17294.7 5263.2 5267.5 5416.5 5430.9 5450.2 5306.5 5345.2 5351.4 5353.6 5403.3 5169.2 5311.1 5311.8 5312.1 5325.7 5257.7 5346.9 5352.9 5375.0 5388.8 4737.8 4755.5 4770.9 4782.5 4783.0 20366.4 20421.1 20459.4 20627.0 20948.8 2150.2 2234.0 2275.3 2305.5 2314.6 13045.3 13094.3 13182.3 13333.1 13337.1 1875.1 1901.3 1905.4 1927.6 1955.8 51676.5 55984.4 57007.1 60496.7 64271.4 9032.6 9090.2 9404.0 9449.9 9454.9 12227.4 12230.0 12315.6 12342.1 12396.9 7621.0 7749.0 7768.1 7783.5 7829.3 7790.7 7838.1 7865.8 7902.9 7913.8 5633.6 5751.6 5824.7 5833.9 5851.8 1731.5 1762.1 1766.2 1779.7 1788.3 905.4 946.6 1001.5 1015.8 1074.7 15476.8 15678.2 16833.0 17195.2 17328.6 965.5 970.9 1005.4 1027.0 1114.5 9646.6 9688.2 9875.3 9971.2 10090.9 321859.0 333657.0 337561.0 446849.0 450402.0 67630.3 67918.3 69099.3 69658.0 72434.6 1012.5 1035.0 1054.5 1056.1 1066.2 14797.8 15105.2 15219.7 15432.2 15482.4 22570.9 23367.4 30743.4 33900.0 35565.8 43767.8 48023.5 48127.0 48345.0 48735.8 7521.5 7606.2 7791.9 7805.6 7811.5 8722.0 11423.4 12425.8 12597.0 12597.8 10211.6 10692.3 10745.6 10801.2 10882.1 10795.5 10895.3 10906.2 11142.4 11231.5 10674.4 10986.5 10998.7 11105.8 11179.3 7426.9 7644.5 7779.3 7823.6 7936.3 9302.0 10487.5 10590.7 10621.0 11166.7 08:19:36 INFO - PROCESS | 4034 | 08:19:36 INFO - PROCESS | 4034 | [#3] mootools.html Cycles:180 Average:5444.17 Median:6400.60 stddev:2818.95 (44.0%) stddev-sans-first:2811.05 08:19:36 INFO - PROCESS | 4034 | Values: 1472.3 1523.8 1685.7 1802.9 1814.2 6989.9 7664.3 7853.5 8067.0 8073.9 7622.7 7643.8 7721.3 7731.6 7773.5 2278.2 2282.7 2285.1 2287.5 2302.8 2236.5 2244.8 2254.8 2274.1 2287.7 2224.7 2233.6 2263.1 2265.7 2273.4 2199.9 2208.0 2210.8 2222.7 2229.6 2263.6 2264.9 2268.3 2271.0 2279.3 8029.0 8048.4 8093.0 8103.0 8115.6 4771.4 4859.7 4868.9 4879.5 4890.9 3013.0 3018.2 3132.0 3132.4 3166.6 1052.3 1053.4 1976.9 1992.6 1999.9 10710.6 10712.0 10772.3 10842.5 10897.5 4058.8 4167.7 4217.4 4231.4 4255.9 8126.1 8145.0 8146.2 8189.3 8192.9 4763.5 4765.7 4788.2 4795.7 4812.0 4347.4 4447.1 4448.1 4477.6 4493.4 3486.2 3514.4 3535.0 3542.8 3546.9 1087.3 1106.1 1114.2 1117.5 1128.2 1102.6 1109.8 1122.8 1283.6 1373.1 7216.3 7224.3 7253.3 7258.6 7719.8 496.8 497.4 503.9 506.1 507.9 5466.5 5516.4 5556.6 5586.0 5601.2 9212.9 9427.2 9429.6 9467.5 9509.6 9510.2 9645.1 9680.9 9710.4 9727.2 7373.6 7564.5 7576.1 7604.3 7616.8 7041.6 7046.4 7056.4 7080.7 7097.6 8360.3 8422.3 8557.4 8681.5 8690.0 8528.4 8557.8 8611.7 8655.4 8758.6 6370.8 6612.7 6775.3 6961.5 7023.5 7367.4 7410.5 7440.8 7446.1 7446.7 6600.8 6745.5 6789.2 6865.6 6914.5 6694.2 6714.9 6785.7 6796.1 6916.2 6809.7 6817.7 6843.5 6849.9 6852.2 6430.4 6507.4 6510.9 6520.6 6530.7 6452.4 6476.7 6502.1 6508.6 6521.7 08:19:36 INFO - PROCESS | 4034 | 08:19:36 INFO - PROCESS | 4034 | [#4] prototype.html Cycles:180 Average:5552.12 Median:6273.58 stddev:1732.08 (27.6%) stddev-sans-first:1691.72 08:19:36 INFO - PROCESS | 4034 | Values: 313.4 323.7 325.2 326.8 330.2 6287.0 6313.0 6361.6 6372.6 6404.4 6230.1 6257.7 6259.4 6275.0 6276.6 4564.6 4605.6 4644.7 4707.0 4784.3 4689.6 4693.1 4694.9 4697.9 4709.7 4613.2 4631.2 4633.4 4637.0 4662.2 4626.9 4647.9 4659.1 4672.3 4675.0 4003.8 4009.7 4015.3 4020.8 4024.5 5788.8 5963.6 5977.8 5985.4 5993.1 5370.7 5387.7 5405.4 5442.5 5447.8 6600.8 6644.0 6670.6 6687.6 6696.9 4380.0 4399.3 4409.1 4412.2 4422.1 6880.4 6930.0 6943.5 6972.1 6980.6 4414.9 4526.6 4529.0 4529.7 4534.5 4536.0 4550.4 4556.2 4556.7 4581.6 5338.6 5385.4 5395.3 5407.6 5415.4 6667.5 6699.1 6778.7 6781.7 6788.9 1662.8 1666.9 1669.0 1675.9 1676.6 1066.0 1097.8 1112.7 1117.5 1123.0 6238.1 6248.7 6255.4 6255.6 6272.2 6813.8 6847.7 6855.1 6862.9 6870.2 6131.0 6209.5 6249.3 6362.4 6371.9 3733.1 3742.7 3743.5 3756.3 3757.8 7307.5 7311.0 7314.7 7317.2 7336.3 7092.9 7108.9 7144.2 7150.0 7162.0 7047.5 7261.7 7296.9 7299.8 7316.0 6878.0 6932.4 6934.5 6936.2 6954.8 6853.4 6893.9 6897.3 6909.8 6915.3 7239.8 7253.6 7260.2 7261.8 7275.1 4546.9 4672.1 4677.7 4680.1 4690.7 6915.6 6959.6 6973.9 6993.9 6995.4 6679.8 6717.7 6753.7 6764.9 6768.9 6675.9 6721.8 6722.9 6726.3 6755.7 6492.7 6613.1 6627.4 6627.9 6642.3 6727.7 6740.9 6778.3 6785.3 6785.9 6575.6 6620.4 6634.6 6636.2 6644.6 08:19:36 INFO - PROCESS | 4034 | 08:19:36 INFO - PROCESS | 4034 | [#5] yui.html Cycles:180 Average:13757.96 Median:4413.07 stddev:15559.32 (352.6%) stddev-sans-first:15572.28 08:19:36 INFO - PROCESS | 4034 | Values: 746.9 800.2 804.2 805.8 818.5 13747.7 13817.2 13924.5 13926.1 13957.0 13082.3 13144.3 13145.8 13222.6 13239.2 803.3 811.4 831.9 832.5 835.6 814.1 818.2 822.5 825.4 826.1 858.0 860.1 863.8 865.3 865.8 852.5 853.7 857.9 858.2 858.9 626.3 630.8 633.6 634.1 635.2 14265.9 14307.9 14329.3 14337.9 14376.6 12320.6 12480.2 12684.4 12779.2 12934.1 10547.4 10637.9 10710.7 10738.8 10962.4 3652.2 3657.3 3666.2 3747.1 3826.7 48053.0 48803.3 48817.3 48903.5 49065.0 9957.1 10037.2 10051.5 10225.6 10596.7 18114.6 18160.7 18178.8 18219.2 18249.4 7710.3 7767.2 7782.8 8023.6 8044.5 4231.5 4328.0 4411.3 4414.9 4461.8 3276.6 3305.1 3312.2 3319.2 3319.3 597.6 599.5 600.5 614.0 619.9 632.8 658.1 658.2 663.3 668.5 7486.8 7750.3 7782.8 7807.9 8020.8 517.4 630.0 652.5 656.8 663.8 3683.7 3813.4 3900.5 3957.8 4214.2 54846.7 56347.0 56847.4 56864.4 56925.7 46800.3 47337.8 47921.8 48161.3 48993.5 45454.8 46031.0 46851.8 48128.0 49084.8 8368.3 8464.9 8504.4 8692.6 8699.3 33878.7 34515.8 35293.5 35323.6 35692.0 39395.4 40278.8 42437.0 43183.4 43884.0 11326.3 11361.3 11435.0 11441.8 11659.1 12424.5 12451.8 12587.7 12793.9 12958.2 11241.4 11597.2 11612.4 11892.8 11952.0 11733.4 11957.3 11964.3 12353.0 12383.2 10741.7 11415.3 11865.3 12004.2 12078.7 9965.8 10241.9 10284.7 10361.4 10404.5 9100.4 9355.7 9591.0 9759.0 9816.1 08:19:36 INFO - PROCESS | 4034 | -------- Summary: end -------- 08:19:36 INFO - PROCESS | 4034 | 08:19:36 INFO - PROCESS | 4034 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:36 INFO - PROCESS | 4034 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:36 INFO - PROCESS | 4034 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:36 INFO - PROCESS | 4034 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:36 INFO - PROCESS | 4034 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:36 INFO - PROCESS | 4034 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:36 INFO - PROCESS | 4034 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:36 INFO - PROCESS | 4034 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:37 INFO - TEST-INFO | 4034: exit 0 08:19:37 INFO - TEST-OK | dromaeo_css | took 1111643ms 08:19:37 INFO - TEST-START | kraken 08:19:37 INFO - operating with platform_type : linux_ 08:19:37 INFO - Initialising browser for kraken test... 08:19:37 INFO - TEST-INFO | started process 4278 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsy9GyK/profile http://localhost:40474/getInfo.html) 08:19:41 INFO - PROCESS | 4278 | 08:19:41 INFO - PROCESS | 4278 | (process:4347): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:19:41 INFO - PROCESS | 4278 | __metrics Screen width/height:1600/1200 08:19:41 INFO - PROCESS | 4278 | colorDepth:24 08:19:41 INFO - PROCESS | 4278 | Browser inner width/height: 1024/697 08:19:41 INFO - PROCESS | 4278 | __metrics 08:19:42 ERROR - PROCESS | 4278 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 08:19:42 INFO - PROCESS | 4278 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:42 INFO - PROCESS | 4278 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:42 INFO - PROCESS | 4278 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:42 INFO - PROCESS | 4278 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:42 INFO - PROCESS | 4278 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:42 INFO - PROCESS | 4278 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:42 INFO - PROCESS | 4278 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:42 INFO - PROCESS | 4278 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:42 INFO - PROCESS | 4278 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:19:43 INFO - TEST-INFO | 4278: exit 0 08:19:43 INFO - Browser initialized. 08:19:43 INFO - Running cycle 1/1 for kraken test... 08:19:43 INFO - TEST-INFO | started process 4398 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsy9GyK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:19:44 INFO - PROCESS | 4398 | 08:19:44 INFO - PROCESS | 4398 | (process:4456): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:19:55 INFO - PROCESS | 4398 | RSS: Main: 160415744 08:19:55 INFO - PROCESS | 4398 | 08:19:57 INFO - PROCESS | 4398 | Cycle 1(1): loaded http://localhost:40474/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40474/tests/kraken/driver.html?testName=audio-beat-detection) 08:19:58 INFO - PROCESS | 4398 | RSS: Main: 166719488 08:19:58 INFO - PROCESS | 4398 | 08:20:00 INFO - PROCESS | 4398 | Cycle 1(1): loaded http://localhost:40474/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40474/tests/kraken/driver.html?testName=audio-dft) 08:20:01 INFO - PROCESS | 4398 | RSS: Main: 169222144 08:20:01 INFO - PROCESS | 4398 | 08:20:04 INFO - PROCESS | 4398 | Cycle 1(1): loaded http://localhost:40474/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40474/tests/kraken/driver.html?testName=audio-fft) 08:20:05 INFO - PROCESS | 4398 | RSS: Main: 163774464 08:20:05 INFO - PROCESS | 4398 | 08:20:07 INFO - PROCESS | 4398 | Cycle 1(1): loaded http://localhost:40474/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40474/tests/kraken/driver.html?testName=audio-oscillator) 08:20:07 INFO - PROCESS | 4398 | RSS: Main: 163966976 08:20:07 INFO - PROCESS | 4398 | 08:20:09 INFO - PROCESS | 4398 | Cycle 1(1): loaded http://localhost:40474/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40474/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:20:10 INFO - PROCESS | 4398 | RSS: Main: 164290560 08:20:10 INFO - PROCESS | 4398 | 08:20:13 INFO - PROCESS | 4398 | Cycle 1(1): loaded http://localhost:40474/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40474/tests/kraken/driver.html?testName=imaging-darkroom) 08:20:14 INFO - PROCESS | 4398 | RSS: Main: 164786176 08:20:14 INFO - PROCESS | 4398 | 08:20:17 INFO - PROCESS | 4398 | Cycle 1(1): loaded http://localhost:40474/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40474/tests/kraken/driver.html?testName=imaging-desaturate) 08:20:18 INFO - PROCESS | 4398 | RSS: Main: 164560896 08:20:18 INFO - PROCESS | 4398 | 08:20:20 INFO - PROCESS | 4398 | Cycle 1(1): loaded http://localhost:40474/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40474/tests/kraken/driver.html?testName=json-parse-financial) 08:20:21 INFO - PROCESS | 4398 | RSS: Main: 166862848 08:20:21 INFO - PROCESS | 4398 | 08:20:23 INFO - PROCESS | 4398 | Cycle 1(1): loaded http://localhost:40474/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40474/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:20:23 INFO - PROCESS | 4398 | RSS: Main: 166420480 08:20:23 INFO - PROCESS | 4398 | 08:20:25 INFO - PROCESS | 4398 | Cycle 1(1): loaded http://localhost:40474/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40474/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:20:26 INFO - PROCESS | 4398 | RSS: Main: 165728256 08:20:26 INFO - PROCESS | 4398 | 08:20:28 INFO - PROCESS | 4398 | Cycle 1(1): loaded http://localhost:40474/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40474/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:20:28 INFO - PROCESS | 4398 | RSS: Main: 167690240 08:20:28 INFO - PROCESS | 4398 | 08:20:31 INFO - PROCESS | 4398 | Cycle 1(1): loaded http://localhost:40474/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40474/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:20:31 INFO - PROCESS | 4398 | RSS: Main: 168271872 08:20:31 INFO - PROCESS | 4398 | 08:20:34 INFO - PROCESS | 4398 | Cycle 1(1): loaded http://localhost:40474/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40474/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:20:35 INFO - PROCESS | 4398 | RSS: Main: 167936000 08:20:35 INFO - PROCESS | 4398 | 08:20:36 INFO - PROCESS | 4398 | Cycle 1(1): loaded http://localhost:40474/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40474/tests/kraken/driver.html?testName=ai-astar) 08:20:37 INFO - PROCESS | 4398 | RSS: Main: 168554496 08:20:37 INFO - PROCESS | 4398 | 08:20:37 INFO - PROCESS | 4398 | __start_tp_report 08:20:37 INFO - PROCESS | 4398 | _x_x_mozilla_page_load 08:20:37 INFO - PROCESS | 4398 | _x_x_mozilla_page_load_details 08:20:37 INFO - PROCESS | 4398 | |i|pagename|runs| 08:20:37 INFO - PROCESS | 4398 | |0;ai-astar;111;107;113;110;111;122;113;111;112;111 08:20:37 INFO - PROCESS | 4398 | |1;audio-beat-detection;152;125;164;178;126;149;151;128;168;130 08:20:37 INFO - PROCESS | 4398 | |2;audio-dft;162;161;162;163;162;162;162;165;177;164 08:20:37 INFO - PROCESS | 4398 | |3;audio-fft;73;73;74;76;73;74;72;151;77;72 08:20:37 INFO - PROCESS | 4398 | |4;audio-oscillator;95;95;147;95;96;95;144;95;96;145 08:20:37 INFO - PROCESS | 4398 | |5;imaging-gaussian-blur;120;117;115;116;115;115;116;115;116;115 08:20:37 INFO - PROCESS | 4398 | |6;imaging-darkroom;147;147;147;148;147;147;147;149;146;147 08:20:37 INFO - PROCESS | 4398 | |7;imaging-desaturate;96;97;101;101;97;97;96;96;96;96 08:20:37 INFO - PROCESS | 4398 | |8;json-parse-financial;57;58;60;56;64;57;57;59;56;56 08:20:37 INFO - PROCESS | 4398 | |9;json-stringify-tinderbox;69;69;68;68;67;68;68;67;69;68 08:20:37 INFO - PROCESS | 4398 | |10;stanford-crypto-aes;84;83;83;84;82;83;83;87;83;83 08:20:37 INFO - PROCESS | 4398 | |11;stanford-crypto-ccm;122;117;119;121;125;126;119;128;116;119 08:20:37 INFO - PROCESS | 4398 | |12;stanford-crypto-pbkdf2;140;150;154;150;150;140;149;161;151;141 08:20:37 INFO - PROCESS | 4398 | |13;stanford-crypto-sha256-iterative;73;68;70;68;71;70;68;69;69;69 08:20:37 INFO - PROCESS | 4398 | __end_tp_report 08:20:37 INFO - PROCESS | 4398 | __start_cc_report 08:20:37 INFO - PROCESS | 4398 | _x_x_mozilla_cycle_collect,808 08:20:37 INFO - PROCESS | 4398 | __end_cc_report 08:20:37 INFO - PROCESS | 4398 | __startTimestamp1456762837004__endTimestamp 08:20:37 INFO - PROCESS | 4398 | 08:20:37 INFO - PROCESS | 4398 | ------- Summary: start ------- 08:20:37 INFO - PROCESS | 4398 | Number of tests: 14 08:20:37 INFO - PROCESS | 4398 | 08:20:37 INFO - PROCESS | 4398 | [#0] ai-astar Cycles:10 Average:112.10 Median:111.50 stddev:3.87 (3.5%) stddev-sans-first:4.09 08:20:37 INFO - PROCESS | 4398 | Values: 111.0 107.0 113.0 110.0 111.0 122.0 113.0 111.0 112.0 111.0 08:20:37 INFO - PROCESS | 4398 | 08:20:37 INFO - PROCESS | 4398 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:151.50 stddev:19.18 (12.7%) stddev-sans-first:20.26 08:20:37 INFO - PROCESS | 4398 | Values: 152.0 125.0 164.0 178.0 126.0 149.0 151.0 128.0 168.0 130.0 08:20:37 INFO - PROCESS | 4398 | 08:20:37 INFO - PROCESS | 4398 | [#2] audio-dft Cycles:10 Average:164.00 Median:162.50 stddev:4.71 (2.9%) stddev-sans-first:4.94 08:20:37 INFO - PROCESS | 4398 | Values: 162.0 161.0 162.0 163.0 162.0 162.0 162.0 165.0 177.0 164.0 08:20:37 INFO - PROCESS | 4398 | 08:20:37 INFO - PROCESS | 4398 | [#3] audio-fft Cycles:10 Average:81.50 Median:73.50 stddev:24.47 (33.3%) stddev-sans-first:25.76 08:20:37 INFO - PROCESS | 4398 | Values: 73.0 73.0 74.0 76.0 73.0 74.0 72.0 151.0 77.0 72.0 08:20:37 INFO - PROCESS | 4398 | 08:20:37 INFO - PROCESS | 4398 | [#4] audio-oscillator Cycles:10 Average:110.30 Median:95.00 stddev:24.19 (25.5%) stddev-sans-first:25.01 08:20:37 INFO - PROCESS | 4398 | Values: 95.0 95.0 147.0 95.0 96.0 95.0 144.0 95.0 96.0 145.0 08:20:37 INFO - PROCESS | 4398 | 08:20:37 INFO - PROCESS | 4398 | [#5] imaging-gaussian-blur Cycles:10 Average:116.00 Median:116.00 stddev:1.56 (1.3%) stddev-sans-first:0.73 08:20:37 INFO - PROCESS | 4398 | Values: 120.0 117.0 115.0 116.0 115.0 115.0 116.0 115.0 116.0 115.0 08:20:37 INFO - PROCESS | 4398 | 08:20:37 INFO - PROCESS | 4398 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 08:20:37 INFO - PROCESS | 4398 | Values: 147.0 147.0 147.0 148.0 147.0 147.0 147.0 149.0 146.0 147.0 08:20:37 INFO - PROCESS | 4398 | 08:20:37 INFO - PROCESS | 4398 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:96.00 stddev:2.00 (2.1%) stddev-sans-first:2.07 08:20:37 INFO - PROCESS | 4398 | Values: 96.0 97.0 101.0 101.0 97.0 97.0 96.0 96.0 96.0 96.0 08:20:37 INFO - PROCESS | 4398 | 08:20:37 INFO - PROCESS | 4398 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:57.50 stddev:2.49 (4.3%) stddev-sans-first:2.62 08:20:37 INFO - PROCESS | 4398 | Values: 57.0 58.0 60.0 56.0 64.0 57.0 57.0 59.0 56.0 56.0 08:20:37 INFO - PROCESS | 4398 | 08:20:37 INFO - PROCESS | 4398 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 08:20:37 INFO - PROCESS | 4398 | Values: 69.0 69.0 68.0 68.0 67.0 68.0 68.0 67.0 69.0 68.0 08:20:37 INFO - PROCESS | 4398 | 08:20:37 INFO - PROCESS | 4398 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.00 stddev:1.35 (1.6%) stddev-sans-first:1.42 08:20:37 INFO - PROCESS | 4398 | Values: 84.0 83.0 83.0 84.0 82.0 83.0 83.0 87.0 83.0 83.0 08:20:37 INFO - PROCESS | 4398 | 08:20:37 INFO - PROCESS | 4398 | [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:121.50 stddev:3.99 (3.3%) stddev-sans-first:4.23 08:20:37 INFO - PROCESS | 4398 | Values: 122.0 117.0 119.0 121.0 125.0 126.0 119.0 128.0 116.0 119.0 08:20:37 INFO - PROCESS | 4398 | 08:20:37 INFO - PROCESS | 4398 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.60 Median:150.00 stddev:6.67 (4.4%) stddev-sans-first:6.31 08:20:37 INFO - PROCESS | 4398 | Values: 140.0 150.0 154.0 150.0 150.0 140.0 149.0 161.0 151.0 141.0 08:20:37 INFO - PROCESS | 4398 | 08:20:37 INFO - PROCESS | 4398 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.50 stddev:1.58 (2.3%) stddev-sans-first:1.05 08:20:37 INFO - PROCESS | 4398 | Values: 73.0 68.0 70.0 68.0 71.0 70.0 68.0 69.0 69.0 69.0 08:20:37 INFO - PROCESS | 4398 | -------- Summary: end -------- 08:20:37 INFO - PROCESS | 4398 | 08:20:37 INFO - PROCESS | 4398 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:20:37 INFO - PROCESS | 4398 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:20:37 INFO - PROCESS | 4398 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:20:37 INFO - PROCESS | 4398 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:20:37 INFO - PROCESS | 4398 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 08:20:37 INFO - TEST-INFO | 4398: exit 0 08:20:37 INFO - TEST-OK | kraken | took 60761ms 08:20:37 INFO - SUITE-END | took 1172s 08:20:38 INFO - Completed test suite (00:19:32) 08:20:38 INFO - Working with test: dromaeo_css 08:20:38 INFO - Generating results file: dromaeo_css 08:20:38 INFO - Working with test: kraken 08:20:38 INFO - Generating results file: kraken 08:20:38 INFO - javascript benchmark 08:20:38 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:20:38 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 08:20:38 INFO - process_Request line: dromaeo_css 6992.43 graph.html#tests=[[72,64,43]] 08:20:38 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:20:38 INFO - process_Request line: kraken 1524.40 graph.html#tests=[[232,64,43]] 08:20:38 INFO - RETURN: dromaeo_css: 6992.43 08:20:38 INFO - RETURN: kraken: 1524.40 08:20:38 INFO - javascript benchmark 08:20:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3163.066895265896, 3210.1011716719327, 3220.2432428379325, 3276.3938671345795, 3284.293876816484, 5297.708626025567, 5336.306280183576, 5380.085385484467, 5420.485053919876, 5425.891482170354, 5381.892362152755, 5390.78436862525, 5426.0, 5436.374816896048, 5500.22996780451, 4900.975495122529, 4945.703257804544, 4964.081644895706, 5005.924911126336, 5083.389993200821, 5000.299958005882, 5009.398872135331, 5038.067957427869, 5042.773075211624, 5116.513931176532, 4845.927311090337, 4920.384951880997, 4954.157793175169, 4962.727050012248, 4978.402591688984, 4915.5821755150855, 4922.704637721712, 4938.209886418192, 4943.555080042777, 4952.0, 4789.114013907403, 4898.21628539432, 4909.7790599423115, 4922.704637721748, 4973.825916092956, 5277.788888444457, 5278.815241466568, 5323.041852466555, 5339.199120132012, 5355.571554275649, 5867.853303667443, 5886.764529418818, 5887.35239123696, 5888.381719919433, 5889.057750759858, 5770.682612456313, 5846.035404158309, 5907.232059832194, 5911.320198177222, 5927.466528012456, 5443.510084092451, 5507.146392309199, 5507.531859791922, 5509.47659972306, 5512.503874651301, 5973.880522389528, 5978.521718262528, 5982.790602328984, 5986.9401305986385, 5987.042073268256, 5691.231683722727, 5706.3722990471015, 5730.484256416942, 5757.395473475225, 5800.535957123504, 5876.941230587639, 5880.26496687914, 5889.0, 5890.234269545017, 5904.232449781501, 5690.118031705092, 5751.827445176651, 5822.0, 5873.706314684248, 5905.143754155623, 5708.20085188074, 5732.34078081026, 5810.389909059572, 5817.418258174149, 5846.152307915413, 4443.866683999485, 4480.215962206601, 4493.618042466362, 4494.235979883428, 4521.909561808746, 3991.7604943703473, 3999.3601023836045, 4007.499062617173, 4027.8993025174605, 4031.8185681644395, 5385.838424847182, 5427.891442171213, 5469.15228139639, 5509.944900550943, 5528.06022976095, 5844.620099693507, 5856.4143585641095, 5875.0, 5902.734376953047, 5908.231929849092, 5391.0, 5460.5085542301385, 5465.617406781566, 5473.343198816167, 5493.587980901449, 4937.35814344133, 4939.728314942641, 4943.8516844494725, 4953.6037117030555, 4984.800607975713, 6039.577229593886, 6039.758409663565, 6040.124181993587, 6043.546733994968, 6055.848603784941, 5692.260006199168, 5815.854603634773, 5825.94174058271, 5837.503812176013, 5867.767768768435, 6106.603070800384, 6117.431594453822, 6119.571769464861, 6121.452487244962, 6123.038605230386, 5752.6836024019085, 5796.101604251347, 5810.012297909281, 5821.388754180919, 5862.062070068769, 5822.301323840997, 5833.0, 5883.35283118848, 5889.234399528034, 5904.645721256738, 5650.604457687922, 5688.004599195207, 5697.7151142443545, 5733.71331433435, 5765.250517432707, 5553.305836770403, 5579.4420557945505, 5617.634853734494, 5621.016322143527, 5627.127795191752, 5542.224088627515, 5566.443355664564, 5574.637648552831, 5632.464915833153, 5640.605157638925, 5635.830925072254, 5696.715164241688, 5786.768529258782, 5804.2744656917885, 5807.361190268983, 5624.606277560531, 5634.183043458757, 5640.858978525405, 5643.858903527281, 5673.716314184357], "unit": "score", "name": "dojo.html", "value": 5376.689628765569}, {"lowerIsBetter": false, "replicates": [523.2778765303881, 534.1107056750508, 536.241218675574, 553.3194171169464, 555.336373034224, 34515.0, 34557.0, 34839.4774078389, 34857.65142348576, 34997.82501087494, 35628.28743425137, 36054.63945360546, 36135.928446082115, 36202.81898590503, 36242.09394765132, 8414.789630259247, 8703.912960870373, 8710.564471776417, 8715.520646364448, 8716.912830871705, 8588.355873309496, 8709.129087091273, 8711.43375680582, 8717.782055448633, 8753.824923501526, 8745.125487451267, 8817.779555511099, 8832.514211718353, 8845.95577022114, 8858.114188581123, 8651.04838467768, 8738.388312818106, 8750.824983500326, 8754.60604272806, 8789.121087891224, 8552.828943421158, 8626.439281446748, 8656.437331573428, 8661.0, 8716.694915677921, 36742.8162859184, 36951.445728314095, 37162.62837371619, 37254.81372593147, 37303.813480932695, 3223.6131664200448, 3458.291050334675, 3471.340445315382, 3480.7215422766117, 3550.4496802995577, 27249.727502724916, 27349.45301093987, 27391.17826465209, 27411.622384515547, 27953.720462795314, 3622.6196249393697, 3647.252313275772, 3724.718042315954, 3875.4961854958956, 3884.7086468514976, 261091.0, 263531.0, 263628.0, 263941.0, 264472.0, 59603.40396596065, 60660.0, 60672.696636517416, 60748.69625651844, 60849.0, 64084.35915640877, 64403.0, 64654.67672661607, 65158.0, 66201.33798662048, 15909.124998125215, 16225.107619080827, 16314.75527867083, 16323.18384080815, 16330.591735206715, 12313.26120432777, 12336.259824410565, 12380.133390662568, 12382.257064576153, 12418.130730848754, 19455.708164377545, 20230.291939782037, 20447.18211271562, 20483.69274460884, 20601.48496287605, 7969.8406031880195, 8089.110197878229, 8170.550619715973, 8282.012317043866, 8339.83320333602, 966.6906589891167, 972.0813830929703, 1020.2501161646184, 1045.6183493025144, 1121.870984836738, 28325.0, 28514.572281415796, 28514.857425713155, 28581.28546786347, 28612.284692882844, 1074.6937122920087, 1090.111559079348, 1100.8403781451646, 1105.6848798092506, 1186.258588382261, 14653.706925861636, 14755.77866332006, 14782.48261310849, 14827.851721482863, 15228.847711522743, 309042.0, 311293.0, 312347.0, 313836.0, 315018.0, 50839.74580127076, 51531.0, 51800.0, 51822.0, 51865.48134518607, 1331.5472739268696, 1379.593020059085, 1390.0547627613118, 1392.470861072786, 1397.1477398786733, 26957.865210673823, 27771.722282776915, 28269.293267668472, 28324.150275491767, 28635.856820716595, 44763.32855007112, 45109.0, 45194.0, 45211.54788452073, 45225.773871130434, 291260.0, 294592.0, 296463.0, 298978.0, 300025.0, 31548.211294717814, 31749.20626984344, 32058.6794132065, 32229.51655725213, 32299.19252018718, 42605.5739442614, 42622.147557049306, 43398.566014340715, 43543.346849796646, 43747.0, 35547.28905421825, 35825.0, 36228.4565731509, 36350.45474317834, 36546.8172659135, 36569.08577285589, 36645.450318244715, 36996.815015924745, 37160.44259336058, 37218.0, 36193.0, 38435.0, 39449.60550394459, 39618.80190599029, 39770.2045959085, 28473.857630711715, 32409.35181296408, 32685.18287042843, 33077.0, 33528.329433410705, 25339.239822805346, 25557.233283000794, 25685.0, 25729.485410291316, 26102.0], "unit": "score", "name": "ext.html", "value": 18427.460544775622}, {"lowerIsBetter": false, "replicates": [333.84809911490277, 335.70290293090625, 337.49712927737676, 338.84582514955684, 343.354493552122, 16270.755938660915, 16423.753643695338, 17096.059716715576, 17693.55766105848, 17760.822391776077, 16392.426265080725, 16541.090240036792, 16913.985160890355, 17292.56768580783, 17294.654106917853, 5263.236830659552, 5267.525922666969, 5416.539594134503, 5430.945690543103, 5450.236966824647, 5306.4958828911385, 5345.1714984177515, 5351.384590772072, 5353.5984801139875, 5403.2705584746145, 5169.198774190007, 5311.097113490716, 5311.787528498855, 5312.123499622558, 5325.733713314338, 5257.737113144347, 5346.91979620304, 5352.91970620441, 5374.973125134388, 5388.757505912244, 4737.8341758038305, 4755.476897541268, 4770.904581908342, 4782.545658162504, 4783.019481006385, 20366.389008329774, 20421.081051352725, 20459.38621841347, 20627.0, 20948.790512094838, 2150.2151714624206, 2234.0, 2275.2605403243847, 2305.5388922215625, 2314.6412306092584, 13045.282509461977, 13094.279814610192, 13182.340882955814, 13333.133346332554, 13337.066405351628, 1875.0530981854213, 1901.3060233014987, 1905.3807512558335, 1927.5952050069502, 1955.8141976512209, 51676.48323516754, 55984.440155598735, 57007.144892827055, 60496.69751651258, 64271.357286427, 9032.593533291018, 9090.181883630505, 9404.0, 9449.858252126223, 9454.90545094554, 12227.388630568614, 12230.021598272117, 12315.568955086528, 12342.074344424203, 12396.876031239752, 7621.0, 7749.0, 7768.106667733283, 7783.455158138989, 7829.3345065670055, 7790.688372465038, 7838.137804841463, 7865.764027079197, 7902.881456778153, 7913.841723165505, 5633.605647604629, 5751.59738818287, 5824.6796426196115, 5833.88332233353, 5851.795187168429, 1731.463246393622, 1762.1101343821545, 1766.1963806468027, 1779.661864245789, 1788.3115000724554, 905.3526728389234, 946.6355453150586, 1001.5242759689089, 1015.7816069545083, 1074.7474343529263, 15476.76784848228, 15678.216089195495, 16833.0, 17195.22621482011, 17328.566785830455, 965.4979410706393, 970.8592254123254, 1005.3666190300064, 1026.9537870795832, 1114.5318966034285, 9646.5530170475, 9688.176504997155, 9875.308728389087, 9971.202303815677, 10090.899091008996, 321859.0, 333657.0, 337561.0, 446849.0, 450402.0, 67630.32369676339, 67918.3208167912, 69099.30900690929, 69658.0, 72434.63782681053, 1012.5089331674133, 1035.021904300444, 1054.546544985648, 1056.1339701444742, 1066.2376400873259, 14797.778033329294, 15105.244737763287, 15219.701107194456, 15432.151231682365, 15482.380704771684, 22570.887145564167, 23367.41581460477, 30743.385132297677, 33900.0, 35565.82217088898, 43767.78116109399, 48023.5197648033, 48127.0, 48345.0, 48735.75632121817, 7521.4734968551675, 7606.239376062349, 7791.883121753065, 7805.570693611906, 7811.531308121531, 8721.956390218009, 11423.428828558373, 12425.751484970431, 12597.0, 12597.811032834697, 10211.642592509226, 10692.251542391958, 10745.623903163352, 10801.243912926335, 10882.075023623082, 10795.514201860778, 10895.291806032583, 10906.236563440483, 11142.387168705798, 11231.494582743633, 10674.412907290174, 10986.505607247533, 10998.670039898816, 11105.833412498658, 11179.273347232729, 7426.925730742623, 7644.464887457824, 7779.338756205786, 7823.608819558885, 7936.325412339785, 9302.0, 10487.475626218506, 10590.735231619272, 10621.0, 11166.72083197894], "unit": "score", "name": "jquery.html", "value": 8360.995113723531}, {"lowerIsBetter": false, "replicates": [1472.3374481483331, 1523.756199008159, 1685.662867426515, 1802.9008404537744, 1814.156417265971, 6989.89515157273, 7664.271894170059, 7853.48952318099, 8066.959665201681, 8073.919260807397, 7622.695092196319, 7643.808904777384, 7721.30508254257, 7731.574763388011, 7773.455858089936, 2278.2481781012266, 2282.7032485776826, 2285.0631241191113, 2287.5081857400655, 2302.8157747380255, 2236.4856083100894, 2244.820414366855, 2254.797068263856, 2274.1471948019494, 2287.748347681754, 2224.67742177385, 2233.6091184042807, 2263.128695452246, 2265.7054582904198, 2273.443006463419, 2199.9340019799433, 2207.9558408831895, 2210.7568167501563, 2222.744384395799, 2229.6321107017325, 2263.6265016272296, 2264.9320520384413, 2268.2514770125817, 2270.9545809083893, 2279.338991692407, 8028.956235689381, 8048.430556041574, 8093.028836539653, 8102.959485202595, 8115.634796434175, 4771.403574553181, 4859.684120532154, 4868.9269660955115, 4879.536444037811, 4890.902181956377, 3012.9849350753325, 3018.24543864034, 3132.0, 3132.37352529495, 3166.62000559932, 1052.3054783842704, 1053.4153544782644, 1976.9209231630718, 1992.5516758729316, 1999.9200031998703, 10710.571577136905, 10712.0, 10772.29980051302, 10842.512086956027, 10897.509612067397, 4058.837646494166, 4167.666586673059, 4217.388478670576, 4231.407602935591, 4255.914881702349, 8126.10612832588, 8145.0, 8146.185381461806, 8189.344852411793, 8192.918070819334, 4763.476017638057, 4765.714057156512, 4788.162071637449, 4795.664303498791, 4812.0, 4347.4348334716915, 4447.132809102259, 4448.110377924428, 4477.619402350771, 4493.438320209973, 3486.1981744198974, 3514.38498262803, 3535.0, 3542.787432754043, 3546.929061418757, 1087.342157994402, 1106.1261603333437, 1114.1699433921617, 1117.502711293483, 1128.1707944660668, 1102.6416414665266, 1109.8168802147716, 1122.7586068995206, 1283.6020833541631, 1373.0525937103366, 7216.278372162742, 7224.277572242839, 7253.274672532704, 7258.564486130849, 7719.768406947801, 496.7565892712617, 497.4329264638315, 503.92189210672404, 506.11177383691387, 507.88318686701524, 5466.535344495763, 5516.365617953907, 5556.611037227436, 5585.972070139624, 5601.187827764951, 9212.907870921339, 9427.198688111588, 9429.62281508732, 9467.526623668928, 9509.619615215452, 9510.191633711074, 9645.131938125602, 9680.854787178198, 9710.417374957526, 9727.221822254203, 7373.635877362705, 7564.4704870659625, 7576.052993375828, 7604.315611594983, 7616.771496855104, 7041.612711300722, 7046.436285097077, 7056.364927156581, 7080.681369338495, 7097.609631470319, 8360.331173506227, 8422.326213902996, 8557.35819813504, 8681.479111253346, 8689.956550217208, 8528.445651032664, 8557.786055348666, 8611.741647750578, 8655.437396569203, 8758.60586273632, 6370.77702280418, 6612.702428390638, 6775.288594697486, 6961.547499412522, 7023.543469674455, 7367.447441441806, 7410.481266311306, 7440.776776696708, 7446.106467223751, 7446.664900079618, 6600.768973085919, 6745.460363171032, 6789.1852977643, 6865.5537390069485, 6914.51598388108, 6694.163229596301, 6714.899276510759, 6785.660716964231, 6796.082528858541, 6916.20463646687, 6809.659517024228, 6817.659117044227, 6843.452523797984, 6849.869771487649, 6852.177738671391, 6430.421262086247, 6507.414332710079, 6510.934890651033, 6520.608763474207, 6530.67346632676, 6452.35476452351, 6476.676166191766, 6502.122213501306, 6508.60948343101, 6521.67391630426], "unit": "score", "name": "mootools.html", "value": 4439.920975604461}, {"lowerIsBetter": false, "replicates": [313.4452019924733, 323.6989599672304, 325.2373184881452, 326.84311530465374, 330.1844444222769, 6286.9685651571735, 6313.0, 6361.554691171608, 6372.617642941421, 6404.359564043593, 6230.096635987779, 6257.687115644211, 6259.405356491126, 6275.0, 6276.592021518598, 4564.6348292136545, 4605.631549476034, 4644.6516511261625, 4707.011527579212, 4784.282357646346, 4689.62483001359, 4693.108309421199, 4694.859154225362, 4697.882552936187, 4709.693869898446, 4613.169629466712, 4631.189541830183, 4633.351330813689, 4637.026224492861, 4662.207424737802, 4626.884327891796, 4647.907041859161, 4659.138059458977, 4672.322513235562, 4675.0, 4003.799810009488, 4009.67922566194, 4015.277250095011, 4020.839166433339, 4024.517057953035, 5788.797392091299, 5963.582549221556, 5977.7608895644125, 5985.371535988702, 5993.0710739835395, 5370.731463426852, 5387.653086728318, 5405.351357837046, 5442.537384322298, 5447.809326673548, 6600.834979125512, 6644.036614690891, 6670.6331151786635, 6687.632180230085, 6696.933030669679, 4379.978100109511, 4399.318105693623, 4409.11817636474, 4412.183746006999, 4422.071365013351, 6880.380765731108, 6929.965350173217, 6943.513954023271, 6972.058772065757, 6980.581165130108, 4414.888337468983, 4526.615237704832, 4529.048899731093, 4529.728216307032, 4534.501204867528, 4536.047430039663, 4550.408446901882, 4556.24821904382, 4556.726596404226, 4581.610563102174, 5338.626296159309, 5385.407605163429, 5395.2986111806, 5407.594430417735, 5415.431379705153, 6667.533272670964, 6699.062131301622, 6778.661066946633, 6781.6609169541325, 6788.864222715518, 1662.81709012011, 1666.8833181677167, 1669.0403018264547, 1675.9106580722628, 1676.6227598790174, 1066.0, 1097.8353247013013, 1112.7051331397186, 1117.519466629341, 1122.971925701864, 6238.095476155932, 6248.687565621701, 6255.437010669061, 6255.562110652301, 6272.153259310026, 6813.7955861324235, 6847.691853866489, 6855.108835851307, 6862.862742745117, 6870.244273129952, 6130.969345153246, 6209.534284928648, 6249.281332646713, 6362.363763623694, 6371.904421433682, 3733.1227161617, 3742.6631603155847, 3743.494628225209, 3756.286305601927, 3757.8496860125833, 7307.451941104438, 7310.96344518274, 7314.670839812221, 7317.231690672509, 7336.339729424378, 7092.893606595905, 7108.928910710827, 7144.214136444987, 7149.964250178716, 7162.0, 7047.506674532836, 7261.745838895613, 7296.890546641805, 7299.817504562322, 7315.963420182971, 6877.965610171917, 6932.445404367538, 6934.549254298455, 6936.20233673134, 6954.79135625932, 6853.417459515997, 6893.931060689329, 6897.2757860423935, 6909.7581584644295, 6915.273896241023, 7239.819004524929, 7253.637318134178, 7260.201377848327, 7261.782146535613, 7275.090613673291, 4546.931796023128, 4672.08894265615, 4677.7193368398, 4680.134175177603, 4690.742009189391, 6915.585064896122, 6959.582425054513, 6973.931470153117, 6993.860122797617, 6995.440364770908, 6679.799606011828, 6717.697703603448, 6753.662316884234, 6764.86470270582, 6768.898466522907, 6675.899861502178, 6721.798346049626, 6722.865542689216, 6726.327367263235, 6755.6622168892345, 6492.707828147839, 6613.107230523818, 6627.403533681992, 6627.9337206627315, 6642.269350371552, 6727.73089076451, 6740.876623863467, 6778.288279730755, 6785.287544807724, 6785.93214067853, 6575.638339891352, 6620.3710647488415, 6634.568753031038, 6636.170478690164, 6644.568103073285], "unit": "score", "name": "prototype.html", "value": 4980.1258053893325}, {"lowerIsBetter": false, "replicates": [746.8879668049793, 800.1998001997998, 804.2279411764702, 805.8106345008925, 818.5129847740596, 13747.656308592277, 13817.240051797135, 13924.51264205753, 13926.094803837743, 13957.023008389391, 13082.345882705875, 13144.342782860867, 13145.802812957812, 13222.603321900335, 13239.205647661147, 803.3492870774662, 811.4319976016783, 831.9126491718373, 832.5171400587644, 835.6197929941862, 814.1288820961573, 818.2431251092745, 822.5229366967175, 825.3850881093593, 826.1325608111489, 857.9828403431927, 860.0539406652663, 863.7797361672796, 865.2515574028452, 865.7575878753928, 852.4586887326531, 853.714005808055, 857.9313654907593, 858.2361698088706, 858.9141085891423, 626.2891618013542, 630.8044506203091, 633.6261605652641, 634.0679201573679, 635.1742734445203, 14265.857341426557, 14307.92690548213, 14329.283535823168, 14337.928310358486, 14376.64058398538, 12320.568780092743, 12480.188787728768, 12684.42920068599, 12779.233246005177, 12934.094613377067, 10547.419891905942, 10637.893621063768, 10710.732231694192, 10738.785224295549, 10962.376788829804, 3652.196516766307, 3657.2868290683327, 3666.17511060012, 3747.1006958330076, 3826.693864490862, 48053.0, 48803.267950980764, 48817.267740983916, 48903.51096489061, 49065.0, 9957.103860652576, 10037.197024238043, 10051.547680354402, 10225.590976360862, 10596.682099537025, 18114.63770724578, 18160.727589086175, 18178.818211817714, 18219.180136893872, 18249.361272355403, 7710.306072453506, 7767.18444563324, 7782.766517004499, 8023.558704271204, 8044.477108988014, 4231.4710661167355, 4327.956720432819, 4411.2721400968485, 4414.867553973386, 4461.843835465808, 3276.639569647337, 3305.1241421023446, 3312.2381852174135, 3319.186799234155, 3319.286353434023, 597.5578072226521, 599.5173885022512, 600.4655856287907, 614.0390289197392, 619.8574327904607, 632.8386261503288, 658.1082633032269, 658.2495954611746, 663.2604645819972, 668.4819265069513, 7486.812829679193, 7750.341220996165, 7782.844343113106, 7807.921920780833, 8020.839583208303, 517.4385791416355, 629.9762885311369, 652.5203975078314, 656.7734131724548, 663.8207683925409, 3683.7053035757076, 3813.447577535326, 3900.531936167621, 3957.821898014596, 4214.220369231702, 54846.72576637091, 56347.0, 56847.43152568422, 56864.43135568591, 56925.71537142288, 46800.29799553009, 47337.763311183226, 47921.76039119782, 48161.277580836315, 48993.510064898896, 45454.77272613616, 46031.0, 46851.765741171075, 48128.0, 49084.75457622689, 8368.288695460955, 8464.915350846413, 8504.404691671523, 8692.608832602422, 8699.304055675404, 33878.66121338755, 34515.82742086273, 35293.47059794157, 35323.64676353204, 35692.0, 39395.40906886457, 40278.798606006785, 42437.0, 43183.35224971691, 43884.0, 11326.263792853439, 11361.318320900773, 11435.0, 11441.771164576829, 11659.06727461784, 12424.503019879103, 12451.750964980469, 12587.74824503523, 12793.87206127964, 12958.249742990842, 11241.437928103725, 11597.18819682614, 11612.419379030845, 11892.821607676065, 11952.0, 11733.413329333329, 11957.342346171044, 11964.341961192218, 12353.0, 12383.19509231933, 10741.731456713645, 11415.315081094828, 11865.288082715064, 12004.2197257178, 12078.698032549257, 9965.750856228362, 10241.897581024094, 10284.742881428025, 10361.4301213434, 10404.485861951893, 9100.362974591715, 9355.719328420158, 9591.0, 9758.951205243928, 9816.116549510578], "unit": "score", "name": "yui.html", "value": 6380.84801540535}], "name": "dromaeo_css", "value": 6992.430858069886}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 113.0, 110.0, 111.0, 122.0, 113.0, 111.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.1}, {"lowerIsBetter": true, "replicates": [152.0, 125.0, 164.0, 178.0, 126.0, 149.0, 151.0, 128.0, 168.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 147.1}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 162.0, 163.0, 162.0, 162.0, 162.0, 165.0, 177.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 74.0, 76.0, 73.0, 74.0, 72.0, 151.0, 77.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 147.0, 95.0, 96.0, 95.0, 144.0, 95.0, 96.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 110.3}, {"lowerIsBetter": true, "replicates": [120.0, 117.0, 115.0, 116.0, 115.0, 115.0, 116.0, 115.0, 116.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.0}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 149.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 101.0, 101.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 97.3}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 60.0, 56.0, 64.0, 57.0, 57.0, 59.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.0}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 68.0, 67.0, 68.0, 68.0, 67.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 83.0, 84.0, 82.0, 83.0, 83.0, 87.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.5}, {"lowerIsBetter": true, "replicates": [122.0, 117.0, 119.0, 121.0, 125.0, 126.0, 119.0, 128.0, 116.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.2}, {"lowerIsBetter": true, "replicates": [140.0, 150.0, 154.0, 150.0, 150.0, 140.0, 149.0, 161.0, 151.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.6}, {"lowerIsBetter": true, "replicates": [73.0, 68.0, 70.0, 68.0, 71.0, 70.0, 68.0, 69.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.5}], "name": "kraken", "value": 1524.3999999999999}]} 08:20:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1524.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6992.43"}}} 08:20:38 INFO - Return code: 0 08:20:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:20:38 ERROR - # TBPL SUCCESS # 08:20:38 INFO - Running post-action listener: _resource_record_post_action 08:20:38 INFO - Running post-run listener: _resource_record_post_run 08:20:39 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 537743360; Read time: 16; Write time: 484380 08:20:39 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 240250880; Read time: 0; Write time: 298156 08:20:39 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296894464; Read time: 16; Write time: 186224 08:20:39 INFO - Running post-run listener: _upload_blobber_files 08:20:39 INFO - Blob upload gear active. 08:20:39 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:20:39 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:20:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 08:20:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 08:20:40 INFO - (blobuploader) - INFO - Open directory for files ... 08:20:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:20:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:20:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:41 INFO - (blobuploader) - INFO - Done attempting. 08:20:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:20:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:20:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:41 INFO - (blobuploader) - INFO - Done attempting. 08:20:41 INFO - (blobuploader) - INFO - Iteration through files over. 08:20:41 INFO - Return code: 0 08:20:41 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:20:41 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:20:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ba9a2c9871906647c039fe9bf5e573fccabc47f4f7ce6dfa86a5189f37506dd4c9c5000a32a7e77bcb96480311173b51a3cb63e3f1ef62682774c26eb1b93d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2282d252bd12e259446f5c7be8de85542bb5ea0fcb34add0a20a975a7cffef7b8f14ca5beca626a2d9e9872af002d5cc1fa9b96e42af023147411fba4f567167"} 08:20:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:20:41 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:20:41 INFO - Contents: 08:20:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ba9a2c9871906647c039fe9bf5e573fccabc47f4f7ce6dfa86a5189f37506dd4c9c5000a32a7e77bcb96480311173b51a3cb63e3f1ef62682774c26eb1b93d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2282d252bd12e259446f5c7be8de85542bb5ea0fcb34add0a20a975a7cffef7b8f14ca5beca626a2d9e9872af002d5cc1fa9b96e42af023147411fba4f567167"} 08:20:41 INFO - Running post-run listener: copy_logs_to_upload_dir 08:20:41 INFO - Copying logs to upload dir... 08:20:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 08:20:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.730400 ========= master_lag: 2.57 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-02-29 08:20:43.824272) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 08:20:43.827606) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ba9a2c9871906647c039fe9bf5e573fccabc47f4f7ce6dfa86a5189f37506dd4c9c5000a32a7e77bcb96480311173b51a3cb63e3f1ef62682774c26eb1b93d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2282d252bd12e259446f5c7be8de85542bb5ea0fcb34add0a20a975a7cffef7b8f14ca5beca626a2d9e9872af002d5cc1fa9b96e42af023147411fba4f567167"} build_url:https://queue.taskcluster.net/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011388 build_url: 'https://queue.taskcluster.net/v1/task/dG_TiwH6Q9mSUdkn8eIS9Q/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ba9a2c9871906647c039fe9bf5e573fccabc47f4f7ce6dfa86a5189f37506dd4c9c5000a32a7e77bcb96480311173b51a3cb63e3f1ef62682774c26eb1b93d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2282d252bd12e259446f5c7be8de85542bb5ea0fcb34add0a20a975a7cffef7b8f14ca5beca626a2d9e9872af002d5cc1fa9b96e42af023147411fba4f567167"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 08:20:43.852892) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 08:20:43.853240) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1456761170.590597-2076257025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 08:20:43.903087) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 08:20:43.903443) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 08:20:43.903743) ========= ========= Total master_lag: 2.80 =========