builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1450476264.21 results: success (0) buildid: 20151218113010 builduid: 5f314976ac3b46ab8423c106bc92f780 revision: 79e8243e94f78f6f599ad2a10ed6ede11b351cd3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 14:04:24.210558) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 14:04:24.211082) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 14:04:24.211391) ========= 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=fdc9337702648c539b2c5dbe000001aa-1450473342.623108-1509948100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006299 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 14:04:24.253828) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 14:04:24.254162) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 14:04:24.318595) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 14:04:24.318958) ========= 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=fdc9337702648c539b2c5dbe000001aa-1450473342.623108-1509948100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004647 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 14:04:24.373482) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 14:04:24.373802) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 14:04:24.374239) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 14:04:24.374985) ========= 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=fdc9337702648c539b2c5dbe000001aa-1450473342.623108-1509948100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 14:04:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.7M=0s 2015-12-18 14:04:24 (43.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175676 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 14:04:24.570131) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 14:04:24.570498) ========= 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=fdc9337702648c539b2c5dbe000001aa-1450473342.623108-1509948100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013984 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 14:04:24.621018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-18 14:04:24.621347) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 79e8243e94f78f6f599ad2a10ed6ede11b351cd3 --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 79e8243e94f78f6f599ad2a10ed6ede11b351cd3 --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=fdc9337702648c539b2c5dbe000001aa-1450473342.623108-1509948100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 14:04:25,090 truncating revision to first 12 chars 2015-12-18 14:04:25,090 Setting DEBUG logging. 2015-12-18 14:04:25,090 attempt 1/10 2015-12-18 14:04:25,090 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/79e8243e94f7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-18 14:04:25,678 unpacking tar archive at: fx-team-79e8243e94f7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.388896 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-18 14:04:26.024448) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 14:04:26.024784) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 14:04:26.037032) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 14:04:26.037325) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 14:04:26.037779) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-12-18 14:04:26.038110) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --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', '--system-bits', '64', '--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=fdc9337702648c539b2c5dbe000001aa-1450473342.623108-1509948100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:04:26 INFO - MultiFileLogger online at 20151218 14:04:26 in /builds/slave/test-pgo 14:04:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:04:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:04:26 INFO - {'append_to_log': False, 14:04:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:04:26 INFO - 'blob_upload_branch': 'Fx-Team', 14:04:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:04:26 INFO - 'branch': 'Fx-Team', 14:04:26 INFO - 'buildbot_json_path': 'buildprops.json', 14:04:26 INFO - 'config_files': ('talos/linux_config.py',), 14:04:26 INFO - 'default_actions': ('clobber', 14:04:26 INFO - 'read-buildbot-config', 14:04:26 INFO - 'download-and-extract', 14:04:26 INFO - 'populate-webroot', 14:04:26 INFO - 'create-virtualenv', 14:04:26 INFO - 'install', 14:04:26 INFO - 'run-tests'), 14:04:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:04:26 INFO - 'download_minidump_stackwalk': True, 14:04:26 INFO - 'download_symbols': 'ondemand', 14:04:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:04:26 INFO - 'tooltool.py': '/tools/tooltool.py', 14:04:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:04:26 INFO - '/tools/misc-python/virtualenv.py')}, 14:04:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:04:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:04:26 INFO - 'installer_path': 'installer.exe', 14:04:26 INFO - 'log_level': 'info', 14:04:26 INFO - 'log_name': 'talos', 14:04:26 INFO - 'log_to_console': True, 14:04:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:04:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:04:26 INFO - 'opt_config_files': (), 14:04:26 INFO - 'pip_index': False, 14:04:26 INFO - 'sps_profile': False, 14:04:26 INFO - 'sps_profile_interval': 0, 14:04:26 INFO - 'suite': 'dromaeojs-e10s', 14:04:26 INFO - 'system_bits': '64', 14:04:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:04:26 INFO - 'title': 'talos-linux64-ix-048', 14:04:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:04:26 INFO - 'use_talos_json': True, 14:04:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:04:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:04:26 INFO - 'work_dir': 'build'} 14:04:26 INFO - ##### 14:04:26 INFO - ##### Running clobber step. 14:04:26 INFO - ##### 14:04:26 INFO - Running pre-action listener: _resource_record_pre_action 14:04:26 INFO - Running main action method: clobber 14:04:26 INFO - rmtree: /builds/slave/test-pgo/build 14:04:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:04:27 INFO - Running post-action listener: _resource_record_post_action 14:04:27 INFO - ##### 14:04:27 INFO - ##### Running read-buildbot-config step. 14:04:27 INFO - ##### 14:04:27 INFO - Running pre-action listener: _resource_record_pre_action 14:04:27 INFO - Running main action method: read_buildbot_config 14:04:27 INFO - Using buildbot properties: 14:04:27 INFO - { 14:04:27 INFO - "project": "", 14:04:27 INFO - "product": "firefox", 14:04:27 INFO - "script_repo_revision": "production", 14:04:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:04:27 INFO - "repository": "", 14:04:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:04:27 INFO - "buildid": "20151218113010", 14:04:27 INFO - "pgo_build": "True", 14:04:27 INFO - "basedir": "/builds/slave/test-pgo", 14:04:27 INFO - "buildnumber": 110, 14:04:27 INFO - "slavename": "talos-linux64-ix-048", 14:04:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:04:27 INFO - "platform": "ubuntu64_hw", 14:04:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:04:27 INFO - "branch": "fx-team", 14:04:27 INFO - "repo_path": "integration/fx-team", 14:04:27 INFO - "revision": "79e8243e94f78f6f599ad2a10ed6ede11b351cd3", 14:04:27 INFO - "stage_platform": "linux64-pgo", 14:04:27 INFO - "builduid": "5f314976ac3b46ab8423c106bc92f780", 14:04:27 INFO - "slavebuilddir": "test" 14:04:27 INFO - } 14:04:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 14:04:27 INFO - Running post-action listener: _resource_record_post_action 14:04:27 INFO - ##### 14:04:27 INFO - ##### Running download-and-extract step. 14:04:27 INFO - ##### 14:04:27 INFO - Running pre-action listener: _resource_record_pre_action 14:04:27 INFO - Running main action method: download_and_extract 14:04:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:04:27 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')]} 14:04:27 INFO - https://queue.taskcluster.net/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:04:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/test_packages.json 14:04:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/test_packages.json 14:04:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:04:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:04:28 INFO - Downloaded 1302 bytes. 14:04:28 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:04:28 INFO - Using the following test package requirements: 14:04:28 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:04:28 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:04:28 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:28 INFO - u'jsshell-linux-x86_64.zip'], 14:04:28 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:04:28 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:04:28 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:04:28 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:04:28 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:04:28 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:04:28 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:04:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:04:28 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:28 INFO - https://queue.taskcluster.net/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:04:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:04:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:04:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:04:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:04:34 INFO - Downloaded 23121263 bytes. 14:04:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 14:04:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:04:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:04:35 INFO - Return code: 0 14:04:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:35 INFO - https://queue.taskcluster.net/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:04:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:04:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:04:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:04:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:04:44 INFO - Downloaded 23121263 bytes. 14:04:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 14:04:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:04:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:04:45 INFO - Return code: 0 14:04:45 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')]} 14:04:45 INFO - https://queue.taskcluster.net/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:04:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:04:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:04:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:04:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:04:50 INFO - Downloaded 11132039 bytes. 14:04:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 14:04:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:04:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 14:04:51 INFO - Return code: 0 14:04:51 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')]} 14:04:51 INFO - https://queue.taskcluster.net/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:04:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:04:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:04:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:04:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:04:58 INFO - Downloaded 54642602 bytes. 14:04:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:04:58 INFO - mkdir: /builds/slave/test-pgo/properties 14:04:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:04:58 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:04:58 INFO - Contents: 14:04:58 INFO - build_url:https://queue.taskcluster.net/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:04:58 INFO - Running post-action listener: _resource_record_post_action 14:04:58 INFO - Running post-action listener: set_extra_try_arguments 14:04:58 INFO - ##### 14:04:58 INFO - ##### Running populate-webroot step. 14:04:58 INFO - ##### 14:04:58 INFO - Running pre-action listener: _resource_record_pre_action 14:04:58 INFO - Running main action method: populate_webroot 14:04:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:04:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:04:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:04:58 INFO - '--tppagecycles', 14:04:58 INFO - '7'], 14:04:58 INFO - 'tests': ['tsvgm']}}, 14:04:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:04:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:04:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:04:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:04:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:04:58 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:04:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:04:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:58 INFO - 'talos_options': ['--e10s'], 14:04:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:04:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:58 INFO - 'tests': ['damp', 'tps']}, 14:04:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:58 INFO - 'talos_options': ['--e10s'], 14:04:58 INFO - 'tests': ['damp', 'tps']}, 14:04:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:04:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:04:58 INFO - 'other': {'tests': ['a11yr', 14:04:58 INFO - 'ts_paint', 14:04:58 INFO - 'tpaint', 14:04:58 INFO - 'sessionrestore', 14:04:58 INFO - 'sessionrestore_no_auto_restore']}, 14:04:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:04:58 INFO - 'tests': ['a11yr', 14:04:58 INFO - 'ts_paint', 14:04:58 INFO - 'tpaint', 14:04:58 INFO - 'sessionrestore', 14:04:58 INFO - 'sessionrestore_no_auto_restore']}, 14:04:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:04:58 INFO - 'tests': ['a11yr', 14:04:58 INFO - 'ts_paint', 14:04:58 INFO - 'tpaint', 14:04:58 INFO - 'sessionrestore', 14:04:58 INFO - 'sessionrestore_no_auto_restore']}, 14:04:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:04:58 INFO - 'tests': ['a11yr', 14:04:58 INFO - 'ts_paint', 14:04:58 INFO - 'tpaint', 14:04:58 INFO - 'sessionrestore', 14:04:58 INFO - 'sessionrestore_no_auto_restore']}, 14:04:58 INFO - 'other_l64': {'tests': ['a11yr', 14:04:58 INFO - 'ts_paint', 14:04:58 INFO - 'tpaint', 14:04:58 INFO - 'sessionrestore', 14:04:58 INFO - 'sessionrestore_no_auto_restore']}, 14:04:58 INFO - 'other_nol64': {'tests': ['a11yr', 14:04:58 INFO - 'ts_paint', 14:04:58 INFO - 'tpaint', 14:04:58 INFO - 'sessionrestore', 14:04:58 INFO - 'sessionrestore_no_auto_restore']}, 14:04:58 INFO - 'svgr': {'tests': ['tsvgx', 14:04:58 INFO - 'tsvgr_opacity', 14:04:58 INFO - 'tart', 14:04:58 INFO - 'tscrollx', 14:04:58 INFO - 'cart']}, 14:04:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:04:58 INFO - 'tests': ['tsvgx', 14:04:58 INFO - 'tsvgr_opacity', 14:04:58 INFO - 'tart', 14:04:58 INFO - 'tscrollx', 14:04:58 INFO - 'cart']}, 14:04:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:58 INFO - 'tests': ['tp5o']}, 14:04:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:58 INFO - 'talos_options': ['--e10s'], 14:04:58 INFO - 'tests': ['tp5o']}, 14:04:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:58 INFO - 'talos_options': ['--xperf_path', 14:04:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:04:58 INFO - 'tests': ['tp5n']}, 14:04:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:04:58 INFO - 'talos_options': ['--e10s', 14:04:58 INFO - '--xperf_path', 14:04:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:04:58 INFO - 'tests': ['tp5n']}}, 14:04:58 INFO - 'talos.zip': {'path': '', 14:04:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:04:58 INFO - Running post-action listener: _resource_record_post_action 14:04:58 INFO - ##### 14:04:58 INFO - ##### Running create-virtualenv step. 14:04:58 INFO - ##### 14:04:58 INFO - Running pre-action listener: _resource_record_pre_action 14:04:58 INFO - Running main action method: create_virtualenv 14:04:58 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:04:58 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 14:04:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:04:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:04:58 INFO - Using real prefix '/usr' 14:04:58 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:04:59 INFO - Installing distribute.............................................................................................................................................................................................done. 14:05:01 INFO - Installing pip.................done. 14:05:01 INFO - Return code: 0 14:05:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4270595f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abe600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d350>, '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 0x2b4e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e6e0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1450473342.623108-1509948100', '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 14:05:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 14:05:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:05:01 INFO - Using env: {'DISPLAY': ':0', 14:05:01 INFO - 'HOME': '/home/cltbld', 14:05:01 INFO - 'LANG': 'en_US.UTF-8', 14:05:01 INFO - 'LANGUAGE': 'en_US:en', 14:05:01 INFO - 'LOGNAME': 'cltbld', 14:05:01 INFO - 'MAIL': '/var/mail/cltbld', 14:05:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:01 INFO - 'MOZ_NO_REMOTE': '1', 14:05:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:01 INFO - 'NO_EM_RESTART': '1', 14:05:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:01 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:01 INFO - 'SHELL': '/bin/bash', 14:05:01 INFO - 'SHLVL': '1', 14:05:01 INFO - 'TERM': 'linux', 14:05:01 INFO - 'TMOUT': '86400', 14:05:01 INFO - 'USER': 'cltbld', 14:05:01 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450473342.623108-1509948100', 14:05:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:01 INFO - '_': '/tools/buildbot/bin/python'} 14:05:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:01 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 14:05:01 INFO - Cleaning up... 14:05:01 INFO - Return code: 0 14:05:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4270595f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abe600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d350>, '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 0x2b4e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e6e0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1450473342.623108-1509948100', '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 14:05:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 14:05:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:05:01 INFO - Using env: {'DISPLAY': ':0', 14:05:01 INFO - 'HOME': '/home/cltbld', 14:05:01 INFO - 'LANG': 'en_US.UTF-8', 14:05:01 INFO - 'LANGUAGE': 'en_US:en', 14:05:01 INFO - 'LOGNAME': 'cltbld', 14:05:01 INFO - 'MAIL': '/var/mail/cltbld', 14:05:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:01 INFO - 'MOZ_NO_REMOTE': '1', 14:05:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:01 INFO - 'NO_EM_RESTART': '1', 14:05:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:01 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:01 INFO - 'SHELL': '/bin/bash', 14:05:01 INFO - 'SHLVL': '1', 14:05:01 INFO - 'TERM': 'linux', 14:05:01 INFO - 'TMOUT': '86400', 14:05:01 INFO - 'USER': 'cltbld', 14:05:01 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450473342.623108-1509948100', 14:05:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:01 INFO - '_': '/tools/buildbot/bin/python'} 14:05:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:01 INFO - Downloading/unpacking psutil>=0.7.1 14:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:03 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 14:05:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:05:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:05:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:05:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:05:03 INFO - Installing collected packages: psutil 14:05:03 INFO - Running setup.py install for psutil 14:05:03 INFO - building 'psutil._psutil_linux' extension 14:05:03 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 14:05:03 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 14:05:03 INFO - building 'psutil._psutil_posix' extension 14:05:03 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 14:05:03 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 14:05:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:05:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:05:03 INFO - Successfully installed psutil 14:05:03 INFO - Cleaning up... 14:05:03 INFO - Return code: 0 14:05:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4270595f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abe600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d350>, '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 0x2b4e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e6e0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1450473342.623108-1509948100', '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 14:05:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 14:05:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:05:03 INFO - Using env: {'DISPLAY': ':0', 14:05:03 INFO - 'HOME': '/home/cltbld', 14:05:03 INFO - 'LANG': 'en_US.UTF-8', 14:05:03 INFO - 'LANGUAGE': 'en_US:en', 14:05:03 INFO - 'LOGNAME': 'cltbld', 14:05:03 INFO - 'MAIL': '/var/mail/cltbld', 14:05:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:03 INFO - 'MOZ_NO_REMOTE': '1', 14:05:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:03 INFO - 'NO_EM_RESTART': '1', 14:05:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:03 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:03 INFO - 'SHELL': '/bin/bash', 14:05:03 INFO - 'SHLVL': '1', 14:05:03 INFO - 'TERM': 'linux', 14:05:03 INFO - 'TMOUT': '86400', 14:05:03 INFO - 'USER': 'cltbld', 14:05:03 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450473342.623108-1509948100', 14:05:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:03 INFO - '_': '/tools/buildbot/bin/python'} 14:05:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:05:04 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 14:05:04 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 14:05:04 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 14:05:04 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 14:05:04 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 14:05:04 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 14:05:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:05:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:05:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:05:05 INFO - Installing collected packages: mozsystemmonitor 14:05:05 INFO - Running setup.py install for mozsystemmonitor 14:05:05 INFO - Successfully installed mozsystemmonitor 14:05:05 INFO - Cleaning up... 14:05:05 INFO - Return code: 0 14:05:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4270595f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abe600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d350>, '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 0x2b4e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e6e0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1450473342.623108-1509948100', '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 14:05:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 14:05:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:05:06 INFO - Using env: {'DISPLAY': ':0', 14:05:06 INFO - 'HOME': '/home/cltbld', 14:05:06 INFO - 'LANG': 'en_US.UTF-8', 14:05:06 INFO - 'LANGUAGE': 'en_US:en', 14:05:06 INFO - 'LOGNAME': 'cltbld', 14:05:06 INFO - 'MAIL': '/var/mail/cltbld', 14:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:06 INFO - 'MOZ_NO_REMOTE': '1', 14:05:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:06 INFO - 'NO_EM_RESTART': '1', 14:05:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:06 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:06 INFO - 'SHELL': '/bin/bash', 14:05:06 INFO - 'SHLVL': '1', 14:05:06 INFO - 'TERM': 'linux', 14:05:06 INFO - 'TMOUT': '86400', 14:05:06 INFO - 'USER': 'cltbld', 14:05:06 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450473342.623108-1509948100', 14:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:06 INFO - '_': '/tools/buildbot/bin/python'} 14:05:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:06 INFO - Downloading/unpacking blobuploader==1.2.4 14:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:07 INFO - Downloading blobuploader-1.2.4.tar.gz 14:05:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:05:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:05:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:05:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:05:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:08 INFO - Downloading docopt-0.6.1.tar.gz 14:05:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:05:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:05:08 INFO - Installing collected packages: blobuploader, requests, docopt 14:05:08 INFO - Running setup.py install for blobuploader 14:05:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:05:08 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:05:08 INFO - Running setup.py install for requests 14:05:09 INFO - Running setup.py install for docopt 14:05:09 INFO - Successfully installed blobuploader requests docopt 14:05:09 INFO - Cleaning up... 14:05:09 INFO - Return code: 0 14:05:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:05: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')]} 14:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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')]} 14:05:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4270595f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abe600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d350>, '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 0x2b4e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e6e0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1450473342.623108-1509948100', '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 14:05:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:05:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:05:09 INFO - Using env: {'DISPLAY': ':0', 14:05:09 INFO - 'HOME': '/home/cltbld', 14:05:09 INFO - 'LANG': 'en_US.UTF-8', 14:05:09 INFO - 'LANGUAGE': 'en_US:en', 14:05:09 INFO - 'LOGNAME': 'cltbld', 14:05:09 INFO - 'MAIL': '/var/mail/cltbld', 14:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:09 INFO - 'MOZ_NO_REMOTE': '1', 14:05:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:09 INFO - 'NO_EM_RESTART': '1', 14:05:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:09 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:09 INFO - 'SHELL': '/bin/bash', 14:05:09 INFO - 'SHLVL': '1', 14:05:09 INFO - 'TERM': 'linux', 14:05:09 INFO - 'TMOUT': '86400', 14:05:09 INFO - 'USER': 'cltbld', 14:05:09 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450473342.623108-1509948100', 14:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:09 INFO - '_': '/tools/buildbot/bin/python'} 14:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:05:09 INFO - Running setup.py (path:/tmp/pip-gHFeXm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:05:09 INFO - Running setup.py (path:/tmp/pip-Wo3bKn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:05:09 INFO - Running setup.py (path:/tmp/pip-lm5MSU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:05:09 INFO - Running setup.py (path:/tmp/pip-qml8SZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:05:09 INFO - Running setup.py (path:/tmp/pip-rySajm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:05:09 INFO - Running setup.py (path:/tmp/pip-KB8rLS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:05:09 INFO - Running setup.py (path:/tmp/pip-3U_Xgo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:05:09 INFO - Running setup.py (path:/tmp/pip-_l2rR0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:05:09 INFO - Running setup.py (path:/tmp/pip-L16ypw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:05:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:05:10 INFO - Running setup.py (path:/tmp/pip-Qdehuq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:05:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:05:10 INFO - Running setup.py (path:/tmp/pip-pHlMyY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:05:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:05:10 INFO - Running setup.py (path:/tmp/pip-XPVUon-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:05:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:05:10 INFO - Running setup.py (path:/tmp/pip-Qx6w9I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:05:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:05:10 INFO - Running setup.py (path:/tmp/pip-6hCvj4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:05:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:05:10 INFO - Running setup.py (path:/tmp/pip-qlkxt7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:05:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:05:10 INFO - Running setup.py (path:/tmp/pip-f3vvNf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:05:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:05:10 INFO - Running setup.py (path:/tmp/pip-Bda42Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:05:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:05:10 INFO - Running setup.py install for manifestparser 14:05:10 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:05:10 INFO - Running setup.py install for mozcrash 14:05:10 INFO - Running setup.py install for mozdebug 14:05:10 INFO - Running setup.py install for mozdevice 14:05:11 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:05:11 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:05:11 INFO - Running setup.py install for mozfile 14:05:11 INFO - Running setup.py install for mozhttpd 14:05:11 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:05:11 INFO - Running setup.py install for mozinfo 14:05:11 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:05:11 INFO - Running setup.py install for mozInstall 14:05:11 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:05:11 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:05:11 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:05:11 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:05:11 INFO - Running setup.py install for mozleak 14:05:11 INFO - Running setup.py install for mozlog 14:05:11 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:05:11 INFO - Running setup.py install for moznetwork 14:05:11 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:05:11 INFO - Running setup.py install for mozprocess 14:05:11 INFO - Running setup.py install for mozprofile 14:05:11 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:05:11 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:05:11 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:05:11 INFO - Running setup.py install for mozrunner 14:05:12 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:05:12 INFO - Running setup.py install for mozscreenshot 14:05:12 INFO - Running setup.py install for moztest 14:05:12 INFO - Running setup.py install for mozversion 14:05:12 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:05:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:05:12 INFO - Cleaning up... 14:05:12 INFO - Return code: 0 14:05:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4270595f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abe600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d350>, '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 0x2b4e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e6e0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1450473342.623108-1509948100', '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 14:05:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:05:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:05:12 INFO - Using env: {'DISPLAY': ':0', 14:05:12 INFO - 'HOME': '/home/cltbld', 14:05:12 INFO - 'LANG': 'en_US.UTF-8', 14:05:12 INFO - 'LANGUAGE': 'en_US:en', 14:05:12 INFO - 'LOGNAME': 'cltbld', 14:05:12 INFO - 'MAIL': '/var/mail/cltbld', 14:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:12 INFO - 'MOZ_NO_REMOTE': '1', 14:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:12 INFO - 'NO_EM_RESTART': '1', 14:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:12 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:12 INFO - 'SHELL': '/bin/bash', 14:05:12 INFO - 'SHLVL': '1', 14:05:12 INFO - 'TERM': 'linux', 14:05:12 INFO - 'TMOUT': '86400', 14:05:12 INFO - 'USER': 'cltbld', 14:05:12 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450473342.623108-1509948100', 14:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:12 INFO - '_': '/tools/buildbot/bin/python'} 14:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:05:12 INFO - Running setup.py (path:/tmp/pip-SCAvGz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:05:12 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)) 14:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:05:12 INFO - Running setup.py (path:/tmp/pip-dIWjIr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:05:12 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)) 14:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:05:12 INFO - Running setup.py (path:/tmp/pip-louIJL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:05:12 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)) 14:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:05:12 INFO - Running setup.py (path:/tmp/pip-5WmhNR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:05:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:05:12 INFO - Running setup.py (path:/tmp/pip-ML5_t0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:05:12 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)) 14:05:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:05:12 INFO - Running setup.py (path:/tmp/pip-_aF7kp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:05:13 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)) 14:05:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:05:13 INFO - Running setup.py (path:/tmp/pip-bD7T9x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:05:13 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)) 14:05:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:05:13 INFO - Running setup.py (path:/tmp/pip-Juhlom-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:05:13 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)) 14:05:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:05:13 INFO - Running setup.py (path:/tmp/pip-N86Txq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:05:13 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)) 14:05:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:05:13 INFO - Running setup.py (path:/tmp/pip-8m3f6F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:05:13 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)) 14:05:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:05:13 INFO - Running setup.py (path:/tmp/pip-C8Aqne-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:05:13 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)) 14:05:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:05:13 INFO - Running setup.py (path:/tmp/pip-RxWPTC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:05:13 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)) 14:05:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:05:13 INFO - Running setup.py (path:/tmp/pip-G0wlM7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 14:05:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:05:13 INFO - Running setup.py (path:/tmp/pip-0LSEEs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:05:13 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)) 14:05:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:05:13 INFO - Running setup.py (path:/tmp/pip-qwRdFc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:05:13 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)) 14:05:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:05:13 INFO - Running setup.py (path:/tmp/pip-ikuG1W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:05:13 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)) 14:05:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:05:13 INFO - Running setup.py (path:/tmp/pip-TgPJfj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:05:13 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)) 14:05:13 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)) 14:05:13 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)) 14:05:13 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)) 14:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:05:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:15 INFO - Downloading blessings-1.5.1.tar.gz 14:05:15 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 14:05:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:05:15 INFO - Installing collected packages: blessings 14:05:15 INFO - Running setup.py install for blessings 14:05:15 INFO - Successfully installed blessings 14:05:15 INFO - Cleaning up... 14:05:15 INFO - Return code: 0 14:05:15 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:05:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:05:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:05:15 INFO - Reading from file tmpfile_stdout 14:05:15 INFO - Current package versions: 14:05:15 INFO - argparse == 1.2.1 14:05:15 INFO - blessings == 1.5.1 14:05:15 INFO - blobuploader == 1.2.4 14:05:15 INFO - docopt == 0.6.1 14:05:15 INFO - manifestparser == 1.1 14:05:15 INFO - mozInstall == 1.12 14:05:15 INFO - mozcrash == 0.16 14:05:15 INFO - mozdebug == 0.1 14:05:15 INFO - mozdevice == 0.47 14:05:15 INFO - mozfile == 1.2 14:05:15 INFO - mozhttpd == 0.7 14:05:15 INFO - mozinfo == 0.9 14:05:15 INFO - mozleak == 0.1 14:05:15 INFO - mozlog == 3.1 14:05:15 INFO - moznetwork == 0.27 14:05:15 INFO - mozprocess == 0.22 14:05:15 INFO - mozprofile == 0.27 14:05:15 INFO - mozrunner == 6.11 14:05:15 INFO - mozscreenshot == 0.1 14:05:15 INFO - mozsystemmonitor == 0.0 14:05:15 INFO - moztest == 0.7 14:05:15 INFO - mozversion == 1.4 14:05:15 INFO - psutil == 3.1.1 14:05:15 INFO - requests == 1.2.3 14:05:15 INFO - wsgiref == 0.1.2 14:05:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:05:15 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')]} 14:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:15 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')]} 14:05:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4270595f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abe600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d350>, '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 0x2b4e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e6e0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1450473342.623108-1509948100', '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 14:05:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 14:05:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:05:15 INFO - Using env: {'DISPLAY': ':0', 14:05:15 INFO - 'HOME': '/home/cltbld', 14:05:15 INFO - 'LANG': 'en_US.UTF-8', 14:05:15 INFO - 'LANGUAGE': 'en_US:en', 14:05:15 INFO - 'LOGNAME': 'cltbld', 14:05:15 INFO - 'MAIL': '/var/mail/cltbld', 14:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:15 INFO - 'MOZ_NO_REMOTE': '1', 14:05:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:15 INFO - 'NO_EM_RESTART': '1', 14:05:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:15 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:15 INFO - 'SHELL': '/bin/bash', 14:05:15 INFO - 'SHLVL': '1', 14:05:15 INFO - 'TERM': 'linux', 14:05:15 INFO - 'TMOUT': '86400', 14:05:15 INFO - 'USER': 'cltbld', 14:05:15 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450473342.623108-1509948100', 14:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:15 INFO - '_': '/tools/buildbot/bin/python'} 14:05:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 14:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 14:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 14:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 14:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 14:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 14:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 14:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 14:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:05:16 INFO - Cleaning up... 14:05:16 INFO - Return code: 0 14:05:16 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4270595f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abe600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d350>, '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 0x2b4e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e6e0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1450473342.623108-1509948100', '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 14:05:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 14:05:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:05:16 INFO - Using env: {'DISPLAY': ':0', 14:05:16 INFO - 'HOME': '/home/cltbld', 14:05:16 INFO - 'LANG': 'en_US.UTF-8', 14:05:16 INFO - 'LANGUAGE': 'en_US:en', 14:05:16 INFO - 'LOGNAME': 'cltbld', 14:05:16 INFO - 'MAIL': '/var/mail/cltbld', 14:05:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:16 INFO - 'MOZ_NO_REMOTE': '1', 14:05:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:16 INFO - 'NO_EM_RESTART': '1', 14:05:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:16 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:16 INFO - 'SHELL': '/bin/bash', 14:05:16 INFO - 'SHLVL': '1', 14:05:16 INFO - 'TERM': 'linux', 14:05:16 INFO - 'TMOUT': '86400', 14:05:16 INFO - 'USER': 'cltbld', 14:05:16 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450473342.623108-1509948100', 14:05:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:16 INFO - '_': '/tools/buildbot/bin/python'} 14:05:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:16 INFO - Downloading/unpacking jsonschema 14:05:16 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 14:05:16 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 14:05:16 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 14:05:16 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 14:05:16 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 14:05:16 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 14:05:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:05:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 14:05:18 INFO - Downloading/unpacking functools32 (from jsonschema) 14:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:18 INFO - Downloading functools32-3.2.3-2.tar.gz 14:05:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:05:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:05:18 INFO - warning: no files found matching '*.txt' 14:05:18 INFO - no previously-included directories found matching 'build' 14:05:18 INFO - no previously-included directories found matching 'dist' 14:05:18 INFO - no previously-included directories found matching '.git*' 14:05:18 INFO - Installing collected packages: jsonschema, functools32 14:05:18 INFO - Running setup.py install for functools32 14:05:18 INFO - warning: no files found matching '*.txt' 14:05:18 INFO - no previously-included directories found matching 'build' 14:05:18 INFO - no previously-included directories found matching 'dist' 14:05:18 INFO - no previously-included directories found matching '.git*' 14:05:18 INFO - Successfully installed jsonschema functools32 14:05:18 INFO - Cleaning up... 14:05:18 INFO - Return code: 0 14:05:18 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:05:18 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')]} 14:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:18 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')]} 14:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4270595f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2abe600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d350>, '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 0x2b4e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e6e0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1450473342.623108-1509948100', '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 14:05:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 14:05:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:05:18 INFO - Using env: {'DISPLAY': ':0', 14:05:18 INFO - 'HOME': '/home/cltbld', 14:05:18 INFO - 'LANG': 'en_US.UTF-8', 14:05:18 INFO - 'LANGUAGE': 'en_US:en', 14:05:18 INFO - 'LOGNAME': 'cltbld', 14:05:18 INFO - 'MAIL': '/var/mail/cltbld', 14:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:18 INFO - 'MOZ_NO_REMOTE': '1', 14:05:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:18 INFO - 'NO_EM_RESTART': '1', 14:05:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:18 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:18 INFO - 'SHELL': '/bin/bash', 14:05:18 INFO - 'SHLVL': '1', 14:05:18 INFO - 'TERM': 'linux', 14:05:18 INFO - 'TMOUT': '86400', 14:05:18 INFO - 'USER': 'cltbld', 14:05:18 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450473342.623108-1509948100', 14:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:18 INFO - '_': '/tools/buildbot/bin/python'} 14:05:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:18 INFO - Downloading/unpacking flake8 14:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:05:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 14:05:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:05:20 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 14:05:20 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 14:05:20 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 14:05:20 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 14:05:20 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 14:05:20 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 14:05:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:05:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 14:05:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:05:20 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 14:05:20 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 14:05:20 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 14:05:20 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 14:05:20 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 14:05:20 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 14:05:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 14:05:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:05:20 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 14:05:20 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 14:05:20 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 14:05:20 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 14:05:20 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 14:05:20 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 14:05:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:05:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:05:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:05:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:05:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:05:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:05:21 INFO - no previously-included directories found matching 'docs/_build' 14:05:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:05:21 INFO - Running setup.py install for pep8 14:05:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:05:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:05:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:05:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:05:21 INFO - no previously-included directories found matching 'docs/_build' 14:05:21 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:05:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:05:21 INFO - Cleaning up... 14:05:21 INFO - Return code: 0 14:05:21 INFO - Running post-action listener: _resource_record_post_action 14:05:21 INFO - Running post-action listener: _start_resource_monitoring 14:05:21 INFO - Starting resource monitoring. 14:05:21 INFO - ##### 14:05:21 INFO - ##### Running install step. 14:05:21 INFO - ##### 14:05:21 INFO - Running pre-action listener: _resource_record_pre_action 14:05:21 INFO - Running main action method: install 14:05:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:05:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:05:21 INFO - Reading from file tmpfile_stdout 14:05:21 INFO - Detecting whether we're running mozinstall >=1.0... 14:05:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:05:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:05:21 INFO - Reading from file tmpfile_stdout 14:05:21 INFO - Output received: 14:05:21 INFO - Usage: mozinstall [options] installer 14:05:21 INFO - Options: 14:05:21 INFO - -h, --help show this help message and exit 14:05:21 INFO - -d DEST, --destination=DEST 14:05:21 INFO - Directory to install application into. [default: 14:05:21 INFO - "/builds/slave/test-pgo"] 14:05:21 INFO - --app=APP Application being installed. [default: firefox] 14:05:21 INFO - mkdir: /builds/slave/test-pgo/build/application 14:05:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 14:05:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 14:05:37 INFO - Reading from file tmpfile_stdout 14:05:37 INFO - Output received: 14:05:37 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:05:37 INFO - Running post-action listener: _resource_record_post_action 14:05:37 INFO - ##### 14:05:37 INFO - ##### Running run-tests step. 14:05:37 INFO - ##### 14:05:37 INFO - Running pre-action listener: _resource_record_pre_action 14:05:37 INFO - Running main action method: run_tests 14:05:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:05:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:05:37 INFO - Python 2.7.3 14:05:37 INFO - Return code: 0 14:05:37 INFO - grabbing minidump binary from tooltool 14:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:37 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 0x2b4d350>, '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 0x2b4e250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:05:37 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 14:05:37 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 14:05:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:05:37 INFO - Return code: 0 14:05:37 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:05:37 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:05:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:05:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:05:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:05:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:05:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:05:38 INFO - Return code: 0 14:05:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 14:05:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost 14:05:38 INFO - Using env: {'DISPLAY': ':0', 14:05:38 INFO - 'HOME': '/home/cltbld', 14:05:38 INFO - 'LANG': 'en_US.UTF-8', 14:05:38 INFO - 'LANGUAGE': 'en_US:en', 14:05:38 INFO - 'LOGNAME': 'cltbld', 14:05:38 INFO - 'MAIL': '/var/mail/cltbld', 14:05:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:05:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:38 INFO - 'MOZ_NO_REMOTE': '1', 14:05:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:05:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:05:38 INFO - 'NO_EM_RESTART': '1', 14:05:38 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:05:38 INFO - 'PWD': '/builds/slave/test-pgo', 14:05:38 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:05:38 INFO - 'SHELL': '/bin/bash', 14:05:38 INFO - 'SHLVL': '1', 14:05:38 INFO - 'TERM': 'linux', 14:05:38 INFO - 'TMOUT': '86400', 14:05:38 INFO - 'USER': 'cltbld', 14:05:38 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1450473342.623108-1509948100', 14:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:38 INFO - '_': '/tools/buildbot/bin/python'} 14:05:38 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost'] with output_timeout 3600 14:05:38 INFO - mozversion INFO | application_buildid: 20151218113010 14:05:38 INFO - mozversion INFO | application_changeset: 79e8243e94f78f6f599ad2a10ed6ede11b351cd3 14:05:38 INFO - mozversion INFO | application_display_name: Nightly 14:05:38 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:05:38 INFO - mozversion INFO | application_name: Firefox 14:05:38 INFO - mozversion INFO | application_remotingname: firefox 14:05:38 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 14:05:38 INFO - mozversion INFO | application_vendor: Mozilla 14:05:38 INFO - mozversion INFO | application_version: 46.0a1 14:05:38 INFO - mozversion INFO | platform_buildid: 20151218113010 14:05:38 INFO - mozversion INFO | platform_changeset: 79e8243e94f78f6f599ad2a10ed6ede11b351cd3 14:05:38 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 14:05:38 INFO - mozversion INFO | platform_version: 46.0a1 14:05:38 INFO - 2015-12-18 14:05:38,569 DEBUG : using testdate: 1450476338 14:05:38 INFO - 2015-12-18 14:05:38,569 DEBUG : actual date: 1450476338 14:05:38 INFO - 2015-12-18 14:05:38,648 INFO : starting webserver on 'localhost:53338' 14:05:38 INFO - 2015-12-18 14:05:38,650 INFO : Starting test suite talos-linux64-ix-048.e 14:05:38 INFO - 2015-12-18 14:05:38,650 INFO : Starting test dromaeo_css 14:05:38 INFO - 2015-12-18 14:05:38,650 DEBUG : operating with platform_type : linux_ 14:05:38 INFO - 2015-12-18 14:05:38,651 INFO : Initialising browser for dromaeo_css test... 14:05:38 INFO - 2015-12-18 14:05:38,667 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5Yzi0v/profile http://localhost:53338/getInfo.html 14:05:43 INFO - 2015-12-18 14:05:43,597 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:05:43 INFO - 2015-12-18 14:05:43,597 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:05:43 INFO - 2015-12-18 14:05:43,597 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:05:43 INFO - 2015-12-18 14:05:43,597 DEBUG : BROWSER_OUTPUT: __metrics 14:05:43 INFO - 2015-12-18 14:05:43,706 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:05:44 INFO - 2015-12-18 14:05:44,523 INFO : Browser initialized. 14:05:44 INFO - 2015-12-18 14:05:44,524 INFO : Running cycle 1/1 for dromaeo_css test... 14:05:44 INFO - 2015-12-18 14:05:44,524 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5Yzi0v/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:05:56 INFO - 2015-12-18 14:05:56,386 DEBUG : BROWSER_OUTPUT: RSS: Main: 150683648 14:05:56 INFO - 2015-12-18 14:05:56,386 DEBUG : BROWSER_OUTPUT: 14:06:45 INFO - 2015-12-18 14:06:45,994 DEBUG : BROWSER_OUTPUT: 1450476405993 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] 14:08:54 INFO - 2015-12-18 14:08:54,640 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53338/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53338/tests/dromaeo/cssquery-ext.html) 14:08:55 INFO - 2015-12-18 14:08:55,868 DEBUG : BROWSER_OUTPUT: RSS: Main: 158785536 14:08:55 INFO - 2015-12-18 14:08:55,868 DEBUG : BROWSER_OUTPUT: 14:11:57 INFO - 2015-12-18 14:11:57,958 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53338/tests/dromaeo/cssquery-ext.html (next: http://localhost:53338/tests/dromaeo/cssquery-jquery.html) 14:11:58 INFO - 2015-12-18 14:11:58,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 155348992 14:11:58 INFO - 2015-12-18 14:11:58,551 DEBUG : BROWSER_OUTPUT: 14:15:00 INFO - 2015-12-18 14:15:00,291 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53338/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53338/tests/dromaeo/cssquery-mootools.html) 14:15:00 INFO - 2015-12-18 14:15:00,885 DEBUG : BROWSER_OUTPUT: RSS: Main: 154243072 14:15:00 INFO - 2015-12-18 14:15:00,886 DEBUG : BROWSER_OUTPUT: 14:18:02 INFO - 2015-12-18 14:18:02,495 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53338/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53338/tests/dromaeo/cssquery-prototype.html) 14:18:03 INFO - 2015-12-18 14:18:03,082 DEBUG : BROWSER_OUTPUT: RSS: Main: 152981504 14:18:03 INFO - 2015-12-18 14:18:03,082 DEBUG : BROWSER_OUTPUT: 14:21:05 INFO - 2015-12-18 14:21:05,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53338/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53338/tests/dromaeo/cssquery-yui.html) 14:21:05 INFO - 2015-12-18 14:21:05,941 DEBUG : BROWSER_OUTPUT: RSS: Main: 152174592 14:21:05 INFO - 2015-12-18 14:21:05,941 DEBUG : BROWSER_OUTPUT: 14:24:08 INFO - 2015-12-18 14:24:08,276 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53338/tests/dromaeo/cssquery-yui.html (next: http://localhost:53338/tests/dromaeo/cssquery-dojo.html) 14:24:08 INFO - 2015-12-18 14:24:08,534 DEBUG : BROWSER_OUTPUT: RSS: Main: 156143616 14:24:08 INFO - 2015-12-18 14:24:08,534 DEBUG : BROWSER_OUTPUT: 14:24:08 INFO - 2015-12-18 14:24:08,534 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:24:08 INFO - 2015-12-18 14:24:08,534 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:24:08 INFO - 2015-12-18 14:24:08,534 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:24:08 INFO - 2015-12-18 14:24:08,534 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:24:08 INFO - 2015-12-18 14:24:08,535 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3113.95329070064;3143.2927591291964;3185.4903215485497;3209.181658677037;3229.935401291975;5223.555997740196;5317.415084340724;5369.9463005369935;5378.838634840951;5433.864153396167;5296.788128474856;5329.173978033401;5383.300170977767;5407.459254074591;5410.404855465896;4832.589229915461;4845.830395936143;4992.925106123411;5006.54941055305;5075.720835354054;4672.64955128365;4867.221244600864;4896.43690975537;4901.436334821487;4977.253411988195;4869.853904382874;4871.658983871131;4896.143174944388;4931.901361972758;4933.087378834891;4862.100511405401;4910.533499317595;4919.4834542373255;4932.630052746058;4942.431620363633;4733.313669517935;4831.202851529493;4842.903141937141;4846.927296090562;4887.242477416006;4970.900581988376;5077.796888124471;5107.233914912756;5122.820701275475;5220.216967454874;5686.004949133885;5689.516391106761;5701.0308247598;5726.856828579277;5738;5689.573282003867;5752.36723960364;5763;5777.59556831022;5826.737796799154;5384.6499977501335;5399.325084364455;5402.405735369146;5408.4050754416985;5435.619506634537;5802;5827.65034097947;5830.47525722687;5851.61964472308;5896.557758168155;5597.104463285855;5656.971715141398;5673.035583950738;5701.971490142523;5752.223449834302;5815.389384114692;5821.126830975388;5829.446202610745;5834.774697313612;5857.062869940789;5809;5815.127730840323;5820.94179058204;5822.446867547576;5823.970880145657;5513.696746678891;5608.663480191201;5620.381758006616;5622.606417550732;5747.568932330092;4345.087531618396;4367.344898265285;4389.582989615981;4430.734155950653;4482.887927801831;4034.757914525138;4036.0313524754433;4049.1699201663587;4074.083331250445;4076.510818701775;5252.9737351313;5486.588505861996;5501.257330260443;5510.393856675762;5511.696856672921;5778.393268706725;5786.797462088806;5811.738471768696;5840;5885.146653735184;5477.20580515823;5478.835634930879;5479.972600136974;5485.314335708036;5510.641808282448;4894.706317620954;5046.1926091825135;5101.51535604117;5123.6157288202785;5174.97412512935;5789.102689083199;5790.392008839095;5827.184194212899;5887.8233652990475;5917.142014407887;5769.3942136076785;5771.422857714195;5779;5782.1615865698395;5787.421257874179;5806.82579522615;5810.76756929735;5813.215215945793;5814.156947242711;5841.386654401396;5603.38362780102;5633.324001119728;5726.055200891807;5732.226149469935;5785.82642520725;5808.593398462236;5832.475077243069;5838.474537291664;5841.32824725162;5842.883142337215;5493.972530137324;5505.504504594605;5691.089425691869;5705.942940570541;5706.42935706426;5552.361478430033;5581.6930068846605;5640.900024495184;5666.829995100154;5718.3423906249645;5590.608657393944;5594.9720251398485;5613.438656134517;5642.069058605284;5649.406812284816;5471.316085489314;5555.194496798023;5696.886062278814;5734.05388110957;5755.482006619424;5530.529904958124;5600.775968961359;5604.383517812956;5607.2149899014985;5632.971835140798 14:24:08 INFO - 2015-12-18 14:24:08,535 DEBUG : BROWSER_OUTPUT: |1;ext.html;575.9690154623224;583.5331734612311;587.8295294364634;590.5187272373016;604.2990131447522;37059.814700926494;38038;38158.42762358567;38206.80896595516;38217;41731;42355.15289694204;42570.93572660685;42578.36132458015;42583.574164258345;8653.134686531344;8735.213830755263;8747.081556436578;8757.124287571223;8811.911880881205;8547.717842323638;8681;8703.52130632815;8718.084601116887;8732.17044380786;8648.697295594655;8682.739517814476;8745.868811967826;8777.605007774666;8781.209691127797;8727.869081963776;8767.780805479819;8779.341549383822;8815.162559556831;8836.64653413869;8567.614457349371;8660.393772435931;8721.563921803885;8723.869141962876;8741.825163496758;38970;39591;39598.60401396007;39630.207395851925;39909.40135897935;3182.5067114597273;3224.516322551636;3311.3542859142476;3490.022793617791;3593.982030089859;29074.70925290762;29397.85301073481;29561.408771824445;30000;30446.54330185049;3846.192299617084;3924.2151569686175;4032.6370626643447;4038.192361527706;4039.8284497495692;249005.9999999982;249210;251408;252152;252190;57677.711611442515;57909.420905791245;58084.709576451845;58101.418985810444;58368.4163158363;60957.390426096055;66145.33854661392;66379.33620663828;66802.3319766796;66868.66565667141;14857.628559286104;14933.477328293458;14963.70072598542;15019.699606007818;15054.32255548481;11250.324980501196;11297.830532542019;11354.829677554842;11366.772664546828;11373.658790236306;20200.29298974529;20448.284310049075;20508.179672813218;20528.897355513127;20530.281440149523;8083.878741818878;8090.352771778244;8211.507309561446;8312.293455056268;8366.58167091643;945.6075728572703;987.4174237200086;1030.3920686794827;1044.9007344302279;1075.946202689878;28104.43791124166;28789.856050719613;28793.280167995967;32163.678363216535;33582.49626255608;999.6900960702205;1110.5946329589804;1113.3820729495046;1117.7820325036703;1123.4607388453587;14691.55925322242;14743.336549855283;14812.555623331318;15035;15123.773143402857;358136;360558;362145;363070;363091;52408.737956309975;52681.2097818533;52841.73579132157;52844.20733688998;52989;1335.7194989052214;1343.0732794371852;1343.892488600929;1349.4399824073096;1355.9389827457787;27472;28565.14304570866;28747.71252287534;28765.856170719013;28766.568501472077;44486.555134448245;44889.77555112204;45079;45105;45484.99665036777;269358;269712;270447;270689;271318;31671;31706.36587268288;32080;32222.516662249614;32228.516572250966;41357;41692.75880920359;42259.7887010563;42303.576964229964;43331.78334108309;35906.8204658975;36343.45484817677;36999;36999.260014799016;42830;37967;39145.41281880831;39788.40317395183;40439.3934090983;40929.79535102305;38646;39149.41275880921;40313.79843100766;40935;41033.79483102685;37037.62962370342;38783;38835.805820971844;39498;39793.60206397899;26771.19686409411;26991.650417478653;27122;27345.86327068352;27424.72575274222 14:24:08 INFO - 2015-12-18 14:24:08,535 DEBUG : BROWSER_OUTPUT: |2;jquery.html;347.12005067154735;357.07517529598334;357.6066327040256;358.96769290763825;360.9981950090249;11245.437728113582;11714.414279286044;16309.184540772958;16801;17443.476695699133;15367.538973830775;15512.922435387836;15564.45524406646;17390.3913363032;17768;5933.732982015809;6299.307076221635;6467;6504.70728817202;6525.184351956005;6312.684365781715;6422.678866056702;6835.28229535899;6840.28177041411;6864.9656751716175;6187.814365569017;6423.197100362455;6425.485961123099;6741.966290168542;6776.390124888759;5279.577633789307;6408.166938298038;6432.903506447407;6492.837679058014;6792.966035169842;6418.646974416405;6433.324500927429;6459.35406459355;6475.255345635218;6485.2541957675;20985.580288394147;21553.5689286215;22169.224077157385;22187.889060554757;22271.888640556856;2229.9108035678555;2249.865008099503;2310.1567927706433;2350.306659535441;2368.751281115475;14103.294835258299;14330.64173395663;14390.568282951528;14593.635159121108;14844.332005059798;2005.0977060322766;2022.5348169920853;2076.1384025629345;2091.1426315210692;2091.7699053104147;67777.66111169462;69322.65338673274;70430.99999999949;70473.64763176203;71983;15138.772918406232;15302.08187508753;15451;15465.072095674295;15508.767368489482;23757.7624223759;23894.163704270613;23921.641175382385;24017.399565011016;24075.157369491983;8946.910530894738;8979.057198994142;9029.909700903037;9039.954800225956;9084.364094513452;7739.535627862234;7805.687772489036;7833.921660783433;7835.882461763078;7853.332466740277;7460.552366858006;7625.428092893055;7657.387409007378;7664.501807382502;7802.102758182768;1799.4075243409416;1859.9256029758658;3018.652854921668;3021.6374035115928;3111.859966301522;841.1630427724454;876.3909083187251;897.6678628907346;942.4486675295029;962.6390103711109;15561.688766224612;16296.592585185228;16631.168441578116;17366.65266694659;17518;905.8912930448388;908.68650315641;933.2207606648388;965.8116667249819;1015.0205052124735;9682.612695492242;9713.757156071013;10022.899771002196;10135.695929122137;10152.492375381202;476937;480415;484046;484214;484301;76306.77870364358;76599.61700191464;77244;80340;80726.57820265401;1110.6890070780194;1124.2804605052772;1133.7449073958294;1136.8806275341135;1151.45305979659;15275.541733748005;15284.694306114037;15348.30932608013;15562.922185389001;15756.133412662413;33651.326973460884;34420.65579344174;35034.85137062159;35255;35622.28755424929;44624.10751785011;44928.32607510955;45342.31986520139;46194;49056.01887962292;9195.586198620944;9699.175570076623;9784.119429251401;9803.16673082796;9806.75483112928;11466.713332166762;15310.693786123993;16268.349266029227;16460.176991150154;17050.658986820443;14104.365303561159;14146.151230926178;14359.92820035893;14469;14542.054766440147;13904.652383690489;13930.860691392956;14000.229987350793;14718.411263549338;15011.699766004836;14508.637284067983;15154.469593564172;15163.469278575638;15329.46346877854;15511.612209694396;8600.827983440422;9630.555416687554;9687;9931.304808663324;9937.701868943943;10068.194544436281;12787.488500459878;13383.263920484467;13965;14737.778933315794 14:24:08 INFO - 2015-12-18 14:24:08,535 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1503.8420965798598;1679.5045461588832;1717.716576764834;1724.6636905803368;1736.7221244600858;7038.577685338877;7193.964030179842;7200.495965282439;7212.423006159508;7501.5874126923;7395.963020184891;7428.851422971537;7451.329380355767;7483.8877416838795;7500.324970752631;2153.8923053847325;2190.4742861713153;2192.1450634252656;2194.1333173396497;2195.1548653768336;2197.52753158071;2216.357256395643;2287.2680742162515;2287.405274628592;2287.839851210416;2192.1560199323294;2197.494576247464;2219.411855858199;2236.4408897775556;2245.38251980705;2183.5087105401235;2201.8348623853117;2235.821134309251;2235.977640223601;2236.664500324948;2205.2722601541454;2230.5984922713906;2232.821374290053;2233.6314508106143;2235.9888200559058;7305.52514086588;7378.741744038986;7393.778186654409;7394.852102957911;7406.185319614838;4479.910401791946;4564.5435456454425;4576.405067341258;4594.540545945379;4600.125976064537;3047.360054388581;3132.859021344045;3215.3569286142865;3233.062411900546;3234.4016356974034;1015.5629783855835;1054.5149231353587;1070.122499550369;1085.375908852413;1116.3246236027248;9776.804463910681;9798.118169364792;9834.508274586313;9838.114569688762;9852.211823054211;3834.1373191031794;3843.1737176507186;3844.961550384516;3898.629630185128;4007.719459637856;8043.839123217503;8056.39577031725;8089;8150.225728555778;8154.592270386457;4446.510883802779;4459.665525085632;4464.709793863389;4480.350349199413;4507.391502147234;4130.876073717794;4137.482814648169;4138.503379594468;4143.02638879863;4180.268453020709;3198.296374797541;3213.453712868818;3244.626867910173;3264.9347013060083;3270.4113259613023;1000.2246013326404;1015.9085682288629;1026.440589878518;1029.2332212501585;1031.231732359397;953.3374304858196;1002.0981116994617;1096.923215374916;1161.6747310753003;1323.0341850449227;6573.967130164318;6654.26803051664;6706.597604143767;6724.193096828412;6729.798106056826;607.2682417686677;613.8153364007509;626.2297374229723;627.3350248736355;760.8972788673569;5209.817656382084;5295.126304159848;5369.275147855068;5394.973025134927;5410.107332290128;8476.703315383931;8657.696980605648;8743.125687431206;8788.209061184523;8798.29613630908;8567.914320856837;8625.654973800978;8648.091950345122;8673.392862499564;8728.781780455412;6818.147731533559;6952.860942781217;6969.2682268362105;6979.965100174568;6990.196127445409;6758.695858686273;6759.662016899037;6773.288804675438;6777.966110169417;6808.897866531907;7603.0876294844975;7826;7908.6045697713735;7918.485298455582;7962;7950.204979502235;8069.152738962324;8098.51408915467;8105.878411823709;8153.7553873383895;6005.729742161526;6054.545909056927;6123;6165.167702360124;6171.506279497539;7114.822129446805;7143.357097861218;7158.2841715828;7167.319104685047;7167.3549380556;5836.8944446663345;6541.967290163519;6575.80272591823;6649.434798042221;6680.03139544773;6323.968380158254;6516.120323756232;6519.152510173647;6539.149910511603;6597.373249541286;6587.934120658923;6634.601923884582;6661.633610151488;6844.315568443116;6850;6186.10301506288;6214.471769899609;6237.438630523275;6241.687915604292;6246.718897649525;6290.591111577733;6296.464800492009;6299.590526615755;6344.555881088279;6350.618962862243 14:24:08 INFO - 2015-12-18 14:24:08,535 DEBUG : BROWSER_OUTPUT: |4;prototype.html;333.0242389797892;344.2564061626886;345.58874938822794;349.79012592444553;354.2914171656688;6250.187475628168;6285.245770507546;6329.145565348676;6331.968340158304;6405.61566306022;6200.937990620092;6225.159603453532;6264.123022776804;6273.184486016811;6280.685965701719;4726.031163611451;4726.598239149659;4733.763311834403;4735.431748190222;4738.099761045408;4737.218358970783;4743.169945259566;4743.383360163174;4743.549362810545;4744.5492678195515;4614.054118905617;4620.768961551926;4679.672422930396;4695.859124226278;4697.013627138305;4697.647676424282;4697.78859951303;4726.905461890778;4737.123632128068;4742.644301677371;4098.631123198897;4099.97950010251;4102.261592913274;4107.815148318333;4108.36320370343;5920.348761636216;5927.2590926134235;5928.555358348141;5945.8810823783715;5954.345022047572;5431.293931788881;5531.640443371209;5534.833954981357;5544.695041772701;5556.666600004012;6640.80077597668;6640.93359066408;6650.168728908887;6650.767223147215;6666.200055993263;4561.452625684906;4565.703229290086;4567.840125595588;4571.085782843445;4584.083183363341;6700.162479690039;6836.829079273009;6848.589084654936;6863.965680171617;6887.173539175281;4599.793009314589;4613.331066995267;4617.7691115444095;4619.676622636383;4621.491635920046;4649.976750116295;4669.276262179367;4672.766361681903;4672.883177920579;4688.249880019181;5432.320959880015;5451.918221226685;5455.563554915597;5458.153986132156;5464.836054918359;6506.739730410731;6629.469642428594;6637.601743895381;6651.900221496681;6707.3292670732535;1635.501172142508;1643.2112585958807;1646.415522489523;1648.5384092454133;1650.3893559383105;1058.4231593781408;1094.2395035450445;1105.9391733454577;1118.625260537729;1125.8480105185859;6331.493480521547;6336.904946425807;6341.365863413622;6356.713947872265;6363.427291543783;6928.203256625452;6944.618046007417;6953.304669533006;6953.965230173918;6954.061201737802;6256.249250089927;6291.4023167799905;6324.114623952651;6358.7456501740335;6409.583377080568;3733.309337772521;3784.0539865033743;3786.8295926683363;3794.2411517696573;3814.6185381462187;7070.186928503185;7099.183593886666;7113.0753002109395;7116.964415177891;7127.643617819192;6969.825754356181;7054.118235220598;7142.5714457132735;7179.174394944544;7185.993960845486;7069.469789765788;7104.183018952784;7106.893396599158;7111.6799744010605;7113.359797618239;6983.685734142077;6988.6505674715045;6991.44068474531;6996.6151861648095;7011.3689767919095;6750.729970801113;6893.551919125241;6895;6909.44724422035;6929.064576282138;7007.089078419773;7021.894671579828;7036.507444478837;7098;7108.289171083057;4625.768711564341;4692.483826778984;4696.436427628706;4699.929501057555;4700.2244629635725;6902.516823822284;6955;6982.1272340957385;7020.438364930691;7022.789316320519;6807.625580593115;6808.251092379934;6811.182658081062;6812.455003599601;6814.318568143146;6753.864922701617;6756.290589488033;6767.154105736783;6789.490788190807;6800.965995169992;6470.38531339522;6594.637294948824;6604.933950660432;6642.83392915181;6651.7006734698025;6806.387425131762;6806.965965170142;6820.31796820314;6825.249222585611;6825.55633883796;6494.935050649433;6636;6656.201255849329;6657.40083392497;6657.434118100015 14:24:08 INFO - 2015-12-18 14:24:08,536 DEBUG : BROWSER_OUTPUT: |5;yui.html;768.4236822383212;817.162408531255;830.783996160998;861.6036623153349;878.7275944457217;13383.665408364795;13685.178889266652;13714.451421943111;13726.725465490685;13774.862251377483;12746.68133296668;12828.230306181636;12843.486260549567;13417.59747207583;14001.229932353743;810.529892662256;816.408104124508;819.4304958054155;819.8196396792725;822.9218224268685;824.1017291152642;824.3611201318965;827.9130691277419;829.4442723375353;830.1739768929893;868.7393781865446;870.7474832298626;876.6493402638931;876.8553188723853;876.9827000679213;875.6147295190096;876.0582373947967;876.1238761238761;876.2201640539924;878.7100256915235;634.9746010159588;635.1869606903172;637.6333608175318;638.8562573420943;639.6481934935813;13732;13780.793288100687;13859.861401385959;13860.306984650728;13862.4455021799;11483.712907177387;11628.06975441971;11826.586069487612;12014;12266.509339626404;10144.289899707024;10170.491475426274;10398.428086455242;10635.46822658864;10636.62771802991;3558.074900525856;3576.2847430513743;3700.85196592136;3704.907377315562;3723.94414083789;45397.77301113506;45446.54553454456;45529.35765138781;45538.54461455409;45569;9318.767030824149;9405.57674904631;9445.952770236105;9556.426614403159;9676.806463870684;17079.743803842954;17441.040742759018;17457.039862807414;17461.65076698459;17479;7369.189389167187;7703.075630924325;7758.340541054074;7763.534187948628;7819.139894611588;4297.742135471819;4342.696011279243;4369.737815731003;4379.364992076131;4477.19410506112;3053.64883038449;3059;3077.8461076946064;3078.6459557150765;3098.3028818515654;541.1990254423397;541.656048409255;563.9830805075854;571.2202843119195;574.03562015813;515.3583788183661;518.7432221050605;529.3303970477349;532.4170033812968;578.4446930946339;7334.963325183447;7538.924610753822;7595.392368610498;7780.1052878919645;7827.412944029221;602.9457348838538;633.4520639646764;648.3322178156507;649.04590252329;665.1353240786957;3852;3914.549826769901;3926.096997690547;3971.5035620547433;4000.7799571023875;51350.22974655383;54133;54922;56620;57063.714681426325;45237.32144017842;45784.7710761444;46054.53945460502;46290.76854615705;47411.28883066757;42084.789576051924;44857.22646853119;45693.314600281024;46607;46658.76670616625;8261.917380826355;8516.914830851612;8639.222469977733;8784.736457906272;8803.691870784492;33858.49212261769;33875.4918676225;34468.65531344755;34623.13442163865;34747.82626086853;38357.6164238354;38971.6102838968;41999;42480.78759606182;42531.57468425276;10433.373997560171;10733.624323148651;10794.406307653155;10814.080803131821;10898.12814974816;11202.383868886964;11423.314601123959;11647.475863585989;11691.298522088702;12198.268103913793;10829;10980;11074.889251107386;11101.056410205223;11200.83198752003;10160.390376577428;10181.694549163536;10248.692539223835;10269.691909242734;10333.431661258403;10390.844137337795;10708;10750.838737418788;10958.835617465904;11023.61417350421;9554.952225238829;9646.228301735984;9736.988257696183;9777.364471309342;10072.043155900177;8389.95805020971;8706.434081784664;9171.495567743837;9210.355275130676;9468.810623787347 14:24:08 INFO - 2015-12-18 14:24:08,536 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:24:08 INFO - 2015-12-18 14:24:08,537 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:24:08 INFO - 2015-12-18 14:24:08,537 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,311 14:24:08 INFO - 2015-12-18 14:24:08,537 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:24:08 INFO - 2015-12-18 14:24:08,537 DEBUG : BROWSER_OUTPUT: __startTimestamp1450477448528__endTimestamp 14:24:08 INFO - 2015-12-18 14:24:08,537 DEBUG : BROWSER_OUTPUT: 14:24:08 INFO - 2015-12-18 14:24:08,537 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:24:08 INFO - 2015-12-18 14:24:08,537 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:24:08 INFO - 2015-12-18 14:24:08,537 DEBUG : BROWSER_OUTPUT: 14:24:08 INFO - 2015-12-18 14:24:08,537 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5347.53 Median:5581.69 stddev:589.69 (10.6%) stddev-sans-first:564.87 14:24:08 INFO - 2015-12-18 14:24:08,537 DEBUG : BROWSER_OUTPUT: Values: 3114.0 3143.3 3185.5 3209.2 3229.9 5223.6 5317.4 5369.9 5378.8 5433.9 5296.8 5329.2 5383.3 5407.5 5410.4 4832.6 4845.8 4992.9 5006.5 5075.7 4672.6 4867.2 4896.4 4901.4 4977.3 4869.9 4871.7 4896.1 4931.9 4933.1 4862.1 4910.5 4919.5 4932.6 4942.4 4733.3 4831.2 4842.9 4846.9 4887.2 4970.9 5077.8 5107.2 5122.8 5220.2 5686.0 5689.5 5701.0 5726.9 5738.0 5689.6 5752.4 5763.0 5777.6 5826.7 5384.6 5399.3 5402.4 5408.4 5435.6 5802.0 5827.7 5830.5 5851.6 5896.6 5597.1 5657.0 5673.0 5702.0 5752.2 5815.4 5821.1 5829.4 5834.8 5857.1 5809.0 5815.1 5820.9 5822.4 5824.0 5513.7 5608.7 5620.4 5622.6 5747.6 4345.1 4367.3 4389.6 4430.7 4482.9 4034.8 4036.0 4049.2 4074.1 4076.5 5253.0 5486.6 5501.3 5510.4 5511.7 5778.4 5786.8 5811.7 5840.0 5885.1 5477.2 5478.8 5480.0 5485.3 5510.6 4894.7 5046.2 5101.5 5123.6 5175.0 5789.1 5790.4 5827.2 5887.8 5917.1 5769.4 5771.4 5779.0 5782.2 5787.4 5806.8 5810.8 5813.2 5814.2 5841.4 5603.4 5633.3 5726.1 5732.2 5785.8 5808.6 5832.5 5838.5 5841.3 5842.9 5494.0 5505.5 5691.1 5705.9 5706.4 5552.4 5581.7 5640.9 5666.8 5718.3 5590.6 5595.0 5613.4 5642.1 5649.4 5471.3 5555.2 5696.9 5734.1 5755.5 5530.5 5600.8 5604.4 5607.2 5633.0 14:24:08 INFO - 2015-12-18 14:24:08,537 DEBUG : BROWSER_OUTPUT: 14:24:08 INFO - 2015-12-18 14:24:08,537 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47066.86 Median:38809.40 stddev:78004.13 (201.0%) stddev-sans-first:78144.85 14:24:08 INFO - 2015-12-18 14:24:08,538 DEBUG : BROWSER_OUTPUT: Values: 576.0 583.5 587.8 590.5 604.3 37059.8 38038.0 38158.4 38206.8 38217.0 41731.0 42355.2 42570.9 42578.4 42583.6 8653.1 8735.2 8747.1 8757.1 8811.9 8547.7 8681.0 8703.5 8718.1 8732.2 8648.7 8682.7 8745.9 8777.6 8781.2 8727.9 8767.8 8779.3 8815.2 8836.6 8567.6 8660.4 8721.6 8723.9 8741.8 38970.0 39591.0 39598.6 39630.2 39909.4 3182.5 3224.5 3311.4 3490.0 3594.0 29074.7 29397.9 29561.4 30000.0 30446.5 3846.2 3924.2 4032.6 4038.2 4039.8 249006.0 249210.0 251408.0 252152.0 252190.0 57677.7 57909.4 58084.7 58101.4 58368.4 60957.4 66145.3 66379.3 66802.3 66868.7 14857.6 14933.5 14963.7 15019.7 15054.3 11250.3 11297.8 11354.8 11366.8 11373.7 20200.3 20448.3 20508.2 20528.9 20530.3 8083.9 8090.4 8211.5 8312.3 8366.6 945.6 987.4 1030.4 1044.9 1075.9 28104.4 28789.9 28793.3 32163.7 33582.5 999.7 1110.6 1113.4 1117.8 1123.5 14691.6 14743.3 14812.6 15035.0 15123.8 358136.0 360558.0 362145.0 363070.0 363091.0 52408.7 52681.2 52841.7 52844.2 52989.0 1335.7 1343.1 1343.9 1349.4 1355.9 27472.0 28565.1 28747.7 28765.9 28766.6 44486.6 44889.8 45079.0 45105.0 45485.0 269358.0 269712.0 270447.0 270689.0 271318.0 31671.0 31706.4 32080.0 32222.5 32228.5 41357.0 41692.8 42259.8 42303.6 43331.8 35906.8 36343.5 36999.0 36999.3 42830.0 37967.0 39145.4 39788.4 40439.4 40929.8 38646.0 39149.4 40313.8 40935.0 41033.8 37037.6 38783.0 38835.8 39498.0 39793.6 26771.2 26991.7 27122.0 27345.9 27424.7 14:24:08 INFO - 2015-12-18 14:24:08,538 DEBUG : BROWSER_OUTPUT: 14:24:08 INFO - 2015-12-18 14:24:08,538 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28277.54 Median:17383.89 stddev:78774.46 (453.1%) stddev-sans-first:78967.52 14:24:08 INFO - 2015-12-18 14:24:08,539 DEBUG : BROWSER_OUTPUT: Values: 347.1 357.1 357.6 359.0 361.0 11245.4 11714.4 16309.2 16801.0 17443.5 15367.5 15512.9 15564.5 17390.4 17768.0 5933.7 6299.3 6467.0 6504.7 6525.2 6312.7 6422.7 6835.3 6840.3 6865.0 6187.8 6423.2 6425.5 6742.0 6776.4 5279.6 6408.2 6432.9 6492.8 6793.0 6418.6 6433.3 6459.4 6475.3 6485.3 20985.6 21553.6 22169.2 22187.9 22271.9 2229.9 2249.9 2310.2 2350.3 2368.8 14103.3 14330.6 14390.6 14593.6 14844.3 2005.1 2022.5 2076.1 2091.1 2091.8 67777.7 69322.7 70431.0 70473.6 71983.0 15138.8 15302.1 15451.0 15465.1 15508.8 23757.8 23894.2 23921.6 24017.4 24075.2 8946.9 8979.1 9029.9 9040.0 9084.4 7739.5 7805.7 7833.9 7835.9 7853.3 7460.6 7625.4 7657.4 7664.5 7802.1 1799.4 1859.9 3018.7 3021.6 3111.9 841.2 876.4 897.7 942.4 962.6 15561.7 16296.6 16631.2 17366.7 17518.0 905.9 908.7 933.2 965.8 1015.0 9682.6 9713.8 10022.9 10135.7 10152.5 476937.0 480415.0 484046.0 484214.0 484301.0 76306.8 76599.6 77244.0 80340.0 80726.6 1110.7 1124.3 1133.7 1136.9 1151.5 15275.5 15284.7 15348.3 15562.9 15756.1 33651.3 34420.7 35034.9 35255.0 35622.3 44624.1 44928.3 45342.3 46194.0 49056.0 9195.6 9699.2 9784.1 9803.2 9806.8 11466.7 15310.7 16268.3 16460.2 17050.7 14104.4 14146.2 14359.9 14469.0 14542.1 13904.7 13930.9 14000.2 14718.4 15011.7 14508.6 15154.5 15163.5 15329.5 15511.6 8600.8 9630.6 9687.0 9931.3 9937.7 10068.2 12787.5 13383.3 13965.0 14737.8 14:24:08 INFO - 2015-12-18 14:24:08,539 DEBUG : BROWSER_OUTPUT: 14:24:08 INFO - 2015-12-18 14:24:08,539 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5125.95 Median:6244.20 stddev:2609.84 (41.8%) stddev-sans-first:2602.96 14:24:08 INFO - 2015-12-18 14:24:08,539 DEBUG : BROWSER_OUTPUT: Values: 1503.8 1679.5 1717.7 1724.7 1736.7 7038.6 7194.0 7200.5 7212.4 7501.6 7396.0 7428.9 7451.3 7483.9 7500.3 2153.9 2190.5 2192.1 2194.1 2195.2 2197.5 2216.4 2287.3 2287.4 2287.8 2192.2 2197.5 2219.4 2236.4 2245.4 2183.5 2201.8 2235.8 2236.0 2236.7 2205.3 2230.6 2232.8 2233.6 2236.0 7305.5 7378.7 7393.8 7394.9 7406.2 4479.9 4564.5 4576.4 4594.5 4600.1 3047.4 3132.9 3215.4 3233.1 3234.4 1015.6 1054.5 1070.1 1085.4 1116.3 9776.8 9798.1 9834.5 9838.1 9852.2 3834.1 3843.2 3845.0 3898.6 4007.7 8043.8 8056.4 8089.0 8150.2 8154.6 4446.5 4459.7 4464.7 4480.4 4507.4 4130.9 4137.5 4138.5 4143.0 4180.3 3198.3 3213.5 3244.6 3264.9 3270.4 1000.2 1015.9 1026.4 1029.2 1031.2 953.3 1002.1 1096.9 1161.7 1323.0 6574.0 6654.3 6706.6 6724.2 6729.8 607.3 613.8 626.2 627.3 760.9 5209.8 5295.1 5369.3 5395.0 5410.1 8476.7 8657.7 8743.1 8788.2 8798.3 8567.9 8625.7 8648.1 8673.4 8728.8 6818.1 6952.9 6969.3 6980.0 6990.2 6758.7 6759.7 6773.3 6778.0 6808.9 7603.1 7826.0 7908.6 7918.5 7962.0 7950.2 8069.2 8098.5 8105.9 8153.8 6005.7 6054.5 6123.0 6165.2 6171.5 7114.8 7143.4 7158.3 7167.3 7167.4 5836.9 6542.0 6575.8 6649.4 6680.0 6324.0 6516.1 6519.2 6539.1 6597.4 6587.9 6634.6 6661.6 6844.3 6850.0 6186.1 6214.5 6237.4 6241.7 6246.7 6290.6 6296.5 6299.6 6344.6 6350.6 14:24:08 INFO - 2015-12-18 14:24:08,539 DEBUG : BROWSER_OUTPUT: 14:24:08 INFO - 2015-12-18 14:24:08,539 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5566.69 Median:6330.32 stddev:1706.81 (27.0%) stddev-sans-first:1665.78 14:24:08 INFO - 2015-12-18 14:24:08,540 DEBUG : BROWSER_OUTPUT: Values: 333.0 344.3 345.6 349.8 354.3 6250.2 6285.2 6329.1 6332.0 6405.6 6200.9 6225.2 6264.1 6273.2 6280.7 4726.0 4726.6 4733.8 4735.4 4738.1 4737.2 4743.2 4743.4 4743.5 4744.5 4614.1 4620.8 4679.7 4695.9 4697.0 4697.6 4697.8 4726.9 4737.1 4742.6 4098.6 4100.0 4102.3 4107.8 4108.4 5920.3 5927.3 5928.6 5945.9 5954.3 5431.3 5531.6 5534.8 5544.7 5556.7 6640.8 6640.9 6650.2 6650.8 6666.2 4561.5 4565.7 4567.8 4571.1 4584.1 6700.2 6836.8 6848.6 6864.0 6887.2 4599.8 4613.3 4617.8 4619.7 4621.5 4650.0 4669.3 4672.8 4672.9 4688.2 5432.3 5451.9 5455.6 5458.2 5464.8 6506.7 6629.5 6637.6 6651.9 6707.3 1635.5 1643.2 1646.4 1648.5 1650.4 1058.4 1094.2 1105.9 1118.6 1125.8 6331.5 6336.9 6341.4 6356.7 6363.4 6928.2 6944.6 6953.3 6954.0 6954.1 6256.2 6291.4 6324.1 6358.7 6409.6 3733.3 3784.1 3786.8 3794.2 3814.6 7070.2 7099.2 7113.1 7117.0 7127.6 6969.8 7054.1 7142.6 7179.2 7186.0 7069.5 7104.2 7106.9 7111.7 7113.4 6983.7 6988.7 6991.4 6996.6 7011.4 6750.7 6893.6 6895.0 6909.4 6929.1 7007.1 7021.9 7036.5 7098.0 7108.3 4625.8 4692.5 4696.4 4699.9 4700.2 6902.5 6955.0 6982.1 7020.4 7022.8 6807.6 6808.3 6811.2 6812.5 6814.3 6753.9 6756.3 6767.2 6789.5 6801.0 6470.4 6594.6 6604.9 6642.8 6651.7 6806.4 6807.0 6820.3 6825.2 6825.6 6494.9 6636.0 6656.2 6657.4 6657.4 14:24:08 INFO - 2015-12-18 14:24:08,541 DEBUG : BROWSER_OUTPUT: 14:24:08 INFO - 2015-12-18 14:24:08,541 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13201.87 Median:45487.95 stddev:14991.14 (33.0%) stddev-sans-first:15004.12 14:24:08 INFO - 2015-12-18 14:24:08,541 DEBUG : BROWSER_OUTPUT: Values: 768.4 817.2 830.8 861.6 878.7 13383.7 13685.2 13714.5 13726.7 13774.9 12746.7 12828.2 12843.5 13417.6 14001.2 810.5 816.4 819.4 819.8 822.9 824.1 824.4 827.9 829.4 830.2 868.7 870.7 876.6 876.9 877.0 875.6 876.1 876.1 876.2 878.7 635.0 635.2 637.6 638.9 639.6 13732.0 13780.8 13859.9 13860.3 13862.4 11483.7 11628.1 11826.6 12014.0 12266.5 10144.3 10170.5 10398.4 10635.5 10636.6 3558.1 3576.3 3700.9 3704.9 3723.9 45397.8 45446.5 45529.4 45538.5 45569.0 9318.8 9405.6 9446.0 9556.4 9676.8 17079.7 17441.0 17457.0 17461.7 17479.0 7369.2 7703.1 7758.3 7763.5 7819.1 4297.7 4342.7 4369.7 4379.4 4477.2 3053.6 3059.0 3077.8 3078.6 3098.3 541.2 541.7 564.0 571.2 574.0 515.4 518.7 529.3 532.4 578.4 7335.0 7538.9 7595.4 7780.1 7827.4 602.9 633.5 648.3 649.0 665.1 3852.0 3914.5 3926.1 3971.5 4000.8 51350.2 54133.0 54922.0 56620.0 57063.7 45237.3 45784.8 46054.5 46290.8 47411.3 42084.8 44857.2 45693.3 46607.0 46658.8 8261.9 8516.9 8639.2 8784.7 8803.7 33858.5 33875.5 34468.7 34623.1 34747.8 38357.6 38971.6 41999.0 42480.8 42531.6 10433.4 10733.6 10794.4 10814.1 10898.1 11202.4 11423.3 11647.5 11691.3 12198.3 10829.0 10980.0 11074.9 11101.1 11200.8 10160.4 10181.7 10248.7 10269.7 10333.4 10390.8 10708.0 10750.8 10958.8 11023.6 9555.0 9646.2 9737.0 9777.4 10072.0 8390.0 8706.4 9171.5 9210.4 9468.8 14:24:08 INFO - 2015-12-18 14:24:08,541 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:24:08 INFO - 2015-12-18 14:24:08,541 DEBUG : BROWSER_OUTPUT: 14:24:09 INFO - 2015-12-18 14:24:09,263 INFO : Browser exited with error code: 0 14:24:09 INFO - 2015-12-18 14:24:09,282 INFO : Completed test dromaeo_css (00:18:30) 14:24:09 INFO - 2015-12-18 14:24:09,282 INFO : Starting test kraken 14:24:09 INFO - 2015-12-18 14:24:09,282 DEBUG : operating with platform_type : linux_ 14:24:09 INFO - 2015-12-18 14:24:09,282 INFO : Initialising browser for kraken test... 14:24:09 INFO - 2015-12-18 14:24:09,288 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9nNNS3/profile http://localhost:53338/getInfo.html 14:24:13 INFO - 2015-12-18 14:24:13,457 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:24:13 INFO - 2015-12-18 14:24:13,457 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:24:13 INFO - 2015-12-18 14:24:13,457 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:24:13 INFO - 2015-12-18 14:24:13,457 DEBUG : BROWSER_OUTPUT: __metrics 14:24:13 INFO - 2015-12-18 14:24:13,553 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:24:14 INFO - 2015-12-18 14:24:14,383 INFO : Browser initialized. 14:24:14 INFO - 2015-12-18 14:24:14,384 INFO : Running cycle 1/1 for kraken test... 14:24:14 INFO - 2015-12-18 14:24:14,384 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9nNNS3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:24:26 INFO - 2015-12-18 14:24:26,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 150630400 14:24:26 INFO - 2015-12-18 14:24:26,192 DEBUG : BROWSER_OUTPUT: 14:24:28 INFO - 2015-12-18 14:24:28,693 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53338/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53338/tests/kraken/driver.html?testName=audio-beat-detection) 14:24:29 INFO - 2015-12-18 14:24:29,303 DEBUG : BROWSER_OUTPUT: RSS: Main: 152059904 14:24:29 INFO - 2015-12-18 14:24:29,303 DEBUG : BROWSER_OUTPUT: 14:24:31 INFO - 2015-12-18 14:24:31,944 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53338/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53338/tests/kraken/driver.html?testName=audio-dft) 14:24:32 INFO - 2015-12-18 14:24:32,546 DEBUG : BROWSER_OUTPUT: RSS: Main: 152186880 14:24:32 INFO - 2015-12-18 14:24:32,547 DEBUG : BROWSER_OUTPUT: 14:24:35 INFO - 2015-12-18 14:24:35,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53338/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53338/tests/kraken/driver.html?testName=audio-fft) 14:24:35 INFO - 2015-12-18 14:24:35,972 DEBUG : BROWSER_OUTPUT: RSS: Main: 146374656 14:24:35 INFO - 2015-12-18 14:24:35,972 DEBUG : BROWSER_OUTPUT: 14:24:38 INFO - 2015-12-18 14:24:38,158 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53338/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53338/tests/kraken/driver.html?testName=audio-oscillator) 14:24:38 INFO - 2015-12-18 14:24:38,760 DEBUG : BROWSER_OUTPUT: RSS: Main: 146219008 14:24:38 INFO - 2015-12-18 14:24:38,760 DEBUG : BROWSER_OUTPUT: 14:24:40 INFO - 2015-12-18 14:24:40,974 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53338/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53338/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:24:41 INFO - 2015-12-18 14:24:41,556 DEBUG : BROWSER_OUTPUT: RSS: Main: 147271680 14:24:41 INFO - 2015-12-18 14:24:41,556 DEBUG : BROWSER_OUTPUT: 14:24:44 INFO - 2015-12-18 14:24:44,541 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53338/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53338/tests/kraken/driver.html?testName=imaging-darkroom) 14:24:45 INFO - 2015-12-18 14:24:45,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 148135936 14:24:45 INFO - 2015-12-18 14:24:45,135 DEBUG : BROWSER_OUTPUT: 14:24:48 INFO - 2015-12-18 14:24:48,504 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53338/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53338/tests/kraken/driver.html?testName=imaging-desaturate) 14:24:49 INFO - 2015-12-18 14:24:49,106 DEBUG : BROWSER_OUTPUT: RSS: Main: 148979712 14:24:49 INFO - 2015-12-18 14:24:49,106 DEBUG : BROWSER_OUTPUT: 14:24:51 INFO - 2015-12-18 14:24:51,930 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53338/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53338/tests/kraken/driver.html?testName=json-parse-financial) 14:24:52 INFO - 2015-12-18 14:24:52,519 DEBUG : BROWSER_OUTPUT: RSS: Main: 149282816 14:24:52 INFO - 2015-12-18 14:24:52,519 DEBUG : BROWSER_OUTPUT: 14:24:54 INFO - 2015-12-18 14:24:54,107 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53338/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53338/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:24:54 INFO - 2015-12-18 14:24:54,689 DEBUG : BROWSER_OUTPUT: RSS: Main: 149573632 14:24:54 INFO - 2015-12-18 14:24:54,689 DEBUG : BROWSER_OUTPUT: 14:24:56 INFO - 2015-12-18 14:24:56,485 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53338/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53338/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:24:57 INFO - 2015-12-18 14:24:57,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 148127744 14:24:57 INFO - 2015-12-18 14:24:57,099 DEBUG : BROWSER_OUTPUT: 14:24:59 INFO - 2015-12-18 14:24:59,171 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53338/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53338/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:24:59 INFO - 2015-12-18 14:24:59,761 DEBUG : BROWSER_OUTPUT: RSS: Main: 148340736 14:24:59 INFO - 2015-12-18 14:24:59,761 DEBUG : BROWSER_OUTPUT: 14:25:02 INFO - 2015-12-18 14:25:02,224 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53338/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53338/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:25:02 INFO - 2015-12-18 14:25:02,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 148549632 14:25:02 INFO - 2015-12-18 14:25:02,820 DEBUG : BROWSER_OUTPUT: 14:25:05 INFO - 2015-12-18 14:25:05,420 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53338/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53338/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:25:06 INFO - 2015-12-18 14:25:06,010 DEBUG : BROWSER_OUTPUT: RSS: Main: 148418560 14:25:06 INFO - 2015-12-18 14:25:06,010 DEBUG : BROWSER_OUTPUT: 14:25:07 INFO - 2015-12-18 14:25:07,712 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53338/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53338/tests/kraken/driver.html?testName=ai-astar) 14:25:07 INFO - 2015-12-18 14:25:07,962 DEBUG : BROWSER_OUTPUT: RSS: Main: 149131264 14:25:07 INFO - 2015-12-18 14:25:07,962 DEBUG : BROWSER_OUTPUT: 14:25:07 INFO - 2015-12-18 14:25:07,966 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:25:07 INFO - 2015-12-18 14:25:07,966 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:25:07 INFO - 2015-12-18 14:25:07,966 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:25:07 INFO - 2015-12-18 14:25:07,966 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:25:07 INFO - 2015-12-18 14:25:07,966 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;105;112;111;111;122;113;113;112;114 14:25:07 INFO - 2015-12-18 14:25:07,966 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;125;149;162;126;146;150;132;161;124 14:25:07 INFO - 2015-12-18 14:25:07,967 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;163;162;162;160;161;162;163;169;161 14:25:07 INFO - 2015-12-18 14:25:07,967 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;79;74;72;72;73;132;71;73 14:25:07 INFO - 2015-12-18 14:25:07,967 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;103;135;94;94;94;138;95;93;133 14:25:07 INFO - 2015-12-18 14:25:07,967 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;109;110;110;110;110;111 14:25:07 INFO - 2015-12-18 14:25:07,967 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;145;146;148;151;146;146;147;146 14:25:07 INFO - 2015-12-18 14:25:07,967 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;95;97;99;96;96;96;96;96 14:25:07 INFO - 2015-12-18 14:25:07,967 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;63;63;62;61;62;65;61;60;60 14:25:07 INFO - 2015-12-18 14:25:07,967 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;67;66;67;67;67;67;67;67;68 14:25:07 INFO - 2015-12-18 14:25:07,967 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;86;87;86;93;86;86;85;94;87 14:25:07 INFO - 2015-12-18 14:25:07,967 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;122;123;120;126;119;126;123;127;123 14:25:07 INFO - 2015-12-18 14:25:07,967 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;154;148;154;154;143;150;154;148;156 14:25:07 INFO - 2015-12-18 14:25:07,967 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;68;70;68;77;73;67;72;69 14:25:07 INFO - 2015-12-18 14:25:07,968 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:25:07 INFO - 2015-12-18 14:25:07,968 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:25:07 INFO - 2015-12-18 14:25:07,968 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,730 14:25:07 INFO - 2015-12-18 14:25:07,968 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:25:07 INFO - 2015-12-18 14:25:07,968 DEBUG : BROWSER_OUTPUT: __startTimestamp1450477507963__endTimestamp 14:25:07 INFO - 2015-12-18 14:25:07,968 DEBUG : BROWSER_OUTPUT: 14:25:07 INFO - 2015-12-18 14:25:07,969 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:25:07 INFO - 2015-12-18 14:25:07,969 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:25:07 INFO - 2015-12-18 14:25:07,969 DEBUG : BROWSER_OUTPUT: 14:25:07 INFO - 2015-12-18 14:25:07,969 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.50 Median:112.50 stddev:4.14 (3.7%) stddev-sans-first:4.39 14:25:07 INFO - 2015-12-18 14:25:07,970 DEBUG : BROWSER_OUTPUT: Values: 112.0 105.0 112.0 111.0 111.0 122.0 113.0 113.0 112.0 114.0 14:25:07 INFO - 2015-12-18 14:25:07,970 DEBUG : BROWSER_OUTPUT: 14:25:07 INFO - 2015-12-18 14:25:07,971 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.30 Median:148.50 stddev:14.51 (9.8%) stddev-sans-first:15.24 14:25:07 INFO - 2015-12-18 14:25:07,971 DEBUG : BROWSER_OUTPUT: Values: 148.0 125.0 149.0 162.0 126.0 146.0 150.0 132.0 161.0 124.0 14:25:07 INFO - 2015-12-18 14:25:07,971 DEBUG : BROWSER_OUTPUT: 14:25:07 INFO - 2015-12-18 14:25:07,971 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:2.58 (1.6%) stddev-sans-first:2.60 14:25:07 INFO - 2015-12-18 14:25:07,971 DEBUG : BROWSER_OUTPUT: Values: 160.0 163.0 162.0 162.0 160.0 161.0 162.0 163.0 169.0 161.0 14:25:07 INFO - 2015-12-18 14:25:07,971 DEBUG : BROWSER_OUTPUT: 14:25:07 INFO - 2015-12-18 14:25:07,971 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.10 Median:73.00 stddev:18.72 (25.6%) stddev-sans-first:19.68 14:25:07 INFO - 2015-12-18 14:25:07,972 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 79.0 74.0 72.0 72.0 73.0 132.0 71.0 73.0 14:25:07 INFO - 2015-12-18 14:25:07,972 DEBUG : BROWSER_OUTPUT: 14:25:07 INFO - 2015-12-18 14:25:07,972 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.20 Median:93.50 stddev:19.66 (21.0%) stddev-sans-first:20.17 14:25:07 INFO - 2015-12-18 14:25:07,972 DEBUG : BROWSER_OUTPUT: Values: 93.0 103.0 135.0 94.0 94.0 94.0 138.0 95.0 93.0 133.0 14:25:07 INFO - 2015-12-18 14:25:07,972 DEBUG : BROWSER_OUTPUT: 14:25:07 INFO - 2015-12-18 14:25:07,972 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 14:25:07 INFO - 2015-12-18 14:25:07,972 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 109.0 110.0 110.0 110.0 110.0 111.0 14:25:07 INFO - 2015-12-18 14:25:07,972 DEBUG : BROWSER_OUTPUT: 14:25:07 INFO - 2015-12-18 14:25:07,973 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.70 (1.2%) stddev-sans-first:1.80 14:25:07 INFO - 2015-12-18 14:25:07,973 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 145.0 146.0 148.0 151.0 146.0 146.0 147.0 146.0 14:25:07 INFO - 2015-12-18 14:25:07,973 DEBUG : BROWSER_OUTPUT: 14:25:07 INFO - 2015-12-18 14:25:07,973 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:1.07 (1.1%) stddev-sans-first:1.12 14:25:07 INFO - 2015-12-18 14:25:07,973 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 95.0 97.0 99.0 96.0 96.0 96.0 96.0 96.0 14:25:07 INFO - 2015-12-18 14:25:07,973 DEBUG : BROWSER_OUTPUT: 14:25:07 INFO - 2015-12-18 14:25:07,973 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.00 Median:62.50 stddev:1.56 (2.5%) stddev-sans-first:1.62 14:25:07 INFO - 2015-12-18 14:25:07,973 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 63.0 62.0 61.0 62.0 65.0 61.0 60.0 60.0 14:25:07 INFO - 2015-12-18 14:25:07,974 DEBUG : BROWSER_OUTPUT: 14:25:07 INFO - 2015-12-18 14:25:07,974 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 14:25:07 INFO - 2015-12-18 14:25:07,974 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 66.0 67.0 67.0 67.0 67.0 67.0 67.0 68.0 14:25:07 INFO - 2015-12-18 14:25:07,974 DEBUG : BROWSER_OUTPUT: 14:25:07 INFO - 2015-12-18 14:25:07,974 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:86.50 stddev:3.34 (3.9%) stddev-sans-first:3.31 14:25:07 INFO - 2015-12-18 14:25:07,974 DEBUG : BROWSER_OUTPUT: Values: 84.0 86.0 87.0 86.0 93.0 86.0 86.0 85.0 94.0 87.0 14:25:07 INFO - 2015-12-18 14:25:07,974 DEBUG : BROWSER_OUTPUT: 14:25:07 INFO - 2015-12-18 14:25:07,974 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.00 Median:123.00 stddev:2.67 (2.2%) stddev-sans-first:2.73 14:25:07 INFO - 2015-12-18 14:25:07,974 DEBUG : BROWSER_OUTPUT: Values: 121.0 122.0 123.0 120.0 126.0 119.0 126.0 123.0 127.0 123.0 14:25:07 INFO - 2015-12-18 14:25:07,974 DEBUG : BROWSER_OUTPUT: 14:25:07 INFO - 2015-12-18 14:25:07,974 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.20 Median:154.00 stddev:5.14 (3.3%) stddev-sans-first:4.24 14:25:07 INFO - 2015-12-18 14:25:07,975 DEBUG : BROWSER_OUTPUT: Values: 141.0 154.0 148.0 154.0 154.0 143.0 150.0 154.0 148.0 156.0 14:25:07 INFO - 2015-12-18 14:25:07,975 DEBUG : BROWSER_OUTPUT: 14:25:07 INFO - 2015-12-18 14:25:07,975 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:69.50 stddev:3.01 (4.3%) stddev-sans-first:3.16 14:25:07 INFO - 2015-12-18 14:25:07,975 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 70.0 68.0 77.0 73.0 67.0 72.0 69.0 14:25:07 INFO - 2015-12-18 14:25:07,975 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:25:07 INFO - 2015-12-18 14:25:07,975 DEBUG : BROWSER_OUTPUT: 14:25:08 INFO - 2015-12-18 14:25:08,831 INFO : Browser exited with error code: 0 14:25:08 INFO - 2015-12-18 14:25:08,882 INFO : Completed test kraken (00:00:59) 14:25:08 INFO - 2015-12-18 14:25:08,882 INFO : Starting test v8_7 14:25:08 INFO - 2015-12-18 14:25:08,882 DEBUG : operating with platform_type : linux_ 14:25:08 INFO - 2015-12-18 14:25:08,883 INFO : Initialising browser for v8_7 test... 14:25:08 INFO - 2015-12-18 14:25:08,889 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxB3qWO/profile http://localhost:53338/getInfo.html 14:25:13 INFO - 2015-12-18 14:25:13,105 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:25:13 INFO - 2015-12-18 14:25:13,106 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:25:13 INFO - 2015-12-18 14:25:13,106 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:25:13 INFO - 2015-12-18 14:25:13,106 DEBUG : BROWSER_OUTPUT: __metrics 14:25:13 INFO - 2015-12-18 14:25:13,222 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:25:14 INFO - 2015-12-18 14:25:14,075 INFO : Browser initialized. 14:25:14 INFO - 2015-12-18 14:25:14,076 INFO : Running cycle 1/1 for v8_7 test... 14:25:14 INFO - 2015-12-18 14:25:14,076 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxB3qWO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:25:25 INFO - 2015-12-18 14:25:25,882 DEBUG : BROWSER_OUTPUT: RSS: Main: 150966272 14:25:25 INFO - 2015-12-18 14:25:25,882 DEBUG : BROWSER_OUTPUT: 14:25:47 INFO - 2015-12-18 14:25:47,330 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53338/tests/v8_7/run.html (next: http://localhost:53338/tests/v8_7/run.html) 14:25:47 INFO - 2015-12-18 14:25:47,580 DEBUG : BROWSER_OUTPUT: RSS: Main: 145764352 14:25:47 INFO - 2015-12-18 14:25:47,580 DEBUG : BROWSER_OUTPUT: 14:25:47 INFO - 2015-12-18 14:25:47,581 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:25:47 INFO - 2015-12-18 14:25:47,581 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:25:47 INFO - 2015-12-18 14:25:47,582 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:25:47 INFO - 2015-12-18 14:25:47,582 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:25:47 INFO - 2015-12-18 14:25:47,582 DEBUG : BROWSER_OUTPUT: |0;Richards;167.33601070950468 14:25:47 INFO - 2015-12-18 14:25:47,582 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.11576400521125 14:25:47 INFO - 2015-12-18 14:25:47,582 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.0336040324839 14:25:47 INFO - 2015-12-18 14:25:47,582 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5229.166666666667 14:25:47 INFO - 2015-12-18 14:25:47,582 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1096.3855421686746 14:25:47 INFO - 2015-12-18 14:25:47,582 DEBUG : BROWSER_OUTPUT: |5;Earley;695.8942240779402 14:25:47 INFO - 2015-12-18 14:25:47,583 DEBUG : BROWSER_OUTPUT: |6;Boyer;12243.90243902439 14:25:47 INFO - 2015-12-18 14:25:47,583 DEBUG : BROWSER_OUTPUT: |7;RegExp;25300 14:25:47 INFO - 2015-12-18 14:25:47,583 DEBUG : BROWSER_OUTPUT: |8;Splay;695.6219596942321 14:25:47 INFO - 2015-12-18 14:25:47,583 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 14:25:47 INFO - 2015-12-18 14:25:47,583 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:25:47 INFO - 2015-12-18 14:25:47,583 DEBUG : BROWSER_OUTPUT: __startTimestamp1450477547581__endTimestamp 14:25:47 INFO - 2015-12-18 14:25:47,583 DEBUG : BROWSER_OUTPUT: 14:25:47 INFO - 2015-12-18 14:25:47,584 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:25:47 INFO - 2015-12-18 14:25:47,584 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:25:47 INFO - 2015-12-18 14:25:47,584 DEBUG : BROWSER_OUTPUT: 14:25:47 INFO - 2015-12-18 14:25:47,584 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.34 Median:167.34 stddev:0.00 (0.0%) 14:25:47 INFO - 2015-12-18 14:25:47,584 DEBUG : BROWSER_OUTPUT: Values: 167.3 14:25:47 INFO - 2015-12-18 14:25:47,584 DEBUG : BROWSER_OUTPUT: 14:25:47 INFO - 2015-12-18 14:25:47,585 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.12 Median:186.12 stddev:0.00 (0.0%) 14:25:47 INFO - 2015-12-18 14:25:47,585 DEBUG : BROWSER_OUTPUT: Values: 186.1 14:25:47 INFO - 2015-12-18 14:25:47,585 DEBUG : BROWSER_OUTPUT: 14:25:47 INFO - 2015-12-18 14:25:47,585 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 14:25:47 INFO - 2015-12-18 14:25:47,585 DEBUG : BROWSER_OUTPUT: Values: 280.0 14:25:47 INFO - 2015-12-18 14:25:47,586 DEBUG : BROWSER_OUTPUT: 14:25:47 INFO - 2015-12-18 14:25:47,586 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 14:25:47 INFO - 2015-12-18 14:25:47,586 DEBUG : BROWSER_OUTPUT: Values: 5229.2 14:25:47 INFO - 2015-12-18 14:25:47,586 DEBUG : BROWSER_OUTPUT: 14:25:47 INFO - 2015-12-18 14:25:47,586 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1096.39 Median:1096.39 stddev:0.00 (0.0%) 14:25:47 INFO - 2015-12-18 14:25:47,586 DEBUG : BROWSER_OUTPUT: Values: 1096.4 14:25:47 INFO - 2015-12-18 14:25:47,586 DEBUG : BROWSER_OUTPUT: 14:25:47 INFO - 2015-12-18 14:25:47,586 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:695.89 Median:695.89 stddev:0.00 (0.0%) 14:25:47 INFO - 2015-12-18 14:25:47,586 DEBUG : BROWSER_OUTPUT: Values: 695.9 14:25:47 INFO - 2015-12-18 14:25:47,586 DEBUG : BROWSER_OUTPUT: 14:25:47 INFO - 2015-12-18 14:25:47,587 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 14:25:47 INFO - 2015-12-18 14:25:47,587 DEBUG : BROWSER_OUTPUT: Values: 12243.9 14:25:47 INFO - 2015-12-18 14:25:47,587 DEBUG : BROWSER_OUTPUT: 14:25:47 INFO - 2015-12-18 14:25:47,587 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25300.00 Median:25300.00 stddev:0.00 (0.0%) 14:25:47 INFO - 2015-12-18 14:25:47,587 DEBUG : BROWSER_OUTPUT: Values: 25300.0 14:25:47 INFO - 2015-12-18 14:25:47,587 DEBUG : BROWSER_OUTPUT: 14:25:47 INFO - 2015-12-18 14:25:47,587 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:695.62 Median:695.62 stddev:0.00 (0.0%) 14:25:47 INFO - 2015-12-18 14:25:47,588 DEBUG : BROWSER_OUTPUT: Values: 695.6 14:25:47 INFO - 2015-12-18 14:25:47,588 DEBUG : BROWSER_OUTPUT: 14:25:47 INFO - 2015-12-18 14:25:47,588 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 14:25:47 INFO - 2015-12-18 14:25:47,588 DEBUG : BROWSER_OUTPUT: Values: 4830.9 14:25:47 INFO - 2015-12-18 14:25:47,588 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:25:47 INFO - 2015-12-18 14:25:47,588 DEBUG : BROWSER_OUTPUT: 14:25:48 INFO - 2015-12-18 14:25:48,411 INFO : Browser exited with error code: 0 14:25:48 INFO - 2015-12-18 14:25:48,430 INFO : Completed test v8_7 (00:00:39) 14:25:48 INFO - 2015-12-18 14:25:48,603 INFO : Completed test suite (00:20:09) 14:25:48 INFO - 2015-12-18 14:25:48,604 DEBUG : Working with test: dromaeo_css 14:25:48 INFO - 2015-12-18 14:25:48,604 DEBUG : Generating results file: dromaeo_css 14:25:48 INFO - 2015-12-18 14:25:48,605 DEBUG : Working with test: kraken 14:25:48 INFO - 2015-12-18 14:25:48,605 DEBUG : Generating results file: kraken 14:25:48 INFO - 2015-12-18 14:25:48,605 INFO : javascript benchmark 14:25:48 INFO - 2015-12-18 14:25:48,605 DEBUG : Working with test: v8_7 14:25:48 INFO - 2015-12-18 14:25:48,605 DEBUG : Generating results file: v8_7 14:25:48 INFO - 2015-12-18 14:25:48,606 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:25:48 INFO - 2015-12-18 14:25:48,656 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 14:25:48 INFO - 2015-12-18 14:25:48,657 DEBUG : process_Request line: dromaeo_css 7085.51 graph.html#tests=[[72,64,43]] 14:25:48 INFO - 2015-12-18 14:25:48,657 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:25:48 INFO - 2015-12-18 14:25:48,696 DEBUG : process_Request line: kraken 1516.40 graph.html#tests=[[232,64,43]] 14:25:48 INFO - 2015-12-18 14:25:48,696 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:25:48 INFO - 2015-12-18 14:25:48,723 DEBUG : process_Request line: v8_7 21066.66 graph.html#tests=[[230,64,43]] 14:25:48 INFO - 2015-12-18 14:25:48,724 INFO : javascript benchmark 14:25:48 INFO - 2015-12-18 14:25:48,728 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3113.95329070064, 3143.2927591291964, 3185.4903215485497, 3209.181658677037, 3229.935401291975, 5223.555997740196, 5317.415084340724, 5369.9463005369935, 5378.838634840951, 5433.864153396167, 5296.788128474856, 5329.173978033401, 5383.300170977767, 5407.459254074591, 5410.404855465896, 4832.589229915461, 4845.830395936143, 4992.925106123411, 5006.54941055305, 5075.720835354054, 4672.64955128365, 4867.221244600864, 4896.43690975537, 4901.436334821487, 4977.253411988195, 4869.853904382874, 4871.658983871131, 4896.143174944388, 4931.901361972758, 4933.087378834891, 4862.100511405401, 4910.533499317595, 4919.4834542373255, 4932.630052746058, 4942.431620363633, 4733.313669517935, 4831.202851529493, 4842.903141937141, 4846.927296090562, 4887.242477416006, 4970.900581988376, 5077.796888124471, 5107.233914912756, 5122.820701275475, 5220.216967454874, 5686.004949133885, 5689.516391106761, 5701.0308247598, 5726.856828579277, 5738.0, 5689.573282003867, 5752.36723960364, 5763.0, 5777.59556831022, 5826.737796799154, 5384.6499977501335, 5399.325084364455, 5402.405735369146, 5408.4050754416985, 5435.619506634537, 5802.0, 5827.65034097947, 5830.47525722687, 5851.61964472308, 5896.557758168155, 5597.104463285855, 5656.971715141398, 5673.035583950738, 5701.971490142523, 5752.223449834302, 5815.389384114692, 5821.126830975388, 5829.446202610745, 5834.774697313612, 5857.062869940789, 5809.0, 5815.127730840323, 5820.94179058204, 5822.446867547576, 5823.970880145657, 5513.696746678891, 5608.663480191201, 5620.381758006616, 5622.606417550732, 5747.568932330092, 4345.087531618396, 4367.344898265285, 4389.582989615981, 4430.734155950653, 4482.887927801831, 4034.757914525138, 4036.0313524754433, 4049.1699201663587, 4074.083331250445, 4076.510818701775, 5252.9737351313, 5486.588505861996, 5501.257330260443, 5510.393856675762, 5511.696856672921, 5778.393268706725, 5786.797462088806, 5811.738471768696, 5840.0, 5885.146653735184, 5477.20580515823, 5478.835634930879, 5479.972600136974, 5485.314335708036, 5510.641808282448, 4894.706317620954, 5046.1926091825135, 5101.51535604117, 5123.6157288202785, 5174.97412512935, 5789.102689083199, 5790.392008839095, 5827.184194212899, 5887.8233652990475, 5917.142014407887, 5769.3942136076785, 5771.422857714195, 5779.0, 5782.1615865698395, 5787.421257874179, 5806.82579522615, 5810.76756929735, 5813.215215945793, 5814.156947242711, 5841.386654401396, 5603.38362780102, 5633.324001119728, 5726.055200891807, 5732.226149469935, 5785.82642520725, 5808.593398462236, 5832.475077243069, 5838.474537291664, 5841.32824725162, 5842.883142337215, 5493.972530137324, 5505.504504594605, 5691.089425691869, 5705.942940570541, 5706.42935706426, 5552.361478430033, 5581.6930068846605, 5640.900024495184, 5666.829995100154, 5718.3423906249645, 5590.608657393944, 5594.9720251398485, 5613.438656134517, 5642.069058605284, 5649.406812284816, 5471.316085489314, 5555.194496798023, 5696.886062278814, 5734.05388110957, 5755.482006619424, 5530.529904958124, 5600.775968961359, 5604.383517812956, 5607.2149899014985, 5632.971835140798], "unit": "score", "name": "dojo.html", "value": 5309.329931566654}, {"lowerIsBetter": false, "replicates": [575.9690154623224, 583.5331734612311, 587.8295294364634, 590.5187272373016, 604.2990131447522, 37059.814700926494, 38038.0, 38158.42762358567, 38206.80896595516, 38217.0, 41731.0, 42355.15289694204, 42570.93572660685, 42578.36132458015, 42583.574164258345, 8653.134686531344, 8735.213830755263, 8747.081556436578, 8757.124287571223, 8811.911880881205, 8547.717842323638, 8681.0, 8703.52130632815, 8718.084601116887, 8732.17044380786, 8648.697295594655, 8682.739517814476, 8745.868811967826, 8777.605007774666, 8781.209691127797, 8727.869081963776, 8767.780805479819, 8779.341549383822, 8815.162559556831, 8836.64653413869, 8567.614457349371, 8660.393772435931, 8721.563921803885, 8723.869141962876, 8741.825163496758, 38970.0, 39591.0, 39598.60401396007, 39630.207395851925, 39909.40135897935, 3182.5067114597273, 3224.516322551636, 3311.3542859142476, 3490.022793617791, 3593.982030089859, 29074.70925290762, 29397.85301073481, 29561.408771824445, 30000.0, 30446.54330185049, 3846.192299617084, 3924.2151569686175, 4032.6370626643447, 4038.192361527706, 4039.8284497495692, 249005.9999999982, 249210.0, 251408.0, 252152.0, 252190.0, 57677.711611442515, 57909.420905791245, 58084.709576451845, 58101.418985810444, 58368.4163158363, 60957.390426096055, 66145.33854661392, 66379.33620663828, 66802.3319766796, 66868.66565667141, 14857.628559286104, 14933.477328293458, 14963.70072598542, 15019.699606007818, 15054.32255548481, 11250.324980501196, 11297.830532542019, 11354.829677554842, 11366.772664546828, 11373.658790236306, 20200.29298974529, 20448.284310049075, 20508.179672813218, 20528.897355513127, 20530.281440149523, 8083.878741818878, 8090.352771778244, 8211.507309561446, 8312.293455056268, 8366.58167091643, 945.6075728572703, 987.4174237200086, 1030.3920686794827, 1044.9007344302279, 1075.946202689878, 28104.43791124166, 28789.856050719613, 28793.280167995967, 32163.678363216535, 33582.49626255608, 999.6900960702205, 1110.5946329589804, 1113.3820729495046, 1117.7820325036703, 1123.4607388453587, 14691.55925322242, 14743.336549855283, 14812.555623331318, 15035.0, 15123.773143402857, 358136.0, 360558.0, 362145.0, 363070.0, 363091.0, 52408.737956309975, 52681.2097818533, 52841.73579132157, 52844.20733688998, 52989.0, 1335.7194989052214, 1343.0732794371852, 1343.892488600929, 1349.4399824073096, 1355.9389827457787, 27472.0, 28565.14304570866, 28747.71252287534, 28765.856170719013, 28766.568501472077, 44486.555134448245, 44889.77555112204, 45079.0, 45105.0, 45484.99665036777, 269358.0, 269712.0, 270447.0, 270689.0, 271318.0, 31671.0, 31706.36587268288, 32080.0, 32222.516662249614, 32228.516572250966, 41357.0, 41692.75880920359, 42259.7887010563, 42303.576964229964, 43331.78334108309, 35906.8204658975, 36343.45484817677, 36999.0, 36999.260014799016, 42830.0, 37967.0, 39145.41281880831, 39788.40317395183, 40439.3934090983, 40929.79535102305, 38646.0, 39149.41275880921, 40313.79843100766, 40935.0, 41033.79483102685, 37037.62962370342, 38783.0, 38835.805820971844, 39498.0, 39793.60206397899, 26771.19686409411, 26991.650417478653, 27122.0, 27345.86327068352, 27424.72575274222], "unit": "score", "name": "ext.html", "value": 18822.468394458716}, {"lowerIsBetter": false, "replicates": [347.12005067154735, 357.07517529598334, 357.6066327040256, 358.96769290763825, 360.9981950090249, 11245.437728113582, 11714.414279286044, 16309.184540772958, 16801.0, 17443.476695699133, 15367.538973830775, 15512.922435387836, 15564.45524406646, 17390.3913363032, 17768.0, 5933.732982015809, 6299.307076221635, 6467.0, 6504.70728817202, 6525.184351956005, 6312.684365781715, 6422.678866056702, 6835.28229535899, 6840.28177041411, 6864.9656751716175, 6187.814365569017, 6423.197100362455, 6425.485961123099, 6741.966290168542, 6776.390124888759, 5279.577633789307, 6408.166938298038, 6432.903506447407, 6492.837679058014, 6792.966035169842, 6418.646974416405, 6433.324500927429, 6459.35406459355, 6475.255345635218, 6485.2541957675, 20985.580288394147, 21553.5689286215, 22169.224077157385, 22187.889060554757, 22271.888640556856, 2229.9108035678555, 2249.865008099503, 2310.1567927706433, 2350.306659535441, 2368.751281115475, 14103.294835258299, 14330.64173395663, 14390.568282951528, 14593.635159121108, 14844.332005059798, 2005.0977060322766, 2022.5348169920853, 2076.1384025629345, 2091.1426315210692, 2091.7699053104147, 67777.66111169462, 69322.65338673274, 70430.99999999949, 70473.64763176203, 71983.0, 15138.772918406232, 15302.08187508753, 15451.0, 15465.072095674295, 15508.767368489482, 23757.7624223759, 23894.163704270613, 23921.641175382385, 24017.399565011016, 24075.157369491983, 8946.910530894738, 8979.057198994142, 9029.909700903037, 9039.954800225956, 9084.364094513452, 7739.535627862234, 7805.687772489036, 7833.921660783433, 7835.882461763078, 7853.332466740277, 7460.552366858006, 7625.428092893055, 7657.387409007378, 7664.501807382502, 7802.102758182768, 1799.4075243409416, 1859.9256029758658, 3018.652854921668, 3021.6374035115928, 3111.859966301522, 841.1630427724454, 876.3909083187251, 897.6678628907346, 942.4486675295029, 962.6390103711109, 15561.688766224612, 16296.592585185228, 16631.168441578116, 17366.65266694659, 17518.0, 905.8912930448388, 908.68650315641, 933.2207606648388, 965.8116667249819, 1015.0205052124735, 9682.612695492242, 9713.757156071013, 10022.899771002196, 10135.695929122137, 10152.492375381202, 476937.0, 480415.0, 484046.0, 484214.0, 484301.0, 76306.77870364358, 76599.61700191464, 77244.0, 80340.0, 80726.57820265401, 1110.6890070780194, 1124.2804605052772, 1133.7449073958294, 1136.8806275341135, 1151.45305979659, 15275.541733748005, 15284.694306114037, 15348.30932608013, 15562.922185389001, 15756.133412662413, 33651.326973460884, 34420.65579344174, 35034.85137062159, 35255.0, 35622.28755424929, 44624.10751785011, 44928.32607510955, 45342.31986520139, 46194.0, 49056.01887962292, 9195.586198620944, 9699.175570076623, 9784.119429251401, 9803.16673082796, 9806.75483112928, 11466.713332166762, 15310.693786123993, 16268.349266029227, 16460.176991150154, 17050.658986820443, 14104.365303561159, 14146.151230926178, 14359.92820035893, 14469.0, 14542.054766440147, 13904.652383690489, 13930.860691392956, 14000.229987350793, 14718.411263549338, 15011.699766004836, 14508.637284067983, 15154.469593564172, 15163.469278575638, 15329.46346877854, 15511.612209694396, 8600.827983440422, 9630.555416687554, 9687.0, 9931.304808663324, 9937.701868943943, 10068.194544436281, 12787.488500459878, 13383.263920484467, 13965.0, 14737.778933315794], "unit": "score", "name": "jquery.html", "value": 9770.644269800458}, {"lowerIsBetter": false, "replicates": [1503.8420965798598, 1679.5045461588832, 1717.716576764834, 1724.6636905803368, 1736.7221244600858, 7038.577685338877, 7193.964030179842, 7200.495965282439, 7212.423006159508, 7501.5874126923, 7395.963020184891, 7428.851422971537, 7451.329380355767, 7483.8877416838795, 7500.324970752631, 2153.8923053847325, 2190.4742861713153, 2192.1450634252656, 2194.1333173396497, 2195.1548653768336, 2197.52753158071, 2216.357256395643, 2287.2680742162515, 2287.405274628592, 2287.839851210416, 2192.1560199323294, 2197.494576247464, 2219.411855858199, 2236.4408897775556, 2245.38251980705, 2183.5087105401235, 2201.8348623853117, 2235.821134309251, 2235.977640223601, 2236.664500324948, 2205.2722601541454, 2230.5984922713906, 2232.821374290053, 2233.6314508106143, 2235.9888200559058, 7305.52514086588, 7378.741744038986, 7393.778186654409, 7394.852102957911, 7406.185319614838, 4479.910401791946, 4564.5435456454425, 4576.405067341258, 4594.540545945379, 4600.125976064537, 3047.360054388581, 3132.859021344045, 3215.3569286142865, 3233.062411900546, 3234.4016356974034, 1015.5629783855835, 1054.5149231353587, 1070.122499550369, 1085.375908852413, 1116.3246236027248, 9776.804463910681, 9798.118169364792, 9834.508274586313, 9838.114569688762, 9852.211823054211, 3834.1373191031794, 3843.1737176507186, 3844.961550384516, 3898.629630185128, 4007.719459637856, 8043.839123217503, 8056.39577031725, 8089.0, 8150.225728555778, 8154.592270386457, 4446.510883802779, 4459.665525085632, 4464.709793863389, 4480.350349199413, 4507.391502147234, 4130.876073717794, 4137.482814648169, 4138.503379594468, 4143.02638879863, 4180.268453020709, 3198.296374797541, 3213.453712868818, 3244.626867910173, 3264.9347013060083, 3270.4113259613023, 1000.2246013326404, 1015.9085682288629, 1026.440589878518, 1029.2332212501585, 1031.231732359397, 953.3374304858196, 1002.0981116994617, 1096.923215374916, 1161.6747310753003, 1323.0341850449227, 6573.967130164318, 6654.26803051664, 6706.597604143767, 6724.193096828412, 6729.798106056826, 607.2682417686677, 613.8153364007509, 626.2297374229723, 627.3350248736355, 760.8972788673569, 5209.817656382084, 5295.126304159848, 5369.275147855068, 5394.973025134927, 5410.107332290128, 8476.703315383931, 8657.696980605648, 8743.125687431206, 8788.209061184523, 8798.29613630908, 8567.914320856837, 8625.654973800978, 8648.091950345122, 8673.392862499564, 8728.781780455412, 6818.147731533559, 6952.860942781217, 6969.2682268362105, 6979.965100174568, 6990.196127445409, 6758.695858686273, 6759.662016899037, 6773.288804675438, 6777.966110169417, 6808.897866531907, 7603.0876294844975, 7826.0, 7908.6045697713735, 7918.485298455582, 7962.0, 7950.204979502235, 8069.152738962324, 8098.51408915467, 8105.878411823709, 8153.7553873383895, 6005.729742161526, 6054.545909056927, 6123.0, 6165.167702360124, 6171.506279497539, 7114.822129446805, 7143.357097861218, 7158.2841715828, 7167.319104685047, 7167.3549380556, 5836.8944446663345, 6541.967290163519, 6575.80272591823, 6649.434798042221, 6680.03139544773, 6323.968380158254, 6516.120323756232, 6519.152510173647, 6539.149910511603, 6597.373249541286, 6587.934120658923, 6634.601923884582, 6661.633610151488, 6844.315568443116, 6850.0, 6186.10301506288, 6214.471769899609, 6237.438630523275, 6241.687915604292, 6246.718897649525, 6290.591111577733, 6296.464800492009, 6299.590526615755, 6344.555881088279, 6350.618962862243], "unit": "score", "name": "mootools.html", "value": 4207.563867999951}, {"lowerIsBetter": false, "replicates": [333.0242389797892, 344.2564061626886, 345.58874938822794, 349.79012592444553, 354.2914171656688, 6250.187475628168, 6285.245770507546, 6329.145565348676, 6331.968340158304, 6405.61566306022, 6200.937990620092, 6225.159603453532, 6264.123022776804, 6273.184486016811, 6280.685965701719, 4726.031163611451, 4726.598239149659, 4733.763311834403, 4735.431748190222, 4738.099761045408, 4737.218358970783, 4743.169945259566, 4743.383360163174, 4743.549362810545, 4744.5492678195515, 4614.054118905617, 4620.768961551926, 4679.672422930396, 4695.859124226278, 4697.013627138305, 4697.647676424282, 4697.78859951303, 4726.905461890778, 4737.123632128068, 4742.644301677371, 4098.631123198897, 4099.97950010251, 4102.261592913274, 4107.815148318333, 4108.36320370343, 5920.348761636216, 5927.2590926134235, 5928.555358348141, 5945.8810823783715, 5954.345022047572, 5431.293931788881, 5531.640443371209, 5534.833954981357, 5544.695041772701, 5556.666600004012, 6640.80077597668, 6640.93359066408, 6650.168728908887, 6650.767223147215, 6666.200055993263, 4561.452625684906, 4565.703229290086, 4567.840125595588, 4571.085782843445, 4584.083183363341, 6700.162479690039, 6836.829079273009, 6848.589084654936, 6863.965680171617, 6887.173539175281, 4599.793009314589, 4613.331066995267, 4617.7691115444095, 4619.676622636383, 4621.491635920046, 4649.976750116295, 4669.276262179367, 4672.766361681903, 4672.883177920579, 4688.249880019181, 5432.320959880015, 5451.918221226685, 5455.563554915597, 5458.153986132156, 5464.836054918359, 6506.739730410731, 6629.469642428594, 6637.601743895381, 6651.900221496681, 6707.3292670732535, 1635.501172142508, 1643.2112585958807, 1646.415522489523, 1648.5384092454133, 1650.3893559383105, 1058.4231593781408, 1094.2395035450445, 1105.9391733454577, 1118.625260537729, 1125.8480105185859, 6331.493480521547, 6336.904946425807, 6341.365863413622, 6356.713947872265, 6363.427291543783, 6928.203256625452, 6944.618046007417, 6953.304669533006, 6953.965230173918, 6954.061201737802, 6256.249250089927, 6291.4023167799905, 6324.114623952651, 6358.7456501740335, 6409.583377080568, 3733.309337772521, 3784.0539865033743, 3786.8295926683363, 3794.2411517696573, 3814.6185381462187, 7070.186928503185, 7099.183593886666, 7113.0753002109395, 7116.964415177891, 7127.643617819192, 6969.825754356181, 7054.118235220598, 7142.5714457132735, 7179.174394944544, 7185.993960845486, 7069.469789765788, 7104.183018952784, 7106.893396599158, 7111.6799744010605, 7113.359797618239, 6983.685734142077, 6988.6505674715045, 6991.44068474531, 6996.6151861648095, 7011.3689767919095, 6750.729970801113, 6893.551919125241, 6895.0, 6909.44724422035, 6929.064576282138, 7007.089078419773, 7021.894671579828, 7036.507444478837, 7098.0, 7108.289171083057, 4625.768711564341, 4692.483826778984, 4696.436427628706, 4699.929501057555, 4700.2244629635725, 6902.516823822284, 6955.0, 6982.1272340957385, 7020.438364930691, 7022.789316320519, 6807.625580593115, 6808.251092379934, 6811.182658081062, 6812.455003599601, 6814.318568143146, 6753.864922701617, 6756.290589488033, 6767.154105736783, 6789.490788190807, 6800.965995169992, 6470.38531339522, 6594.637294948824, 6604.933950660432, 6642.83392915181, 6651.7006734698025, 6806.387425131762, 6806.965965170142, 6820.31796820314, 6825.249222585611, 6825.55633883796, 6494.935050649433, 6636.0, 6656.201255849329, 6657.40083392497, 6657.434118100015], "unit": "score", "name": "prototype.html", "value": 5006.886640501713}, {"lowerIsBetter": false, "replicates": [768.4236822383212, 817.162408531255, 830.783996160998, 861.6036623153349, 878.7275944457217, 13383.665408364795, 13685.178889266652, 13714.451421943111, 13726.725465490685, 13774.862251377483, 12746.68133296668, 12828.230306181636, 12843.486260549567, 13417.59747207583, 14001.229932353743, 810.529892662256, 816.408104124508, 819.4304958054155, 819.8196396792725, 822.9218224268685, 824.1017291152642, 824.3611201318965, 827.9130691277419, 829.4442723375353, 830.1739768929893, 868.7393781865446, 870.7474832298626, 876.6493402638931, 876.8553188723853, 876.9827000679213, 875.6147295190096, 876.0582373947967, 876.1238761238761, 876.2201640539924, 878.7100256915235, 634.9746010159588, 635.1869606903172, 637.6333608175318, 638.8562573420943, 639.6481934935813, 13732.0, 13780.793288100687, 13859.861401385959, 13860.306984650728, 13862.4455021799, 11483.712907177387, 11628.06975441971, 11826.586069487612, 12014.0, 12266.509339626404, 10144.289899707024, 10170.491475426274, 10398.428086455242, 10635.46822658864, 10636.62771802991, 3558.074900525856, 3576.2847430513743, 3700.85196592136, 3704.907377315562, 3723.94414083789, 45397.77301113506, 45446.54553454456, 45529.35765138781, 45538.54461455409, 45569.0, 9318.767030824149, 9405.57674904631, 9445.952770236105, 9556.426614403159, 9676.806463870684, 17079.743803842954, 17441.040742759018, 17457.039862807414, 17461.65076698459, 17479.0, 7369.189389167187, 7703.075630924325, 7758.340541054074, 7763.534187948628, 7819.139894611588, 4297.742135471819, 4342.696011279243, 4369.737815731003, 4379.364992076131, 4477.19410506112, 3053.64883038449, 3059.0, 3077.8461076946064, 3078.6459557150765, 3098.3028818515654, 541.1990254423397, 541.656048409255, 563.9830805075854, 571.2202843119195, 574.03562015813, 515.3583788183661, 518.7432221050605, 529.3303970477349, 532.4170033812968, 578.4446930946339, 7334.963325183447, 7538.924610753822, 7595.392368610498, 7780.1052878919645, 7827.412944029221, 602.9457348838538, 633.4520639646764, 648.3322178156507, 649.04590252329, 665.1353240786957, 3852.0, 3914.549826769901, 3926.096997690547, 3971.5035620547433, 4000.7799571023875, 51350.22974655383, 54133.0, 54922.0, 56620.0, 57063.714681426325, 45237.32144017842, 45784.7710761444, 46054.53945460502, 46290.76854615705, 47411.28883066757, 42084.789576051924, 44857.22646853119, 45693.314600281024, 46607.0, 46658.76670616625, 8261.917380826355, 8516.914830851612, 8639.222469977733, 8784.736457906272, 8803.691870784492, 33858.49212261769, 33875.4918676225, 34468.65531344755, 34623.13442163865, 34747.82626086853, 38357.6164238354, 38971.6102838968, 41999.0, 42480.78759606182, 42531.57468425276, 10433.373997560171, 10733.624323148651, 10794.406307653155, 10814.080803131821, 10898.12814974816, 11202.383868886964, 11423.314601123959, 11647.475863585989, 11691.298522088702, 12198.268103913793, 10829.0, 10980.0, 11074.889251107386, 11101.056410205223, 11200.83198752003, 10160.390376577428, 10181.694549163536, 10248.692539223835, 10269.691909242734, 10333.431661258403, 10390.844137337795, 10708.0, 10750.838737418788, 10958.835617465904, 11023.61417350421, 9554.952225238829, 9646.228301735984, 9736.988257696183, 9777.364471309342, 10072.043155900177, 8389.95805020971, 8706.434081784664, 9171.495567743837, 9210.355275130676, 9468.810623787347], "unit": "score", "name": "yui.html", "value": 6150.987704254435}], "name": "dromaeo_css", "value": 7085.505232675711}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 105.0, 112.0, 111.0, 111.0, 122.0, 113.0, 113.0, 112.0, 114.0], "unit": "score", "name": "ai-astar", "value": 112.5}, {"lowerIsBetter": true, "replicates": [148.0, 125.0, 149.0, 162.0, 126.0, 146.0, 150.0, 132.0, 161.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 142.3}, {"lowerIsBetter": true, "replicates": [160.0, 163.0, 162.0, 162.0, 160.0, 161.0, 162.0, 163.0, 169.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.3}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 79.0, 74.0, 72.0, 72.0, 73.0, 132.0, 71.0, 73.0], "unit": "score", "name": "audio-fft", "value": 79.1}, {"lowerIsBetter": true, "replicates": [93.0, 103.0, 135.0, 94.0, 94.0, 94.0, 138.0, 95.0, 93.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 107.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 145.0, 146.0, 148.0, 151.0, 146.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 95.0, 97.0, 99.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 63.0, 62.0, 61.0, 62.0, 65.0, 61.0, 60.0, 60.0], "unit": "score", "name": "json-parse-financial", "value": 62.0}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.9}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 87.0, 86.0, 93.0, 86.0, 86.0, 85.0, 94.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.4}, {"lowerIsBetter": true, "replicates": [121.0, 122.0, 123.0, 120.0, 126.0, 119.0, 126.0, 123.0, 127.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.0}, {"lowerIsBetter": true, "replicates": [141.0, 154.0, 148.0, 154.0, 154.0, 143.0, 150.0, 154.0, 148.0, 156.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.2}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 70.0, 68.0, 77.0, 73.0, 67.0, 72.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.2}], "name": "kraken", "value": 1516.4000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.33601070950468], "unit": "score", "name": "Richards", "value": 210.96475200000003}, {"lowerIsBetter": false, "replicates": [186.11576400521125], "unit": "score", "name": "DeltaBlue", "value": 355.2520139999999}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [1096.3855421686746], "unit": "score", "name": "RayTrace", "value": 674.9350219780222}, {"lowerIsBetter": false, "replicates": [695.8942240779402], "unit": "score", "name": "Earley", "value": 957.7073310000004}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [25300.0], "unit": "score", "name": "RegExp", "value": 36.007312252964404}, {"lowerIsBetter": false, "replicates": [695.6219596942321], "unit": "score", "name": "Splay", "value": 117.14840059940057}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21066.656795043007}]} 14:25:48 INFO - RETURN: dromaeo_css: 7085.51 14:25:48 INFO - RETURN: kraken: 1516.40 14:25:48 INFO - RETURN: v8_7: 21066.66 14:25:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21066.66"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1516.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "7085.51"}}} 14:25:48 INFO - Return code: 0 14:25:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:25:48 INFO - # TBPL SUCCESS # 14:25:48 INFO - Running post-action listener: _resource_record_post_action 14:25:48 INFO - Running post-run listener: _resource_record_post_run 14:25:49 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 422248448; Read time: 12; Write time: 339236 14:25:49 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99889152; Read time: 0; Write time: 98860 14:25:49 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 322359296; Read time: 12; Write time: 240376 14:25:49 INFO - Running post-run listener: _upload_blobber_files 14:25:49 INFO - Blob upload gear active. 14:25:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:25:49 INFO - Copying logs to upload dir... 14:25:49 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1283.527145 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-12-18 14:25:49.571774) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 14:25:49.574890) ========= 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=fdc9337702648c539b2c5dbe000001aa-1450473342.623108-1509948100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010015 build_url: 'https://queue.taskcluster.net/v1/task/IXXb3hXPSYivPVMXRQRQrg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 14:25:49.626673) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 14:25:49.627005) ========= 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=fdc9337702648c539b2c5dbe000001aa-1450473342.623108-1509948100 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004536 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 14:25:49.676423) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 14:25:49.676747) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 14:25:49.677067) ========= ========= Total master_lag: 0.25 =========