builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-054 starttime: 1450388853.63 results: success (0) buildid: 20151217113032 builduid: 8235816314f64c75936782aacb7c7a5c revision: 6a2ad662612370d248530465d690785c20abcf0b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:33.630858) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:33.631356) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:33.631698) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1450385999.341558-607460702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006365 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:33.677962) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:33.678282) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:33.754600) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:33.754908) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1450385999.341558-607460702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004771 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:33.813366) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:33.813672) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:33.814111) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:33.814446) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1450385999.341558-607460702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 13:47:34-- 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.5M=0s 2015-12-17 13:47:34 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181235 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:34.011603) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:34.011951) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1450385999.341558-607460702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020556 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:34.061077) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:34.061453) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6a2ad662612370d248530465d690785c20abcf0b --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 6a2ad662612370d248530465d690785c20abcf0b --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=752f8c75933e5bfb3b8f10bb000001ce-1450385999.341558-607460702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 13:47:34,720 truncating revision to first 12 chars 2015-12-17 13:47:34,720 Setting DEBUG logging. 2015-12-17 13:47:34,720 attempt 1/10 2015-12-17 13:47:34,720 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6a2ad6626123?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 13:47:35,052 unpacking tar archive at: fx-team-6a2ad6626123/testing/mozharness/ program finished with exit code 0 elapsedTime=0.734891 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:34.809422) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:34.809746) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:34.819206) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:34.819513) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 13:47:34.819952) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-12-17 13:47:34.820277) ========= /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=752f8c75933e5bfb3b8f10bb000001ce-1450385999.341558-607460702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:47:35 INFO - MultiFileLogger online at 20151217 13:47:35 in /builds/slave/test-pgo 13:47:35 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 13:47:35 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:47:35 INFO - {'append_to_log': False, 13:47:35 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:47:35 INFO - 'blob_upload_branch': 'Fx-Team', 13:47:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:47:35 INFO - 'branch': 'Fx-Team', 13:47:35 INFO - 'buildbot_json_path': 'buildprops.json', 13:47:35 INFO - 'config_files': ('talos/linux_config.py',), 13:47:35 INFO - 'default_actions': ('clobber', 13:47:35 INFO - 'read-buildbot-config', 13:47:35 INFO - 'download-and-extract', 13:47:35 INFO - 'populate-webroot', 13:47:35 INFO - 'create-virtualenv', 13:47:35 INFO - 'install', 13:47:35 INFO - 'run-tests'), 13:47:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:47:35 INFO - 'download_minidump_stackwalk': True, 13:47:35 INFO - 'download_symbols': 'ondemand', 13:47:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:47:35 INFO - 'tooltool.py': '/tools/tooltool.py', 13:47:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:47:35 INFO - '/tools/misc-python/virtualenv.py')}, 13:47:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:47:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:47:35 INFO - 'installer_path': 'installer.exe', 13:47:35 INFO - 'log_level': 'info', 13:47:35 INFO - 'log_name': 'talos', 13:47:35 INFO - 'log_to_console': True, 13:47:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:47:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:47:35 INFO - 'opt_config_files': (), 13:47:35 INFO - 'pip_index': False, 13:47:35 INFO - 'sps_profile': False, 13:47:35 INFO - 'sps_profile_interval': 0, 13:47:35 INFO - 'suite': 'dromaeojs-e10s', 13:47:35 INFO - 'system_bits': '64', 13:47:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:47:35 INFO - 'title': 'talos-linux64-ix-054', 13:47:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:47:35 INFO - 'use_talos_json': True, 13:47:35 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:47:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:47:35 INFO - 'work_dir': 'build'} 13:47:35 INFO - ##### 13:47:35 INFO - ##### Running clobber step. 13:47:35 INFO - ##### 13:47:35 INFO - Running pre-action listener: _resource_record_pre_action 13:47:35 INFO - Running main action method: clobber 13:47:35 INFO - rmtree: /builds/slave/test-pgo/build 13:47:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:47:36 INFO - Running post-action listener: _resource_record_post_action 13:47:36 INFO - ##### 13:47:36 INFO - ##### Running read-buildbot-config step. 13:47:36 INFO - ##### 13:47:36 INFO - Running pre-action listener: _resource_record_pre_action 13:47:36 INFO - Running main action method: read_buildbot_config 13:47:36 INFO - Using buildbot properties: 13:47:36 INFO - { 13:47:36 INFO - "project": "", 13:47:36 INFO - "product": "firefox", 13:47:36 INFO - "script_repo_revision": "production", 13:47:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 13:47:36 INFO - "repository": "", 13:47:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 13:47:36 INFO - "buildid": "20151217113032", 13:47:36 INFO - "pgo_build": "True", 13:47:36 INFO - "basedir": "/builds/slave/test-pgo", 13:47:36 INFO - "buildnumber": 148, 13:47:36 INFO - "slavename": "talos-linux64-ix-054", 13:47:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:47:36 INFO - "platform": "ubuntu64_hw", 13:47:36 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 13:47:36 INFO - "branch": "fx-team", 13:47:36 INFO - "repo_path": "integration/fx-team", 13:47:36 INFO - "revision": "6a2ad662612370d248530465d690785c20abcf0b", 13:47:36 INFO - "stage_platform": "linux64-pgo", 13:47:36 INFO - "builduid": "8235816314f64c75936782aacb7c7a5c", 13:47:36 INFO - "slavebuilddir": "test" 13:47:36 INFO - } 13:47:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 13:47:36 INFO - Running post-action listener: _resource_record_post_action 13:47:36 INFO - ##### 13:47:36 INFO - ##### Running download-and-extract step. 13:47:36 INFO - ##### 13:47:36 INFO - Running pre-action listener: _resource_record_pre_action 13:47:36 INFO - Running main action method: download_and_extract 13:47:36 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:47:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:36 INFO - https://queue.taskcluster.net/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:47:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/test_packages.json 13:47:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/test_packages.json 13:47:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:47:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:47:38 INFO - Downloaded 1302 bytes. 13:47:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:47:38 INFO - Using the following test package requirements: 13:47:38 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:47:38 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:47:38 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:38 INFO - u'jsshell-linux-x86_64.zip'], 13:47:38 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:47:38 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:47:38 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:47:38 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:47:38 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:47:38 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:47:38 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:47:38 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:38 INFO - https://queue.taskcluster.net/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:47:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:47:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:47:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/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 13:47:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/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 13:47:41 INFO - Downloaded 23120102 bytes. 13:47:41 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 13:47:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:47:41 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 13:47:42 INFO - Return code: 0 13:47:42 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 13:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:42 INFO - https://queue.taskcluster.net/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:47:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:47:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:47:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/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 13:47:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/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 13:47:54 INFO - Downloaded 23120102 bytes. 13:47:54 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 13:47:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:47:54 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 13:47:55 INFO - Return code: 0 13:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:55 INFO - https://queue.taskcluster.net/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:47:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:47:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:47:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/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 13:47:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/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 13:47:56 INFO - Downloaded 11132039 bytes. 13:47:56 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 13:47:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:47:56 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 13:47:57 INFO - Return code: 0 13:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:47:57 INFO - https://queue.taskcluster.net/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:47:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:47:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:47:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/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 13:47:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hrFIooBTRmqAVyCqZN7LZw/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 13:47:58 INFO - Downloaded 54643098 bytes. 13:47:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:47:58 INFO - mkdir: /builds/slave/test-pgo/properties 13:47:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:47:58 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:47:58 INFO - Contents: 13:47:58 INFO - build_url:https://queue.taskcluster.net/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:47:58 INFO - Running post-action listener: _resource_record_post_action 13:47:58 INFO - Running post-action listener: set_extra_try_arguments 13:47:58 INFO - ##### 13:47:58 INFO - ##### Running populate-webroot step. 13:47:58 INFO - ##### 13:47:58 INFO - Running pre-action listener: _resource_record_pre_action 13:47:58 INFO - Running main action method: populate_webroot 13:47:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:47:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:47:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:47:58 INFO - '--tppagecycles', 13:47:58 INFO - '7'], 13:47:58 INFO - 'tests': ['tsvgm']}}, 13:47:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:47:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:47:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:47:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:47:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:47:58 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:47:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:47:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:58 INFO - 'talos_options': ['--e10s'], 13:47:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:47:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:58 INFO - 'tests': ['damp', 'tps']}, 13:47:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:58 INFO - 'talos_options': ['--e10s'], 13:47:58 INFO - 'tests': ['damp', 'tps']}, 13:47:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:47:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:47:58 INFO - 'other': {'tests': ['a11yr', 13:47:58 INFO - 'ts_paint', 13:47:58 INFO - 'tpaint', 13:47:58 INFO - 'sessionrestore', 13:47:58 INFO - 'sessionrestore_no_auto_restore']}, 13:47:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:47:58 INFO - 'tests': ['a11yr', 13:47:58 INFO - 'ts_paint', 13:47:58 INFO - 'tpaint', 13:47:58 INFO - 'sessionrestore', 13:47:58 INFO - 'sessionrestore_no_auto_restore']}, 13:47:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:47:58 INFO - 'tests': ['a11yr', 13:47:58 INFO - 'ts_paint', 13:47:58 INFO - 'tpaint', 13:47:58 INFO - 'sessionrestore', 13:47:58 INFO - 'sessionrestore_no_auto_restore']}, 13:47:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:47:58 INFO - 'tests': ['a11yr', 13:47:58 INFO - 'ts_paint', 13:47:58 INFO - 'tpaint', 13:47:58 INFO - 'sessionrestore', 13:47:58 INFO - 'sessionrestore_no_auto_restore']}, 13:47:58 INFO - 'other_l64': {'tests': ['a11yr', 13:47:58 INFO - 'ts_paint', 13:47:58 INFO - 'tpaint', 13:47:58 INFO - 'sessionrestore', 13:47:58 INFO - 'sessionrestore_no_auto_restore']}, 13:47:58 INFO - 'other_nol64': {'tests': ['a11yr', 13:47:58 INFO - 'ts_paint', 13:47:58 INFO - 'tpaint', 13:47:58 INFO - 'sessionrestore', 13:47:58 INFO - 'sessionrestore_no_auto_restore']}, 13:47:58 INFO - 'svgr': {'tests': ['tsvgx', 13:47:58 INFO - 'tsvgr_opacity', 13:47:58 INFO - 'tart', 13:47:58 INFO - 'tscrollx', 13:47:58 INFO - 'cart']}, 13:47:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:47:58 INFO - 'tests': ['tsvgx', 13:47:58 INFO - 'tsvgr_opacity', 13:47:58 INFO - 'tart', 13:47:58 INFO - 'tscrollx', 13:47:58 INFO - 'cart']}, 13:47:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:58 INFO - 'tests': ['tp5o']}, 13:47:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:58 INFO - 'talos_options': ['--e10s'], 13:47:58 INFO - 'tests': ['tp5o']}, 13:47:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:58 INFO - 'talos_options': ['--xperf_path', 13:47:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:47:58 INFO - 'tests': ['tp5n']}, 13:47:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:58 INFO - 'talos_options': ['--e10s', 13:47:58 INFO - '--xperf_path', 13:47:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:47:58 INFO - 'tests': ['tp5n']}}, 13:47:58 INFO - 'talos.zip': {'path': '', 13:47:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:47:58 INFO - Running post-action listener: _resource_record_post_action 13:47:58 INFO - ##### 13:47:58 INFO - ##### Running create-virtualenv step. 13:47:58 INFO - ##### 13:47:58 INFO - Running pre-action listener: _resource_record_pre_action 13:47:58 INFO - Running main action method: create_virtualenv 13:47:58 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:47: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 13:47:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:47:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:47:58 INFO - Using real prefix '/usr' 13:47:58 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:47:59 INFO - Installing distribute.............................................................................................................................................................................................done. 13:48:01 INFO - Installing pip.................done. 13:48:01 INFO - Return code: 0 13:48:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:48: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')]} 13:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48: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')]} 13:48:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48: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 0x7fd44ca7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1554600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e3350>, '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 0x15e4250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e46e0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450385999.341558-607460702', '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 13:48: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 13:48: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 13:48:01 INFO - Using env: {'DISPLAY': ':0', 13:48:01 INFO - 'HOME': '/home/cltbld', 13:48:01 INFO - 'LANG': 'en_US.UTF-8', 13:48:01 INFO - 'LANGUAGE': 'en_US:en', 13:48:01 INFO - 'LOGNAME': 'cltbld', 13:48:01 INFO - 'MAIL': '/var/mail/cltbld', 13:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:01 INFO - 'MOZ_NO_REMOTE': '1', 13:48:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:01 INFO - 'NO_EM_RESTART': '1', 13:48:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:48:01 INFO - 'PWD': '/builds/slave/test-pgo', 13:48:01 INFO - 'SHELL': '/bin/bash', 13:48:01 INFO - 'SHLVL': '1', 13:48:01 INFO - 'TERM': 'linux', 13:48:01 INFO - 'TMOUT': '86400', 13:48:01 INFO - 'USER': 'cltbld', 13:48:01 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450385999.341558-607460702', 13:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:01 INFO - '_': '/tools/buildbot/bin/python'} 13:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48: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 13:48:01 INFO - Cleaning up... 13:48:01 INFO - Return code: 0 13:48:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:48: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')]} 13:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48: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')]} 13:48:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48: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 0x7fd44ca7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1554600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e3350>, '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 0x15e4250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e46e0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450385999.341558-607460702', '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 13:48: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 13:48: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 13:48:01 INFO - Using env: {'DISPLAY': ':0', 13:48:01 INFO - 'HOME': '/home/cltbld', 13:48:01 INFO - 'LANG': 'en_US.UTF-8', 13:48:01 INFO - 'LANGUAGE': 'en_US:en', 13:48:01 INFO - 'LOGNAME': 'cltbld', 13:48:01 INFO - 'MAIL': '/var/mail/cltbld', 13:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:01 INFO - 'MOZ_NO_REMOTE': '1', 13:48:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:01 INFO - 'NO_EM_RESTART': '1', 13:48:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:48:01 INFO - 'PWD': '/builds/slave/test-pgo', 13:48:01 INFO - 'SHELL': '/bin/bash', 13:48:01 INFO - 'SHLVL': '1', 13:48:01 INFO - 'TERM': 'linux', 13:48:01 INFO - 'TMOUT': '86400', 13:48:01 INFO - 'USER': 'cltbld', 13:48:01 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450385999.341558-607460702', 13:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:01 INFO - '_': '/tools/buildbot/bin/python'} 13:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:01 INFO - Downloading/unpacking psutil>=0.7.1 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48:03 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 13:48:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:48:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:48:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:48:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:48:03 INFO - Installing collected packages: psutil 13:48:03 INFO - Running setup.py install for psutil 13:48:03 INFO - building 'psutil._psutil_linux' extension 13:48: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 13:48: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 13:48:03 INFO - building 'psutil._psutil_posix' extension 13:48: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 13:48: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 13:48:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:48:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:48:04 INFO - Successfully installed psutil 13:48:04 INFO - Cleaning up... 13:48:04 INFO - Return code: 0 13:48:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:04 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 0x7fd44ca7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1554600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e3350>, '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 0x15e4250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e46e0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450385999.341558-607460702', '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 13:48:04 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 13:48:04 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 13:48:04 INFO - Using env: {'DISPLAY': ':0', 13:48:04 INFO - 'HOME': '/home/cltbld', 13:48:04 INFO - 'LANG': 'en_US.UTF-8', 13:48:04 INFO - 'LANGUAGE': 'en_US:en', 13:48:04 INFO - 'LOGNAME': 'cltbld', 13:48:04 INFO - 'MAIL': '/var/mail/cltbld', 13:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:04 INFO - 'MOZ_NO_REMOTE': '1', 13:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:04 INFO - 'NO_EM_RESTART': '1', 13:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:48:04 INFO - 'PWD': '/builds/slave/test-pgo', 13:48:04 INFO - 'SHELL': '/bin/bash', 13:48:04 INFO - 'SHLVL': '1', 13:48:04 INFO - 'TERM': 'linux', 13:48:04 INFO - 'TMOUT': '86400', 13:48:04 INFO - 'USER': 'cltbld', 13:48:04 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450385999.341558-607460702', 13:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:04 INFO - '_': '/tools/buildbot/bin/python'} 13:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:48:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:48:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:48:06 INFO - Installing collected packages: mozsystemmonitor 13:48:06 INFO - Running setup.py install for mozsystemmonitor 13:48:06 INFO - Successfully installed mozsystemmonitor 13:48:06 INFO - Cleaning up... 13:48:06 INFO - Return code: 0 13:48:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd44ca7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1554600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e3350>, '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 0x15e4250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e46e0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450385999.341558-607460702', '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 13:48:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 13:48:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:48:06 INFO - Using env: {'DISPLAY': ':0', 13:48:06 INFO - 'HOME': '/home/cltbld', 13:48:06 INFO - 'LANG': 'en_US.UTF-8', 13:48:06 INFO - 'LANGUAGE': 'en_US:en', 13:48:06 INFO - 'LOGNAME': 'cltbld', 13:48:06 INFO - 'MAIL': '/var/mail/cltbld', 13:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:06 INFO - 'MOZ_NO_REMOTE': '1', 13:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:06 INFO - 'NO_EM_RESTART': '1', 13:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:48:06 INFO - 'PWD': '/builds/slave/test-pgo', 13:48:06 INFO - 'SHELL': '/bin/bash', 13:48:06 INFO - 'SHLVL': '1', 13:48:06 INFO - 'TERM': 'linux', 13:48:06 INFO - 'TMOUT': '86400', 13:48:06 INFO - 'USER': 'cltbld', 13:48:06 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450385999.341558-607460702', 13:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:06 INFO - '_': '/tools/buildbot/bin/python'} 13:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:06 INFO - Downloading/unpacking blobuploader==1.2.4 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48:08 INFO - Downloading blobuploader-1.2.4.tar.gz 13:48:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:48:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:48:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:48:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:48:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48:08 INFO - Downloading docopt-0.6.1.tar.gz 13:48:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:48:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:48:08 INFO - Installing collected packages: blobuploader, requests, docopt 13:48:08 INFO - Running setup.py install for blobuploader 13:48:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:48:08 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:48:08 INFO - Running setup.py install for requests 13:48:09 INFO - Running setup.py install for docopt 13:48:09 INFO - Successfully installed blobuploader requests docopt 13:48:09 INFO - Cleaning up... 13:48:09 INFO - Return code: 0 13:48:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:48: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')]} 13:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48: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')]} 13:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48: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 0x7fd44ca7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1554600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e3350>, '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 0x15e4250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e46e0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450385999.341558-607460702', '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 13:48: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 13:48: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 13:48:09 INFO - Using env: {'DISPLAY': ':0', 13:48:09 INFO - 'HOME': '/home/cltbld', 13:48:09 INFO - 'LANG': 'en_US.UTF-8', 13:48:09 INFO - 'LANGUAGE': 'en_US:en', 13:48:09 INFO - 'LOGNAME': 'cltbld', 13:48:09 INFO - 'MAIL': '/var/mail/cltbld', 13:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:09 INFO - 'MOZ_NO_REMOTE': '1', 13:48:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:09 INFO - 'NO_EM_RESTART': '1', 13:48:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:48:09 INFO - 'PWD': '/builds/slave/test-pgo', 13:48:09 INFO - 'SHELL': '/bin/bash', 13:48:09 INFO - 'SHLVL': '1', 13:48:09 INFO - 'TERM': 'linux', 13:48:09 INFO - 'TMOUT': '86400', 13:48:09 INFO - 'USER': 'cltbld', 13:48:09 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450385999.341558-607460702', 13:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:09 INFO - '_': '/tools/buildbot/bin/python'} 13:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:48:09 INFO - Running setup.py (path:/tmp/pip-BX7DBI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:48:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:48:09 INFO - Running setup.py (path:/tmp/pip-WRhaKx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:48:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:48:09 INFO - Running setup.py (path:/tmp/pip-p28lfY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:48:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:48:09 INFO - Running setup.py (path:/tmp/pip-gJdxGg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:48:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:48:09 INFO - Running setup.py (path:/tmp/pip-r6Oqjh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:48:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:48:10 INFO - Running setup.py (path:/tmp/pip-tfq781-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:48:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:48:10 INFO - Running setup.py (path:/tmp/pip-87fkLA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:48:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:48:10 INFO - Running setup.py (path:/tmp/pip-ZDLmN9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:48:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:48:10 INFO - Running setup.py (path:/tmp/pip-rM_xrl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:48:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:48:10 INFO - Running setup.py (path:/tmp/pip-8bReIg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:48:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:48:10 INFO - Running setup.py (path:/tmp/pip-ZXpypu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:48:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:48:10 INFO - Running setup.py (path:/tmp/pip-P4rw8X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:48:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:48:10 INFO - Running setup.py (path:/tmp/pip-zj9V7_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:48:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:48:10 INFO - Running setup.py (path:/tmp/pip-u31bGp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:48:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:48:10 INFO - Running setup.py (path:/tmp/pip-iQQdUy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:48:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:48:10 INFO - Running setup.py (path:/tmp/pip-Eo8dgq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:48:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:48:10 INFO - Running setup.py (path:/tmp/pip-99jVa2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:48:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:48:10 INFO - Running setup.py install for manifestparser 13:48:11 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:48:11 INFO - Running setup.py install for mozcrash 13:48:11 INFO - Running setup.py install for mozdebug 13:48:11 INFO - Running setup.py install for mozdevice 13:48:11 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:48:11 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:48:11 INFO - Running setup.py install for mozfile 13:48:11 INFO - Running setup.py install for mozhttpd 13:48:11 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:48:11 INFO - Running setup.py install for mozinfo 13:48:11 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:48:11 INFO - Running setup.py install for mozInstall 13:48:11 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:48:11 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:48:11 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:48:11 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:48:11 INFO - Running setup.py install for mozleak 13:48:11 INFO - Running setup.py install for mozlog 13:48:11 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:48:11 INFO - Running setup.py install for moznetwork 13:48:12 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:48:12 INFO - Running setup.py install for mozprocess 13:48:12 INFO - Running setup.py install for mozprofile 13:48:12 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:48:12 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:48:12 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:48:12 INFO - Running setup.py install for mozrunner 13:48:12 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:48:12 INFO - Running setup.py install for mozscreenshot 13:48:12 INFO - Running setup.py install for moztest 13:48:12 INFO - Running setup.py install for mozversion 13:48:12 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:48:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:48:12 INFO - Cleaning up... 13:48:12 INFO - Return code: 0 13:48:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:48: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')]} 13:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48: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')]} 13:48:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48: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 0x7fd44ca7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1554600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e3350>, '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 0x15e4250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e46e0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450385999.341558-607460702', '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 13:48: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 13:48: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 13:48:12 INFO - Using env: {'DISPLAY': ':0', 13:48:12 INFO - 'HOME': '/home/cltbld', 13:48:12 INFO - 'LANG': 'en_US.UTF-8', 13:48:12 INFO - 'LANGUAGE': 'en_US:en', 13:48:12 INFO - 'LOGNAME': 'cltbld', 13:48:12 INFO - 'MAIL': '/var/mail/cltbld', 13:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:12 INFO - 'MOZ_NO_REMOTE': '1', 13:48:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:12 INFO - 'NO_EM_RESTART': '1', 13:48:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:48:12 INFO - 'PWD': '/builds/slave/test-pgo', 13:48:12 INFO - 'SHELL': '/bin/bash', 13:48:12 INFO - 'SHLVL': '1', 13:48:12 INFO - 'TERM': 'linux', 13:48:12 INFO - 'TMOUT': '86400', 13:48:12 INFO - 'USER': 'cltbld', 13:48:12 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450385999.341558-607460702', 13:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:12 INFO - '_': '/tools/buildbot/bin/python'} 13:48:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:48:12 INFO - Running setup.py (path:/tmp/pip-mmJwDG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:48: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)) 13:48:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:48:12 INFO - Running setup.py (path:/tmp/pip-2CWsYx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:48:13 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)) 13:48:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:48:13 INFO - Running setup.py (path:/tmp/pip-ff1Wi8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:48:13 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)) 13:48:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:48:13 INFO - Running setup.py (path:/tmp/pip-_GXdqB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:48:13 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)) 13:48:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:48:13 INFO - Running setup.py (path:/tmp/pip-bdckUY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:48:13 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)) 13:48:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:48:13 INFO - Running setup.py (path:/tmp/pip-WLuZC_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:48: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)) 13:48:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:48:13 INFO - Running setup.py (path:/tmp/pip-4JYuNX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:48: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)) 13:48:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:48:13 INFO - Running setup.py (path:/tmp/pip-TC8Fce-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:48: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)) 13:48:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:48:13 INFO - Running setup.py (path:/tmp/pip-o5ezSy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:48: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)) 13:48:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:48:13 INFO - Running setup.py (path:/tmp/pip-z2vF5t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:48: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)) 13:48:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:48:13 INFO - Running setup.py (path:/tmp/pip-9h4rSU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:48: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)) 13:48:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:48:13 INFO - Running setup.py (path:/tmp/pip-c2Krrg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:48: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)) 13:48:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:48:13 INFO - Running setup.py (path:/tmp/pip-g67Z1e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:48: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)) 13:48:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:48:13 INFO - Running setup.py (path:/tmp/pip-_0m0fi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:48: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)) 13:48:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:48:13 INFO - Running setup.py (path:/tmp/pip-npc3ie-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:48: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)) 13:48:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:48:14 INFO - Running setup.py (path:/tmp/pip-b9VHbO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:48:14 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)) 13:48:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:48:14 INFO - Running setup.py (path:/tmp/pip-8zdufk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:48:14 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)) 13:48:14 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)) 13:48:14 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)) 13:48:14 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)) 13:48:14 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)) 13:48:14 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)) 13:48:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:15 INFO - Downloading blessings-1.5.1.tar.gz 13:48: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 13:48:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:48:15 INFO - Installing collected packages: blessings 13:48:15 INFO - Running setup.py install for blessings 13:48:16 INFO - Successfully installed blessings 13:48:16 INFO - Cleaning up... 13:48:16 INFO - Return code: 0 13:48:16 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:48:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:48:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:48:16 INFO - Reading from file tmpfile_stdout 13:48:16 INFO - Current package versions: 13:48:16 INFO - argparse == 1.2.1 13:48:16 INFO - blessings == 1.5.1 13:48:16 INFO - blobuploader == 1.2.4 13:48:16 INFO - docopt == 0.6.1 13:48:16 INFO - manifestparser == 1.1 13:48:16 INFO - mozInstall == 1.12 13:48:16 INFO - mozcrash == 0.16 13:48:16 INFO - mozdebug == 0.1 13:48:16 INFO - mozdevice == 0.47 13:48:16 INFO - mozfile == 1.2 13:48:16 INFO - mozhttpd == 0.7 13:48:16 INFO - mozinfo == 0.9 13:48:16 INFO - mozleak == 0.1 13:48:16 INFO - mozlog == 3.1 13:48:16 INFO - moznetwork == 0.27 13:48:16 INFO - mozprocess == 0.22 13:48:16 INFO - mozprofile == 0.27 13:48:16 INFO - mozrunner == 6.11 13:48:16 INFO - mozscreenshot == 0.1 13:48:16 INFO - mozsystemmonitor == 0.0 13:48:16 INFO - moztest == 0.7 13:48:16 INFO - mozversion == 1.4 13:48:16 INFO - psutil == 3.1.1 13:48:16 INFO - requests == 1.2.3 13:48:16 INFO - wsgiref == 0.1.2 13:48:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:48: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')]} 13:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48: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')]} 13:48:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48: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', '-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 0x7fd44ca7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1554600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e3350>, '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 0x15e4250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e46e0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450385999.341558-607460702', '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 13:48:16 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 13:48:16 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 13:48:16 INFO - Using env: {'DISPLAY': ':0', 13:48:16 INFO - 'HOME': '/home/cltbld', 13:48:16 INFO - 'LANG': 'en_US.UTF-8', 13:48:16 INFO - 'LANGUAGE': 'en_US:en', 13:48:16 INFO - 'LOGNAME': 'cltbld', 13:48:16 INFO - 'MAIL': '/var/mail/cltbld', 13:48:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:16 INFO - 'MOZ_NO_REMOTE': '1', 13:48:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:16 INFO - 'NO_EM_RESTART': '1', 13:48:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:48:16 INFO - 'PWD': '/builds/slave/test-pgo', 13:48:16 INFO - 'SHELL': '/bin/bash', 13:48:16 INFO - 'SHLVL': '1', 13:48:16 INFO - 'TERM': 'linux', 13:48:16 INFO - 'TMOUT': '86400', 13:48:16 INFO - 'USER': 'cltbld', 13:48:16 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450385999.341558-607460702', 13:48:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:16 INFO - '_': '/tools/buildbot/bin/python'} 13:48:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48: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)) 13:48: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)) 13:48: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)) 13:48: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)) 13:48: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)) 13:48: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)) 13:48: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)) 13:48: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)) 13:48: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)) 13:48: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)) 13:48: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)) 13:48:16 INFO - Cleaning up... 13:48:16 INFO - Return code: 0 13:48:16 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:48: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')]} 13:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48: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')]} 13:48:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48: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 0x7fd44ca7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1554600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e3350>, '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 0x15e4250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e46e0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450385999.341558-607460702', '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 13:48: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 13:48: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 13:48:16 INFO - Using env: {'DISPLAY': ':0', 13:48:16 INFO - 'HOME': '/home/cltbld', 13:48:16 INFO - 'LANG': 'en_US.UTF-8', 13:48:16 INFO - 'LANGUAGE': 'en_US:en', 13:48:16 INFO - 'LOGNAME': 'cltbld', 13:48:16 INFO - 'MAIL': '/var/mail/cltbld', 13:48:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:16 INFO - 'MOZ_NO_REMOTE': '1', 13:48:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:16 INFO - 'NO_EM_RESTART': '1', 13:48:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:48:16 INFO - 'PWD': '/builds/slave/test-pgo', 13:48:16 INFO - 'SHELL': '/bin/bash', 13:48:16 INFO - 'SHLVL': '1', 13:48:16 INFO - 'TERM': 'linux', 13:48:16 INFO - 'TMOUT': '86400', 13:48:16 INFO - 'USER': 'cltbld', 13:48:16 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450385999.341558-607460702', 13:48:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:16 INFO - '_': '/tools/buildbot/bin/python'} 13:48:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:16 INFO - Downloading/unpacking jsonschema 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:48: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 13:48:18 INFO - Downloading/unpacking functools32 (from jsonschema) 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48:18 INFO - Downloading functools32-3.2.3-2.tar.gz 13:48: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 13:48:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:48:18 INFO - warning: no files found matching '*.txt' 13:48:18 INFO - no previously-included directories found matching 'build' 13:48:18 INFO - no previously-included directories found matching 'dist' 13:48:18 INFO - no previously-included directories found matching '.git*' 13:48:18 INFO - Installing collected packages: jsonschema, functools32 13:48:18 INFO - Running setup.py install for functools32 13:48:18 INFO - warning: no files found matching '*.txt' 13:48:18 INFO - no previously-included directories found matching 'build' 13:48:18 INFO - no previously-included directories found matching 'dist' 13:48:18 INFO - no previously-included directories found matching '.git*' 13:48:18 INFO - Successfully installed jsonschema functools32 13:48:18 INFO - Cleaning up... 13:48:18 INFO - Return code: 0 13:48:18 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:48: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')]} 13:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48: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')]} 13:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48: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 0x7fd44ca7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1554600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e3350>, '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 0x15e4250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e46e0>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1450385999.341558-607460702', '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 13:48: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 13:48: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 13:48:18 INFO - Using env: {'DISPLAY': ':0', 13:48:18 INFO - 'HOME': '/home/cltbld', 13:48:18 INFO - 'LANG': 'en_US.UTF-8', 13:48:18 INFO - 'LANGUAGE': 'en_US:en', 13:48:18 INFO - 'LOGNAME': 'cltbld', 13:48:18 INFO - 'MAIL': '/var/mail/cltbld', 13:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:18 INFO - 'MOZ_NO_REMOTE': '1', 13:48:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:18 INFO - 'NO_EM_RESTART': '1', 13:48:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:48:18 INFO - 'PWD': '/builds/slave/test-pgo', 13:48:18 INFO - 'SHELL': '/bin/bash', 13:48:18 INFO - 'SHLVL': '1', 13:48:18 INFO - 'TERM': 'linux', 13:48:18 INFO - 'TMOUT': '86400', 13:48:18 INFO - 'USER': 'cltbld', 13:48:18 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450385999.341558-607460702', 13:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:18 INFO - '_': '/tools/buildbot/bin/python'} 13:48:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:19 INFO - Downloading/unpacking flake8 13:48:19 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 13:48:19 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 13:48:19 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 13:48:19 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 13:48:19 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 13:48:19 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 13:48:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:48: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 13:48:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:48: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 13:48:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48:21 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 13:48:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:48:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:48:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:48:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:48:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:48:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:48:21 INFO - no previously-included directories found matching 'docs/_build' 13:48:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:48:21 INFO - Running setup.py install for pep8 13:48:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:48:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:48:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:48:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:48:21 INFO - no previously-included directories found matching 'docs/_build' 13:48:21 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:48:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:48:21 INFO - Cleaning up... 13:48:21 INFO - Return code: 0 13:48:21 INFO - Running post-action listener: _resource_record_post_action 13:48:21 INFO - Running post-action listener: _start_resource_monitoring 13:48:21 INFO - Starting resource monitoring. 13:48:21 INFO - ##### 13:48:21 INFO - ##### Running install step. 13:48:21 INFO - ##### 13:48:21 INFO - Running pre-action listener: _resource_record_pre_action 13:48:21 INFO - Running main action method: install 13:48:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:48:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:48:21 INFO - Reading from file tmpfile_stdout 13:48:21 INFO - Detecting whether we're running mozinstall >=1.0... 13:48:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:48:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:48:21 INFO - Reading from file tmpfile_stdout 13:48:21 INFO - Output received: 13:48:21 INFO - Usage: mozinstall [options] installer 13:48:21 INFO - Options: 13:48:21 INFO - -h, --help show this help message and exit 13:48:21 INFO - -d DEST, --destination=DEST 13:48:21 INFO - Directory to install application into. [default: 13:48:21 INFO - "/builds/slave/test-pgo"] 13:48:21 INFO - --app=APP Application being installed. [default: firefox] 13:48:21 INFO - mkdir: /builds/slave/test-pgo/build/application 13:48: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'] 13:48: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 13:48:37 INFO - Reading from file tmpfile_stdout 13:48:37 INFO - Output received: 13:48:37 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:48:37 INFO - Running post-action listener: _resource_record_post_action 13:48:37 INFO - ##### 13:48:37 INFO - ##### Running run-tests step. 13:48:37 INFO - ##### 13:48:37 INFO - Running pre-action listener: _resource_record_pre_action 13:48:37 INFO - Running main action method: run_tests 13:48:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:48:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:48:37 INFO - Python 2.7.3 13:48:37 INFO - Return code: 0 13:48:37 INFO - grabbing minidump binary from tooltool 13:48: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')]} 13:48: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 0x15e3350>, '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 0x15e4250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e46e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:48: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 13:48: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 13:48:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:48:37 INFO - Return code: 0 13:48:37 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:48:37 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:48:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:48:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:48:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:48:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:48:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:48:38 INFO - Return code: 0 13:48: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/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 13:48: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/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost 13:48:38 INFO - Using env: {'DISPLAY': ':0', 13:48:38 INFO - 'HOME': '/home/cltbld', 13:48:38 INFO - 'LANG': 'en_US.UTF-8', 13:48:38 INFO - 'LANGUAGE': 'en_US:en', 13:48:38 INFO - 'LOGNAME': 'cltbld', 13:48:38 INFO - 'MAIL': '/var/mail/cltbld', 13:48:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:48:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:38 INFO - 'MOZ_NO_REMOTE': '1', 13:48:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:48:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:38 INFO - 'NO_EM_RESTART': '1', 13:48:38 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:48:38 INFO - 'PWD': '/builds/slave/test-pgo', 13:48:38 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:48:38 INFO - 'SHELL': '/bin/bash', 13:48:38 INFO - 'SHLVL': '1', 13:48:38 INFO - 'TERM': 'linux', 13:48:38 INFO - 'TMOUT': '86400', 13:48:38 INFO - 'USER': 'cltbld', 13:48:38 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1450385999.341558-607460702', 13:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:38 INFO - '_': '/tools/buildbot/bin/python'} 13:48: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/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost'] with output_timeout 3600 13:48:38 INFO - mozversion INFO | application_buildid: 20151217113032 13:48:38 INFO - mozversion INFO | application_changeset: 6a2ad662612370d248530465d690785c20abcf0b 13:48:38 INFO - mozversion INFO | application_display_name: Nightly 13:48:38 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:48:38 INFO - mozversion INFO | application_name: Firefox 13:48:38 INFO - mozversion INFO | application_remotingname: firefox 13:48:38 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 13:48:38 INFO - mozversion INFO | application_vendor: Mozilla 13:48:38 INFO - mozversion INFO | application_version: 46.0a1 13:48:38 INFO - mozversion INFO | platform_buildid: 20151217113032 13:48:38 INFO - mozversion INFO | platform_changeset: 6a2ad662612370d248530465d690785c20abcf0b 13:48:38 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 13:48:38 INFO - mozversion INFO | platform_version: 46.0a1 13:48:38 INFO - 2015-12-17 13:48:38,897 DEBUG : using testdate: 1450388918 13:48:38 INFO - 2015-12-17 13:48:38,897 DEBUG : actual date: 1450388918 13:48:38 INFO - 2015-12-17 13:48:38,911 INFO : starting webserver on 'localhost:58086' 13:48:38 INFO - 2015-12-17 13:48:38,912 INFO : Starting test suite talos-linux64-ix-054.e 13:48:38 INFO - 2015-12-17 13:48:38,912 INFO : Starting test dromaeo_css 13:48:38 INFO - 2015-12-17 13:48:38,912 DEBUG : operating with platform_type : linux_ 13:48:38 INFO - 2015-12-17 13:48:38,913 INFO : Initialising browser for dromaeo_css test... 13:48:38 INFO - 2015-12-17 13:48:38,924 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6fl0pj/profile http://localhost:58086/getInfo.html 13:48:43 INFO - 2015-12-17 13:48:43,950 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:48:43 INFO - 2015-12-17 13:48:43,950 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:48:43 INFO - 2015-12-17 13:48:43,950 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:48:43 INFO - 2015-12-17 13:48:43,950 DEBUG : BROWSER_OUTPUT: __metrics 13:48:44 INFO - 2015-12-17 13:48:44,067 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] 13:48:45 INFO - 2015-12-17 13:48:45,049 INFO : Browser initialized. 13:48:45 INFO - 2015-12-17 13:48:45,050 INFO : Running cycle 1/1 for dromaeo_css test... 13:48:45 INFO - 2015-12-17 13:48:45,050 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6fl0pj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:48:56 INFO - 2015-12-17 13:48:56,865 DEBUG : BROWSER_OUTPUT: RSS: Main: 150773760 13:48:56 INFO - 2015-12-17 13:48:56,866 DEBUG : BROWSER_OUTPUT: 13:49:46 INFO - 2015-12-17 13:49:46,446 DEBUG : BROWSER_OUTPUT: 1450388986443 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] 13:51:55 INFO - 2015-12-17 13:51:55,116 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58086/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58086/tests/dromaeo/cssquery-ext.html) 13:51:56 INFO - 2015-12-17 13:51:56,364 DEBUG : BROWSER_OUTPUT: RSS: Main: 158830592 13:51:56 INFO - 2015-12-17 13:51:56,364 DEBUG : BROWSER_OUTPUT: 13:54:58 INFO - 2015-12-17 13:54:58,390 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58086/tests/dromaeo/cssquery-ext.html (next: http://localhost:58086/tests/dromaeo/cssquery-jquery.html) 13:54:58 INFO - 2015-12-17 13:54:58,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 155439104 13:54:58 INFO - 2015-12-17 13:54:58,973 DEBUG : BROWSER_OUTPUT: 13:58:00 INFO - 2015-12-17 13:58:00,700 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58086/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58086/tests/dromaeo/cssquery-mootools.html) 13:58:01 INFO - 2015-12-17 13:58:01,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 155267072 13:58:01 INFO - 2015-12-17 13:58:01,286 DEBUG : BROWSER_OUTPUT: 14:01:02 INFO - 2015-12-17 14:01:02,902 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58086/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58086/tests/dromaeo/cssquery-prototype.html) 14:01:03 INFO - 2015-12-17 14:01:03,508 DEBUG : BROWSER_OUTPUT: RSS: Main: 152002560 14:01:03 INFO - 2015-12-17 14:01:03,508 DEBUG : BROWSER_OUTPUT: 14:04:05 INFO - 2015-12-17 14:04:05,800 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58086/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58086/tests/dromaeo/cssquery-yui.html) 14:04:06 INFO - 2015-12-17 14:04:06,387 DEBUG : BROWSER_OUTPUT: RSS: Main: 151855104 14:04:06 INFO - 2015-12-17 14:04:06,387 DEBUG : BROWSER_OUTPUT: 14:07:08 INFO - 2015-12-17 14:07:08,810 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58086/tests/dromaeo/cssquery-yui.html (next: http://localhost:58086/tests/dromaeo/cssquery-dojo.html) 14:07:09 INFO - 2015-12-17 14:07:09,061 DEBUG : BROWSER_OUTPUT: RSS: Main: 155607040 14:07:09 INFO - 2015-12-17 14:07:09,061 DEBUG : BROWSER_OUTPUT: 14:07:09 INFO - 2015-12-17 14:07:09,063 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:07:09 INFO - 2015-12-17 14:07:09,063 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:07:09 INFO - 2015-12-17 14:07:09,063 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:07:09 INFO - 2015-12-17 14:07:09,063 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:07:09 INFO - 2015-12-17 14:07:09,064 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3174.3809957058374;3197.712205901467;3205.246767009754;3237.0612522368515;3242.043597138844;5175.146100893348;5269.789208431663;5329.413764485904;5335.306410166678;5375.113106337454;5302.098643230651;5303.893922121555;5311.1502159654465;5316.5215130638335;5353.491418315254;4885.462599114095;4976.950230497685;5027.673201241926;5050.393952725678;5069.087564238435;5047.848564543069;5053.5451809337155;5060.4686507916695;5096.159133742928;5103.081445339856;4775.641826863;4814.951850481485;4865.24588688752;4945.184044632631;4947.678400903929;4937.728424936627;4956.107900577895;4963.280324352949;4973.950260497385;5015.498450154992;4728.40894888139;4920.188168952154;4923.655344125913;4944.184209605447;4952.182889823211;5156.9742151289;5198.636095473318;5205.6616319939085;5205.765740541685;5245.160774276135;5800.332961709415;5886.117082437669;5887.528997680175;5893.970530147365;5922.733476993546;5684.516816070639;5799.159121927339;5879.8530036749;5887.35239123696;5945.4946329562035;5387;5442.700651464207;5445.9727701361635;5457.972710136424;5473.370562385337;5892.970535147382;5954;5970.582059255898;5972.940270597239;5985.162077309094;5568.638038527482;5662.178984047372;5713.5714821388565;5771.0477771168125;5773.855653608609;5817.76728930838;5834.416558344132;5845.912311315334;5852.853678658068;5873.559483038789;5709.286339207599;5817.011108111631;5821.214136091573;5835.854103647358;5840.5035571976005;5595.972020139873;5685.602007859493;5701.059325211377;5710.229119068956;5775.8556036099435;4449.510553839075;4483.910321793546;4487.147441986012;4515.435570553681;4518.4126063612175;3986.863743832994;3993.0616305168264;3993.3211354069877;3993.560708322082;4034.415009823559;5350.0904846176245;5372.328458942632;5452.863678408072;5483.150111732688;5531.474509921551;5853.239078919798;5876.618019828783;5888.087346461305;5890.587658863924;5924.170616113747;5484.095124304445;5526.530244929146;5530.7511161997;5531.751071201806;5541.251930989345;4980.501949805063;5037.143685573461;5045.5459008689395;5062.898742025139;5149.150390185578;5944.197533333031;5967.045272756425;5973.970130149409;5983.820485385359;5989.131575921554;5887.470127688529;5895.64626122434;5898.026825573732;5899.144624029577;5903.0555111182;5695.316562012585;5826.388229235869;5865.14955331466;5868.94131058684;5870.14882841994;5636.126400407943;5643.774249030157;5691.658500489983;5700.572457065819;5752.511036561939;5849.210356601804;5866.120081987736;5878.470937615635;5879.794207202727;5893.823185304448;5592.245046918614;5708.058170401837;5711.914321285101;5714;5722.027255366681;5651.717414129359;5723.685197314021;5736.684482353344;5747.827565173052;5769.048107062287;5533.197686335539;5556.222128901876;5580.358258800127;5588.077967135378;5608.355039170548;5609.775608975595;5614.101743720985;5637.182608521659;5677.829665110054;5730.5129064030025;5560.610757246954;5612.494875461228;5619.915701264403;5652.123920792284;5664.376918538875 14:07:09 INFO - 2015-12-17 14:07:09,066 DEBUG : BROWSER_OUTPUT: |1;ext.html;567.8268128220892;570.8810730967303;572.6764378126359;573.5870173475097;590.0794760174126;37238;37819.05452363692;37933;38017.61982380172;38195.427068593955;42812.78593607035;43307.35038974418;43321.783391083;43350.56649433513;43441.56558434415;8669.783255418617;8813.250873675745;8825.867611985825;8833.11668833118;8857.42426742263;8631.611577478998;8679.435836670596;8729.869051964226;8766.824663506726;8810.339224558153;8665.95667021664;8694.695685651004;8750.956245218797;8773.64905403783;8805.867911981326;8760.299176065899;8774.868376974351;8847.513386763725;8864.867026994569;8869;8634.956825215897;8709.95645021777;8744.475331480067;8758.386912916098;8775.078616745213;39434;39723.20553588912;39798;39919;40076.799616001736;3280.3439312137666;3466.116140384211;3554.5201397811225;3582.8566857325936;3776.244751049801;29874.551881721793;30300.848495757382;30364.54453183204;30470.84764576163;30571.541426878615;3887.747296425723;4052;4060.187962407501;4070.1656160487323;4213.789310534461;250503;251138;251234;251235;251528;51784.22323665148;51839.48160518422;58481.70759146177;58498;58625.70687146537;53232;53263;53383.73308133434;53449.46550534523;53467;13899.79150312746;14115.364808583638;14141.43434262618;14147.717045659028;14204.076735012191;10372;10589.09992650618;10636.946815265874;10745.462726863625;10770.461476926122;19192.726546108614;19660.70508942367;19897;19928.800711992986;19932;7669.309762121436;7834.8433031339055;7951.960240198878;7988.201179881965;8049.154838741965;928.9442633442015;941.8398872191743;978.9363691360039;983.2674657380154;1134.9886501135047;28542.571861422097;28671.71328286732;29199.270018249288;29326.560101598494;29498.705012949595;993.0714781679153;1016.1565900302732;1060.8196606576746;1072.7586293083993;1127.9605213817476;14511;14546.127232366092;14650.487232947009;14812.185329806964;14850.554483365517;321501;325644;326993;327022;327152;50484;50552;50641.74679126581;50748;51000;1329.308759445083;1352.0197856554116;1363.4478036395276;1367.6785955300297;1372.9519466818813;27259.454810904066;28342;28467.857660711565;29271;30017.849910750305;42471.3629295567;42615.7869210652;42888;42996.57003429926;43124.56875431331;252487;252749;254310;255028;255099;30573.55411567025;32078.19804504906;32264.67735322617;32686.83656581702;32695.673043269264;38963.220735585695;43112.78443607762;43363.78318108389;43926;43970;32965.34069318648;33039.83480082584;33236.335273294884;33285;33617.495737564444;33439.66560334365;33479.33041339208;33793.83103084469;33808.49287260742;35510.46734298936;32090.518642220854;32484;32635.673643263264;32777.34445311033;32789.83605081959;29144.7085529142;29777.5533367004;30082.247943800703;30172.849135754182;30188.24529386783;24153.75846241515;24290.635640465054;24538.754612454362;24558.386040349134;24628.507429850943 14:07:09 INFO - 2015-12-17 14:07:09,067 DEBUG : BROWSER_OUTPUT: |2;jquery.html;354.2542947096362;359.0986623574826;362.06948143271796;362.0730928822217;364.9087728067982;16288.755668664964;16877.66244675106;17631.64736705267;17836;18462.815371846278;9755.756106097351;9933.701988940325;14644.121352718845;14650.560483185494;14663.926680366583;4720.929186062212;4845.612351011928;5039.924401133986;5221.451747566508;5233.712145831978;5083.18669012958;5129.25625784263;5133.589312854962;5141.974290128544;5433.972830135844;5903.144044113601;5989.43100405463;6183.474404675608;6373.617582945015;6387.872242555146;6254.155688981998;6405.35946405358;6423.357664233586;6686.197656281277;6704.5306828522025;6405.19935008124;6405.903911441332;6452.257990331078;6458.515611329169;6466.224053113609;21743.67384489234;22624.660630090562;23145.421364465856;23205.88397058004;23208.3037508875;2276.9544609107893;2298.138198175684;2305.262316058862;2322.431004403915;2429.9028038878423;14273.71452570953;14300.499482518166;14704.33830477631;14907.776383354258;14933.626659333495;1772.0962309222261;1795.2370242646953;1880.0129931785784;1957.4616980330381;1972.4871533401276;62577.37422625806;65700.02235302902;70096.64951675209;71673.28326716718;72231.63884180546;14985.850141498446;14988.925055374872;15142.621434464007;15148;15181.696366072838;24185.51628967411;24273.150439734523;24431.87784061104;24455.266342009767;24459.51080978406;8282.503049816909;8336.583170841433;8426.662933482592;8455.873161902577;8486.660533578712;7041.507094503438;7042.225355210922;7050.0129981801565;7073.469489788286;7086.822829429202;7628.580428076398;7628.618569071524;7721.343685786771;7759.57322347265;7786.1824508426935;1810.4478134169206;1842.8065053169491;2839.7444230019396;2914.737673609385;2925.1078421081775;829.8921140251729;843.236870632079;859.621766422772;982.1700662939804;1015.28422462164;15503.922480387526;16563.254653540618;16755.2460139294;17511.912440437718;18411.355602554115;890.8040231149137;891.4473026723473;893.3523195683077;911.3893691226893;1013.964511242103;9590.616375345047;9742.61029558824;10183.388996660076;10322.22583306255;10409.739756506147;377068;381180;382060;385827;495782;76991;80128.59935700284;83680;84019;84274;1133.240728711765;1149.1094401838475;1151.861776586815;1171.2913687219109;1178.0987544528443;15764.921175394049;16007;16060.518184454486;16069.517914462585;16092.436764713178;34549.65450345464;34930;36072;36373.09067273339;36788;45185.77407112943;45418.77290613526;45976;46065.53934460613;46172.76913615411;9048.909510904807;9450.669226577036;9657.9034209657;9690.273229507675;9825.213982881209;8972.955135224543;11422.885771142182;11488.712782180512;11737.47181376823;15235.3905843765;13814.585562433143;14674.55976320712;14802.703945921237;14967.476138335105;15013.624659383166;13928.885689145047;13977.650558736113;14051.718965620426;14445;14507.1295722257;14542.345594448063;14692.485762998243;14776.039557428732;14917.254137293308;15019.09885406879;9144.725658230263;9312.394694344846;9517.048295170705;9540.809183816424;9573.09055639741;9430.57562409707;11049.723756906142;14142.434302628191;14402.135871847722;14439.78340324917 14:07:09 INFO - 2015-12-17 14:07:09,067 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1418.631155899466;1467.1343907094813;1592.8566429021394;1616.814066382365;1742.3640371264491;6620.668966551665;6743.561668491557;7265.41876649868;7557.735479258227;7593.77218683439;7052.894206586905;7338.743143989961;7355.632218389086;7382.335589796917;7384.556926584409;2160.481484443734;2198.8900554972265;2203.3389983005113;2205.4155648753012;2216.1357070742424;2160.2547121243147;2197.8241740660787;2200.2629119244993;2200.7579166291694;2209.304069218199;2162.740471143465;2165.123125134315;2186.8250539956844;2211.2039665720326;2217.623004089309;2162.718846549946;2193.2762188477764;2196.9560608787733;2197.0333053456507;2201.7908298711595;2130.2544109561686;2179.564087182554;2179.9891000544894;2183.148572056899;2190.671399290103;7320.487565870391;7398.963005184994;7404.518706284074;7424.480286379956;7444.664990075459;4513.7743112844555;4534.86395408135;4539.704919180276;4559.635229181657;4559.77201139945;3038.5745995560637;3083.1983684242036;3097.132802815193;3148.449021421265;3161.462551366273;1021.7905329407454;1038.9948050259775;1054.4200689620754;1063.0645032371463;1084.6366467233486;10044.89955100447;10049.397036177852;10083.142932850717;10102.494875256209;10105.696829095212;4088.9182216355507;4098.549159592442;4105.035316700573;4148.79256037197;4173.08192197716;8678.088800675965;8702.39083264178;8714.956425217833;8716.912830871737;8720.215180633773;4525.162844873643;4576.4508259009135;4586.380838586748;4586.403767510269;4597.563231493003;3925.5878132796215;3977.940330895039;4003.4395184674167;4155.542890282067;4202.873913782591;3399.8300084995653;3408.386490431746;3415.4364529852296;3424.8630054797527;3435.9312813743586;1017.1201910347644;1027.7276521721749;1029.5264178477835;1031.7523794289466;1040.6565833275151;1201.3512703140382;1234.4074844074894;1240.076143273249;1250.2123662092824;1257.3838818978634;6956.513044086966;7102.573845569283;7145.749898753519;7184.209736928934;7318.817029574197;1107.44074242507;1110.9944450277696;1120.3613940054254;1124.9943750281195;1128.5203788389902;5676.233708449389;5687.43125687428;5696.629719068247;5710.2862142232225;5747.712614369265;8694.565271736388;8756.56217189138;8854.24738897188;8856.601452934634;9043.909560904307;8691.304695624334;8802.559872006374;8818.779530511789;8832.470051796912;8841.955790221007;6982.685779139951;7010.684519196547;7105.182903966007;7107.928920710727;7131.144262688407;6845.760398386033;6885.965570172117;6888.138982627172;6889.414399776075;6901.206361268519;7789.805254868447;7932.0878099017045;8028.43800933929;8065.596720163851;8089.312408445113;7961.880571791312;8210.835783284181;8271.54506502148;8305.543195124326;8358.832823343377;5540.556755459473;5761.337446193574;6157;6170.259568851767;6233.376662333731;7085.114360704912;7091.893621595784;7099.183593886562;7125.251848555827;7125.5368401053765;6571.411585184591;6708.597484150967;6756.290589488033;6778.0510728497065;6893.20728116273;6655.534112612071;6707.429868461236;6734.6295953721055;6796.150481189851;6828.590284582742;6496.317886621837;6522.673866306761;6584.901226481702;6586.407223349922;6605.5376123670885;6145.170401995673;6235.438810507076;6299.338569450325;6300.527460440577;6304.05439184126;6232.8130156095385;6263.6241825490615;6275.74897004133;6276.058591211355;6286.591371560834 14:07:09 INFO - 2015-12-17 14:07:09,068 DEBUG : BROWSER_OUTPUT: |4;prototype.html;331.24806688816386;331.8373996741597;338.8796977073139;339.45009085281833;347.1806536573686;6248.718807653655;6287.15123458333;6335.619862808235;6352.523560732946;6371.840703982402;6233.719482623282;6293.370662933704;6301.716422760976;6329;6353.459955903742;4744.8102075917095;4745.738984355859;4746.620270378378;4749.838823335383;4754.9762251188695;4747.738874361926;4749.240121580548;4753.073150735608;4759.809607615691;4765.571098601125;4632.953670463303;4652.8138874444985;4703.270992996091;4717.834875779348;4717.882052948687;4658.930116048262;4666.043461090469;4715.174844402233;4718.442913838425;4722.409698787652;4058.431819545266;4061.715679902408;4062.045419326456;4064.4919385076864;4074.9388759168637;5975.581709280352;5986.161937328778;5999.370066143036;6003.909941350883;6012.78955236569;5367.329083864517;5455.536279416255;5463.9180412293845;5468.699221542814;5485.945140548583;6649.60102393858;6650.7339706411685;6659.300773418819;6664.8000559983275;6674;4444.755538445384;4465.843695470643;4479.3057076153245;4491.842785502492;4495.1009798040195;6785.084013658142;6889.448844092461;6891.310868913119;6921.4808889333;6931;4626.953730462719;4627.5603817637275;4639.211334073216;4657.580817726421;4666.766661666903;4689.906201876011;4697.95302046982;4700.647451441156;4701.130290896127;4713.29300604912;5484;5494.780208791603;5505.201745746925;5505.366882808528;5508.889822203533;6613.14029176204;6703.631300278434;6721.4958878084335;6723.058771771955;6745.08941292929;1618.5629879932353;1646.7694522766822;1650.1996531682125;1650.3563610192034;1650.801903771555;1076.531708706715;1077.7575045614674;1079.1097344690504;1087.5160553553592;1089.0470838016736;6352.460040896483;6374.713137908805;6375.947968585224;6378.011408231639;6394.072859435356;6816.659167041628;6821.147356580427;6826.829329266808;6833.658317084225;6876.449884009267;6246.812595622138;6335.904961425582;6370.299267080617;6378.968105159444;6384.265809431882;3689.6494832990825;3720.6837418819164;3732.79469629173;3739.1960728442973;3743.1952130291575;6939.23668396476;6962.651867406609;6974.442044636518;6982.1970473395195;6983.2318444971015;6958.165020197507;7003.54476958996;7009.9649501752165;7013.754518591825;7020.964895175492;7169.426445884316;7181.784546463615;7183.748568800067;7184.676689548983;7186.281371862772;7027.086478757728;7031.894521582282;7037.612931288828;7040.436765058681;7043.6830342633675;6807.3873351398615;6953.06133671968;6963.79108626742;6967;6970.477214209056;7029.753958611424;7045.542039767399;7069.39910107626;7079.787606371817;7105.50261481712;4534.070515544239;4572.6799124061;4576.222042252892;4593.150267200579;4593.6554758392585;6867;7023.754168604074;7039.612821294878;7039.683214255473;7062.4703147263135;6798.082258895183;6823.044773731781;6823.727050917908;6836.692348844214;6840.042394064934;6774.085498457645;6805.081314022544;6808.863822723617;6812.182538095461;6813.1142951415995;6529.902051469327;6633.469322454289;6667.066610674607;6673.265940746611;6676.232233293039;6832.145981752281;6835.863282734417;6838.247792742894;6845.452363810784;6845.520813543203;6590.505712071518;6642.335766423319;6650.767223147167;6656.267810540739;6687.531872769054 14:07:09 INFO - 2015-12-17 14:07:09,070 DEBUG : BROWSER_OUTPUT: |5;yui.html;734.7905846833653;738.9261073892608;798.5568009754587;820.6635279535392;906.2976193450075;12937.547185848498;13160.210387376765;13211.93394033031;13248.536301229458;13313.866861331384;12318.692032699164;13052.804207936864;13235.735285294288;14270.571882843506;14271.429142834275;817.6157206113132;831.3556993330187;832.1096426823271;832.4880198677799;834.1950018232404;815.2703330519182;817.0767033252446;820.4379999700225;821.5112008355019;825.4015838517057;864.2783275964578;869.9347548933823;872.3065163195243;874.0429229993148;875.5972252763736;862.2584577263548;867.7136544940217;871.7166920750718;872.402404353017;874.1346067393298;636.3413866647998;639.3095456906576;639.9616023038633;640.2093414632925;642.4507046475289;12961.416736246798;13166.473341066347;13291.268980206085;13325;13383.263920484369;11824.881751182464;12247.938760306231;12590.874091259153;12615.180013299107;12691.619251422471;10407.271490995634;10448.895511044944;10579.84130238047;10816.242862999594;10827.566897324097;3652.543432070991;3701.222743223926;3719.1260053887313;3821.8853434396733;3857.4599556062176;44364.55635443669;47026.294605580944;47269.52730472686;47484.28773568399;47619.285710714365;8825.470471771714;8898.510581918057;8913.598888050054;9093.636254549743;9095.408798428214;17210.741838872425;17217.311307547807;17254.654906901793;17555.824441755674;17794.199261033285;7499.850003000019;7692.461527693008;7724.806879827936;7737.148913619498;7751.069871615329;4318.740875547477;4366.497852746975;4419.027813880941;4451.310046942729;4512.3908272382805;3072.969270307313;3089.1813669377634;3099.0392978176837;3102.9844850775603;3104.425681248976;526.9815556455505;548.2790130977752;550.1335396750135;563.808305176242;566.3260719743492;635.8315046512678;672.7578071894114;680.8910574308087;687.2131409536054;728.7522242437491;8754.343424243207;8783.253423459077;8826.382153249338;8874.689385871463;8925.464472131693;659.6998365743575;664.4850241063215;677.4952660268132;679.4123083532709;687.9793606191822;4054.878353649395;4128.174365126986;4242.193983143193;4244.363345498138;4271.231178387858;61119;61125;61143.38856611377;61680;62357.68821155865;49158;49807.25289120666;52196.47803521916;52859.471405285454;53696.731516342166;46805;47812.28281575779;51648.741756290976;51933.740331298104;52726.73636631869;8877.644894204159;9018.188363047357;9261.907380926104;9355.502108822013;9375;35081.824590877906;35433.64566354304;36136.27727445489;36550.8172459136;37862.24275514529;45515.31727024031;45542.31686524639;46018.53981460143;46096;46445;11277.830832537355;11393.6998490507;12053.011253143133;12090.576829810914;12156.75686486283;12453.564125255572;12790.872091278969;12845.550405735754;13109.344532773513;13116.672083197996;11519.25124866881;11874.584389546324;12027.63917082454;12273.079519036286;12296.385180740748;11607.535698571963;11947.94026029899;12182.451789669663;12228.510859565518;12253.938730306292;11101.333919964827;11230.382328971986;11387.658370248906;11548.480318385526;11611.205526013111;9858.457784821903;9879.555420005972;9891.802163956825;10033.648822291185;10264.897351026395;9151.267898567965;9205.907940920504;9222.44665320083;9419.764505887408;10312.226583006455 14:07:09 INFO - 2015-12-17 14:07:09,070 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:07:09 INFO - 2015-12-17 14:07:09,070 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:07:09 INFO - 2015-12-17 14:07:09,070 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,309 14:07:09 INFO - 2015-12-17 14:07:09,070 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:07:09 INFO - 2015-12-17 14:07:09,070 DEBUG : BROWSER_OUTPUT: __startTimestamp1450390029062__endTimestamp 14:07:09 INFO - 2015-12-17 14:07:09,070 DEBUG : BROWSER_OUTPUT: 14:07:09 INFO - 2015-12-17 14:07:09,070 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:07:09 INFO - 2015-12-17 14:07:09,071 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:07:09 INFO - 2015-12-17 14:07:09,071 DEBUG : BROWSER_OUTPUT: 14:07:09 INFO - 2015-12-17 14:07:09,071 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5390.91 Median:5595.97 stddev:597.88 (10.7%) stddev-sans-first:573.87 14:07:09 INFO - 2015-12-17 14:07:09,071 DEBUG : BROWSER_OUTPUT: Values: 3174.4 3197.7 3205.2 3237.1 3242.0 5175.1 5269.8 5329.4 5335.3 5375.1 5302.1 5303.9 5311.2 5316.5 5353.5 4885.5 4977.0 5027.7 5050.4 5069.1 5047.8 5053.5 5060.5 5096.2 5103.1 4775.6 4815.0 4865.2 4945.2 4947.7 4937.7 4956.1 4963.3 4974.0 5015.5 4728.4 4920.2 4923.7 4944.2 4952.2 5157.0 5198.6 5205.7 5205.8 5245.2 5800.3 5886.1 5887.5 5894.0 5922.7 5684.5 5799.2 5879.9 5887.4 5945.5 5387.0 5442.7 5446.0 5458.0 5473.4 5893.0 5954.0 5970.6 5972.9 5985.2 5568.6 5662.2 5713.6 5771.0 5773.9 5817.8 5834.4 5845.9 5852.9 5873.6 5709.3 5817.0 5821.2 5835.9 5840.5 5596.0 5685.6 5701.1 5710.2 5775.9 4449.5 4483.9 4487.1 4515.4 4518.4 3986.9 3993.1 3993.3 3993.6 4034.4 5350.1 5372.3 5452.9 5483.2 5531.5 5853.2 5876.6 5888.1 5890.6 5924.2 5484.1 5526.5 5530.8 5531.8 5541.3 4980.5 5037.1 5045.5 5062.9 5149.2 5944.2 5967.0 5974.0 5983.8 5989.1 5887.5 5895.6 5898.0 5899.1 5903.1 5695.3 5826.4 5865.1 5868.9 5870.1 5636.1 5643.8 5691.7 5700.6 5752.5 5849.2 5866.1 5878.5 5879.8 5893.8 5592.2 5708.1 5711.9 5714.0 5722.0 5651.7 5723.7 5736.7 5747.8 5769.0 5533.2 5556.2 5580.4 5588.1 5608.4 5609.8 5614.1 5637.2 5677.8 5730.5 5560.6 5612.5 5619.9 5652.1 5664.4 14:07:09 INFO - 2015-12-17 14:07:09,071 DEBUG : BROWSER_OUTPUT: 14:07:09 INFO - 2015-12-17 14:07:09,071 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44265.83 Median:19488.29 stddev:72846.95 (373.8%) stddev-sans-first:72977.41 14:07:09 INFO - 2015-12-17 14:07:09,071 DEBUG : BROWSER_OUTPUT: Values: 567.8 570.9 572.7 573.6 590.1 37238.0 37819.1 37933.0 38017.6 38195.4 42812.8 43307.4 43321.8 43350.6 43441.6 8669.8 8813.3 8825.9 8833.1 8857.4 8631.6 8679.4 8729.9 8766.8 8810.3 8666.0 8694.7 8751.0 8773.6 8805.9 8760.3 8774.9 8847.5 8864.9 8869.0 8635.0 8710.0 8744.5 8758.4 8775.1 39434.0 39723.2 39798.0 39919.0 40076.8 3280.3 3466.1 3554.5 3582.9 3776.2 29874.6 30300.8 30364.5 30470.8 30571.5 3887.7 4052.0 4060.2 4070.2 4213.8 250503.0 251138.0 251234.0 251235.0 251528.0 51784.2 51839.5 58481.7 58498.0 58625.7 53232.0 53263.0 53383.7 53449.5 53467.0 13899.8 14115.4 14141.4 14147.7 14204.1 10372.0 10589.1 10636.9 10745.5 10770.5 19192.7 19660.7 19897.0 19928.8 19932.0 7669.3 7834.8 7952.0 7988.2 8049.2 928.9 941.8 978.9 983.3 1135.0 28542.6 28671.7 29199.3 29326.6 29498.7 993.1 1016.2 1060.8 1072.8 1128.0 14511.0 14546.1 14650.5 14812.2 14850.6 321501.0 325644.0 326993.0 327022.0 327152.0 50484.0 50552.0 50641.7 50748.0 51000.0 1329.3 1352.0 1363.4 1367.7 1373.0 27259.5 28342.0 28467.9 29271.0 30017.8 42471.4 42615.8 42888.0 42996.6 43124.6 252487.0 252749.0 254310.0 255028.0 255099.0 30573.6 32078.2 32264.7 32686.8 32695.7 38963.2 43112.8 43363.8 43926.0 43970.0 32965.3 33039.8 33236.3 33285.0 33617.5 33439.7 33479.3 33793.8 33808.5 35510.5 32090.5 32484.0 32635.7 32777.3 32789.8 29144.7 29777.6 30082.2 30172.8 30188.2 24153.8 24290.6 24538.8 24558.4 24628.5 14:07:09 INFO - 2015-12-17 14:07:09,072 DEBUG : BROWSER_OUTPUT: 14:07:09 INFO - 2015-12-17 14:07:09,072 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25991.21 Median:18217.03 stddev:66903.54 (367.3%) stddev-sans-first:67063.53 14:07:09 INFO - 2015-12-17 14:07:09,073 DEBUG : BROWSER_OUTPUT: Values: 354.3 359.1 362.1 362.1 364.9 16288.8 16877.7 17631.6 17836.0 18462.8 9755.8 9933.7 14644.1 14650.6 14663.9 4720.9 4845.6 5039.9 5221.5 5233.7 5083.2 5129.3 5133.6 5142.0 5434.0 5903.1 5989.4 6183.5 6373.6 6387.9 6254.2 6405.4 6423.4 6686.2 6704.5 6405.2 6405.9 6452.3 6458.5 6466.2 21743.7 22624.7 23145.4 23205.9 23208.3 2277.0 2298.1 2305.3 2322.4 2429.9 14273.7 14300.5 14704.3 14907.8 14933.6 1772.1 1795.2 1880.0 1957.5 1972.5 62577.4 65700.0 70096.6 71673.3 72231.6 14985.9 14988.9 15142.6 15148.0 15181.7 24185.5 24273.2 24431.9 24455.3 24459.5 8282.5 8336.6 8426.7 8455.9 8486.7 7041.5 7042.2 7050.0 7073.5 7086.8 7628.6 7628.6 7721.3 7759.6 7786.2 1810.4 1842.8 2839.7 2914.7 2925.1 829.9 843.2 859.6 982.2 1015.3 15503.9 16563.3 16755.2 17511.9 18411.4 890.8 891.4 893.4 911.4 1014.0 9590.6 9742.6 10183.4 10322.2 10409.7 377068.0 381180.0 382060.0 385827.0 495782.0 76991.0 80128.6 83680.0 84019.0 84274.0 1133.2 1149.1 1151.9 1171.3 1178.1 15764.9 16007.0 16060.5 16069.5 16092.4 34549.7 34930.0 36072.0 36373.1 36788.0 45185.8 45418.8 45976.0 46065.5 46172.8 9048.9 9450.7 9657.9 9690.3 9825.2 8973.0 11422.9 11488.7 11737.5 15235.4 13814.6 14674.6 14802.7 14967.5 15013.6 13928.9 13977.7 14051.7 14445.0 14507.1 14542.3 14692.5 14776.0 14917.3 15019.1 9144.7 9312.4 9517.0 9540.8 9573.1 9430.6 11049.7 14142.4 14402.1 14439.8 14:07:09 INFO - 2015-12-17 14:07:09,073 DEBUG : BROWSER_OUTPUT: 14:07:09 INFO - 2015-12-17 14:07:09,074 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5213.50 Median:5754.53 stddev:2655.24 (46.1%) stddev-sans-first:2647.37 14:07:09 INFO - 2015-12-17 14:07:09,074 DEBUG : BROWSER_OUTPUT: Values: 1418.6 1467.1 1592.9 1616.8 1742.4 6620.7 6743.6 7265.4 7557.7 7593.8 7052.9 7338.7 7355.6 7382.3 7384.6 2160.5 2198.9 2203.3 2205.4 2216.1 2160.3 2197.8 2200.3 2200.8 2209.3 2162.7 2165.1 2186.8 2211.2 2217.6 2162.7 2193.3 2197.0 2197.0 2201.8 2130.3 2179.6 2180.0 2183.1 2190.7 7320.5 7399.0 7404.5 7424.5 7444.7 4513.8 4534.9 4539.7 4559.6 4559.8 3038.6 3083.2 3097.1 3148.4 3161.5 1021.8 1039.0 1054.4 1063.1 1084.6 10044.9 10049.4 10083.1 10102.5 10105.7 4088.9 4098.5 4105.0 4148.8 4173.1 8678.1 8702.4 8715.0 8716.9 8720.2 4525.2 4576.5 4586.4 4586.4 4597.6 3925.6 3977.9 4003.4 4155.5 4202.9 3399.8 3408.4 3415.4 3424.9 3435.9 1017.1 1027.7 1029.5 1031.8 1040.7 1201.4 1234.4 1240.1 1250.2 1257.4 6956.5 7102.6 7145.7 7184.2 7318.8 1107.4 1111.0 1120.4 1125.0 1128.5 5676.2 5687.4 5696.6 5710.3 5747.7 8694.6 8756.6 8854.2 8856.6 9043.9 8691.3 8802.6 8818.8 8832.5 8842.0 6982.7 7010.7 7105.2 7107.9 7131.1 6845.8 6886.0 6888.1 6889.4 6901.2 7789.8 7932.1 8028.4 8065.6 8089.3 7961.9 8210.8 8271.5 8305.5 8358.8 5540.6 5761.3 6157.0 6170.3 6233.4 7085.1 7091.9 7099.2 7125.3 7125.5 6571.4 6708.6 6756.3 6778.1 6893.2 6655.5 6707.4 6734.6 6796.2 6828.6 6496.3 6522.7 6584.9 6586.4 6605.5 6145.2 6235.4 6299.3 6300.5 6304.1 6232.8 6263.6 6275.7 6276.1 6286.6 14:07:09 INFO - 2015-12-17 14:07:09,075 DEBUG : BROWSER_OUTPUT: 14:07:09 INFO - 2015-12-17 14:07:09,075 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5567.59 Median:6352.99 stddev:1717.25 (27.0%) stddev-sans-first:1676.49 14:07:09 INFO - 2015-12-17 14:07:09,076 DEBUG : BROWSER_OUTPUT: Values: 331.2 331.8 338.9 339.5 347.2 6248.7 6287.2 6335.6 6352.5 6371.8 6233.7 6293.4 6301.7 6329.0 6353.5 4744.8 4745.7 4746.6 4749.8 4755.0 4747.7 4749.2 4753.1 4759.8 4765.6 4633.0 4652.8 4703.3 4717.8 4717.9 4658.9 4666.0 4715.2 4718.4 4722.4 4058.4 4061.7 4062.0 4064.5 4074.9 5975.6 5986.2 5999.4 6003.9 6012.8 5367.3 5455.5 5463.9 5468.7 5485.9 6649.6 6650.7 6659.3 6664.8 6674.0 4444.8 4465.8 4479.3 4491.8 4495.1 6785.1 6889.4 6891.3 6921.5 6931.0 4627.0 4627.6 4639.2 4657.6 4666.8 4689.9 4698.0 4700.6 4701.1 4713.3 5484.0 5494.8 5505.2 5505.4 5508.9 6613.1 6703.6 6721.5 6723.1 6745.1 1618.6 1646.8 1650.2 1650.4 1650.8 1076.5 1077.8 1079.1 1087.5 1089.0 6352.5 6374.7 6375.9 6378.0 6394.1 6816.7 6821.1 6826.8 6833.7 6876.4 6246.8 6335.9 6370.3 6379.0 6384.3 3689.6 3720.7 3732.8 3739.2 3743.2 6939.2 6962.7 6974.4 6982.2 6983.2 6958.2 7003.5 7010.0 7013.8 7021.0 7169.4 7181.8 7183.7 7184.7 7186.3 7027.1 7031.9 7037.6 7040.4 7043.7 6807.4 6953.1 6963.8 6967.0 6970.5 7029.8 7045.5 7069.4 7079.8 7105.5 4534.1 4572.7 4576.2 4593.2 4593.7 6867.0 7023.8 7039.6 7039.7 7062.5 6798.1 6823.0 6823.7 6836.7 6840.0 6774.1 6805.1 6808.9 6812.2 6813.1 6529.9 6633.5 6667.1 6673.3 6676.2 6832.1 6835.9 6838.2 6845.5 6845.5 6590.5 6642.3 6650.8 6656.3 6687.5 14:07:09 INFO - 2015-12-17 14:07:09,077 DEBUG : BROWSER_OUTPUT: 14:07:09 INFO - 2015-12-17 14:07:09,077 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14130.88 Median:47147.91 stddev:16514.96 (35.0%) stddev-sans-first:16530.65 14:07:09 INFO - 2015-12-17 14:07:09,078 DEBUG : BROWSER_OUTPUT: Values: 734.8 738.9 798.6 820.7 906.3 12937.5 13160.2 13211.9 13248.5 13313.9 12318.7 13052.8 13235.7 14270.6 14271.4 817.6 831.4 832.1 832.5 834.2 815.3 817.1 820.4 821.5 825.4 864.3 869.9 872.3 874.0 875.6 862.3 867.7 871.7 872.4 874.1 636.3 639.3 640.0 640.2 642.5 12961.4 13166.5 13291.3 13325.0 13383.3 11824.9 12247.9 12590.9 12615.2 12691.6 10407.3 10448.9 10579.8 10816.2 10827.6 3652.5 3701.2 3719.1 3821.9 3857.5 44364.6 47026.3 47269.5 47484.3 47619.3 8825.5 8898.5 8913.6 9093.6 9095.4 17210.7 17217.3 17254.7 17555.8 17794.2 7499.9 7692.5 7724.8 7737.1 7751.1 4318.7 4366.5 4419.0 4451.3 4512.4 3073.0 3089.2 3099.0 3103.0 3104.4 527.0 548.3 550.1 563.8 566.3 635.8 672.8 680.9 687.2 728.8 8754.3 8783.3 8826.4 8874.7 8925.5 659.7 664.5 677.5 679.4 688.0 4054.9 4128.2 4242.2 4244.4 4271.2 61119.0 61125.0 61143.4 61680.0 62357.7 49158.0 49807.3 52196.5 52859.5 53696.7 46805.0 47812.3 51648.7 51933.7 52726.7 8877.6 9018.2 9261.9 9355.5 9375.0 35081.8 35433.6 36136.3 36550.8 37862.2 45515.3 45542.3 46018.5 46096.0 46445.0 11277.8 11393.7 12053.0 12090.6 12156.8 12453.6 12790.9 12845.6 13109.3 13116.7 11519.3 11874.6 12027.6 12273.1 12296.4 11607.5 11947.9 12182.5 12228.5 12253.9 11101.3 11230.4 11387.7 11548.5 11611.2 9858.5 9879.6 9891.8 10033.6 10264.9 9151.3 9205.9 9222.4 9419.8 10312.2 14:07:09 INFO - 2015-12-17 14:07:09,078 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:07:09 INFO - 2015-12-17 14:07:09,078 DEBUG : BROWSER_OUTPUT: 14:07:09 INFO - 2015-12-17 14:07:09,757 INFO : Browser exited with error code: 0 14:07:09 INFO - 2015-12-17 14:07:09,779 INFO : Completed test dromaeo_css (00:18:30) 14:07:09 INFO - 2015-12-17 14:07:09,779 INFO : Starting test kraken 14:07:09 INFO - 2015-12-17 14:07:09,779 DEBUG : operating with platform_type : linux_ 14:07:09 INFO - 2015-12-17 14:07:09,779 INFO : Initialising browser for kraken test... 14:07:09 INFO - 2015-12-17 14:07:09,785 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHq2eLi/profile http://localhost:58086/getInfo.html 14:07:14 INFO - 2015-12-17 14:07:14,451 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:07:14 INFO - 2015-12-17 14:07:14,451 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:07:14 INFO - 2015-12-17 14:07:14,451 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:07:14 INFO - 2015-12-17 14:07:14,452 DEBUG : BROWSER_OUTPUT: __metrics 14:07:14 INFO - 2015-12-17 14:07:14,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:07:15 INFO - 2015-12-17 14:07:15,397 INFO : Browser initialized. 14:07:15 INFO - 2015-12-17 14:07:15,398 INFO : Running cycle 1/1 for kraken test... 14:07:15 INFO - 2015-12-17 14:07:15,398 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHq2eLi/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:07:27 INFO - 2015-12-17 14:07:27,285 DEBUG : BROWSER_OUTPUT: RSS: Main: 151220224 14:07:27 INFO - 2015-12-17 14:07:27,285 DEBUG : BROWSER_OUTPUT: 14:07:29 INFO - 2015-12-17 14:07:29,766 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58086/tests/kraken/driver.html?testName=audio-beat-detection) 14:07:30 INFO - 2015-12-17 14:07:30,375 DEBUG : BROWSER_OUTPUT: RSS: Main: 153133056 14:07:30 INFO - 2015-12-17 14:07:30,375 DEBUG : BROWSER_OUTPUT: 14:07:33 INFO - 2015-12-17 14:07:33,053 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58086/tests/kraken/driver.html?testName=audio-dft) 14:07:33 INFO - 2015-12-17 14:07:33,646 DEBUG : BROWSER_OUTPUT: RSS: Main: 152895488 14:07:33 INFO - 2015-12-17 14:07:33,646 DEBUG : BROWSER_OUTPUT: 14:07:36 INFO - 2015-12-17 14:07:36,512 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58086/tests/kraken/driver.html?testName=audio-fft) 14:07:37 INFO - 2015-12-17 14:07:37,094 DEBUG : BROWSER_OUTPUT: RSS: Main: 147165184 14:07:37 INFO - 2015-12-17 14:07:37,094 DEBUG : BROWSER_OUTPUT: 14:07:39 INFO - 2015-12-17 14:07:39,215 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58086/tests/kraken/driver.html?testName=audio-oscillator) 14:07:39 INFO - 2015-12-17 14:07:39,801 DEBUG : BROWSER_OUTPUT: RSS: Main: 147263488 14:07:39 INFO - 2015-12-17 14:07:39,801 DEBUG : BROWSER_OUTPUT: 14:07:42 INFO - 2015-12-17 14:07:42,002 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58086/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:07:42 INFO - 2015-12-17 14:07:42,588 DEBUG : BROWSER_OUTPUT: RSS: Main: 146550784 14:07:42 INFO - 2015-12-17 14:07:42,589 DEBUG : BROWSER_OUTPUT: 14:07:45 INFO - 2015-12-17 14:07:45,526 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58086/tests/kraken/driver.html?testName=imaging-darkroom) 14:07:46 INFO - 2015-12-17 14:07:46,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 147226624 14:07:46 INFO - 2015-12-17 14:07:46,116 DEBUG : BROWSER_OUTPUT: 14:07:49 INFO - 2015-12-17 14:07:49,523 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58086/tests/kraken/driver.html?testName=imaging-desaturate) 14:07:50 INFO - 2015-12-17 14:07:50,112 DEBUG : BROWSER_OUTPUT: RSS: Main: 148578304 14:07:50 INFO - 2015-12-17 14:07:50,113 DEBUG : BROWSER_OUTPUT: 14:07:52 INFO - 2015-12-17 14:07:52,972 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58086/tests/kraken/driver.html?testName=json-parse-financial) 14:07:53 INFO - 2015-12-17 14:07:53,558 DEBUG : BROWSER_OUTPUT: RSS: Main: 148459520 14:07:53 INFO - 2015-12-17 14:07:53,558 DEBUG : BROWSER_OUTPUT: 14:07:55 INFO - 2015-12-17 14:07:55,137 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58086/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:07:55 INFO - 2015-12-17 14:07:55,718 DEBUG : BROWSER_OUTPUT: RSS: Main: 148197376 14:07:55 INFO - 2015-12-17 14:07:55,718 DEBUG : BROWSER_OUTPUT: 14:07:57 INFO - 2015-12-17 14:07:57,537 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58086/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:07:58 INFO - 2015-12-17 14:07:58,151 DEBUG : BROWSER_OUTPUT: RSS: Main: 148692992 14:07:58 INFO - 2015-12-17 14:07:58,152 DEBUG : BROWSER_OUTPUT: 14:08:00 INFO - 2015-12-17 14:08:00,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58086/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:08:00 INFO - 2015-12-17 14:08:00,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 148660224 14:08:00 INFO - 2015-12-17 14:08:00,828 DEBUG : BROWSER_OUTPUT: 14:08:03 INFO - 2015-12-17 14:08:03,284 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58086/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:08:03 INFO - 2015-12-17 14:08:03,878 DEBUG : BROWSER_OUTPUT: RSS: Main: 148922368 14:08:03 INFO - 2015-12-17 14:08:03,878 DEBUG : BROWSER_OUTPUT: 14:08:06 INFO - 2015-12-17 14:08:06,445 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58086/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:08:07 INFO - 2015-12-17 14:08:07,031 DEBUG : BROWSER_OUTPUT: RSS: Main: 148176896 14:08:07 INFO - 2015-12-17 14:08:07,031 DEBUG : BROWSER_OUTPUT: 14:08:08 INFO - 2015-12-17 14:08:08,740 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58086/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58086/tests/kraken/driver.html?testName=ai-astar) 14:08:08 INFO - 2015-12-17 14:08:08,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 149114880 14:08:08 INFO - 2015-12-17 14:08:08,990 DEBUG : BROWSER_OUTPUT: 14:08:08 INFO - 2015-12-17 14:08:08,990 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:08:08 INFO - 2015-12-17 14:08:08,990 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:08:08 INFO - 2015-12-17 14:08:08,991 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:08:08 INFO - 2015-12-17 14:08:08,991 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:08:08 INFO - 2015-12-17 14:08:08,991 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;106;113;111;113;124;110;109;110;110 14:08:08 INFO - 2015-12-17 14:08:08,991 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;126;149;167;132;148;153;126;172;132 14:08:08 INFO - 2015-12-17 14:08:08,992 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;160;162;161;164;161;171;164;162 14:08:08 INFO - 2015-12-17 14:08:08,992 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;71;73;72;72;138;71;78;71;72 14:08:08 INFO - 2015-12-17 14:08:08,992 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;137;94;94;94;142;93;93;135 14:08:08 INFO - 2015-12-17 14:08:08,992 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;111;109;109;110;110;110;111;110 14:08:08 INFO - 2015-12-17 14:08:08,992 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;174;146;146;146;147;146;145;147;147;146 14:08:08 INFO - 2015-12-17 14:08:08,992 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;96;96;97;96;96;96;96;95 14:08:08 INFO - 2015-12-17 14:08:08,993 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;65;60;61;60;60;58;60;59;59 14:08:08 INFO - 2015-12-17 14:08:08,993 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;67;67;67;69;71;69;67;68 14:08:08 INFO - 2015-12-17 14:08:08,993 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;92;83;85;85;83;84;83;84;83 14:08:08 INFO - 2015-12-17 14:08:08,993 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;121;120;123;121;125;121;120;123;129 14:08:08 INFO - 2015-12-17 14:08:08,993 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;141;160;153;149;152;149;147;148;140 14:08:08 INFO - 2015-12-17 14:08:08,993 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;71;65;66;69;77;67;69;67;68 14:08:08 INFO - 2015-12-17 14:08:08,993 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:08:08 INFO - 2015-12-17 14:08:08,993 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:08:08 INFO - 2015-12-17 14:08:08,995 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,727 14:08:08 INFO - 2015-12-17 14:08:08,995 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:08:08 INFO - 2015-12-17 14:08:08,995 DEBUG : BROWSER_OUTPUT: __startTimestamp1450390088989__endTimestamp 14:08:08 INFO - 2015-12-17 14:08:08,995 DEBUG : BROWSER_OUTPUT: 14:08:08 INFO - 2015-12-17 14:08:08,995 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:08:08 INFO - 2015-12-17 14:08:08,995 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:08:08 INFO - 2015-12-17 14:08:08,995 DEBUG : BROWSER_OUTPUT: 14:08:08 INFO - 2015-12-17 14:08:08,995 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.60 Median:110.50 stddev:4.79 (4.3%) stddev-sans-first:5.04 14:08:08 INFO - 2015-12-17 14:08:08,995 DEBUG : BROWSER_OUTPUT: Values: 110.0 106.0 113.0 111.0 113.0 124.0 110.0 109.0 110.0 110.0 14:08:08 INFO - 2015-12-17 14:08:08,995 DEBUG : BROWSER_OUTPUT: 14:08:08 INFO - 2015-12-17 14:08:08,996 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.80 Median:151.00 stddev:16.40 (10.9%) stddev-sans-first:17.18 14:08:08 INFO - 2015-12-17 14:08:08,996 DEBUG : BROWSER_OUTPUT: Values: 153.0 126.0 149.0 167.0 132.0 148.0 153.0 126.0 172.0 132.0 14:08:08 INFO - 2015-12-17 14:08:08,996 DEBUG : BROWSER_OUTPUT: 14:08:08 INFO - 2015-12-17 14:08:08,996 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.80 Median:162.00 stddev:3.16 (1.9%) stddev-sans-first:3.28 14:08:08 INFO - 2015-12-17 14:08:08,996 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 160.0 162.0 161.0 164.0 161.0 171.0 164.0 162.0 14:08:08 INFO - 2015-12-17 14:08:08,996 DEBUG : BROWSER_OUTPUT: 14:08:08 INFO - 2015-12-17 14:08:08,996 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.10 Median:72.00 stddev:20.80 (28.9%) stddev-sans-first:21.94 14:08:08 INFO - 2015-12-17 14:08:08,996 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 73.0 72.0 72.0 138.0 71.0 78.0 71.0 72.0 14:08:08 INFO - 2015-12-17 14:08:08,996 DEBUG : BROWSER_OUTPUT: 14:08:08 INFO - 2015-12-17 14:08:08,996 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.80 Median:93.00 stddev:21.60 (23.2%) stddev-sans-first:22.33 14:08:09 INFO - 2015-12-17 14:08:08,996 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 137.0 94.0 94.0 94.0 142.0 93.0 93.0 135.0 14:08:09 INFO - 2015-12-17 14:08:08,996 DEBUG : BROWSER_OUTPUT: 14:08:09 INFO - 2015-12-17 14:08:08,996 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 14:08:09 INFO - 2015-12-17 14:08:08,997 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 111.0 109.0 109.0 110.0 110.0 110.0 111.0 110.0 14:08:09 INFO - 2015-12-17 14:08:08,997 DEBUG : BROWSER_OUTPUT: 14:08:09 INFO - 2015-12-17 14:08:08,998 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:149.00 Median:146.50 stddev:8.81 (6.0%) stddev-sans-first:0.67 14:08:09 INFO - 2015-12-17 14:08:08,998 DEBUG : BROWSER_OUTPUT: Values: 174.0 146.0 146.0 146.0 147.0 146.0 145.0 147.0 147.0 146.0 14:08:09 INFO - 2015-12-17 14:08:08,998 DEBUG : BROWSER_OUTPUT: 14:08:09 INFO - 2015-12-17 14:08:08,998 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 14:08:09 INFO - 2015-12-17 14:08:08,998 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 95.0 14:08:09 INFO - 2015-12-17 14:08:08,998 DEBUG : BROWSER_OUTPUT: 14:08:09 INFO - 2015-12-17 14:08:08,998 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.40 Median:60.00 stddev:1.96 (3.3%) stddev-sans-first:1.99 14:08:09 INFO - 2015-12-17 14:08:08,998 DEBUG : BROWSER_OUTPUT: Values: 62.0 65.0 60.0 61.0 60.0 60.0 58.0 60.0 59.0 59.0 14:08:09 INFO - 2015-12-17 14:08:08,999 DEBUG : BROWSER_OUTPUT: 14:08:09 INFO - 2015-12-17 14:08:08,999 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:67.50 stddev:1.37 (2.0%) stddev-sans-first:1.41 14:08:09 INFO - 2015-12-17 14:08:08,999 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 67.0 67.0 67.0 69.0 71.0 69.0 67.0 68.0 14:08:09 INFO - 2015-12-17 14:08:08,999 DEBUG : BROWSER_OUTPUT: 14:08:09 INFO - 2015-12-17 14:08:08,999 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.00 stddev:2.84 (3.4%) stddev-sans-first:2.87 14:08:09 INFO - 2015-12-17 14:08:08,999 DEBUG : BROWSER_OUTPUT: Values: 82.0 92.0 83.0 85.0 85.0 83.0 84.0 83.0 84.0 83.0 14:08:09 INFO - 2015-12-17 14:08:08,999 DEBUG : BROWSER_OUTPUT: 14:08:09 INFO - 2015-12-17 14:08:08,999 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.90 Median:122.00 stddev:3.45 (2.8%) stddev-sans-first:2.92 14:08:09 INFO - 2015-12-17 14:08:08,999 DEBUG : BROWSER_OUTPUT: Values: 116.0 121.0 120.0 123.0 121.0 125.0 121.0 120.0 123.0 129.0 14:08:09 INFO - 2015-12-17 14:08:08,999 DEBUG : BROWSER_OUTPUT: 14:08:09 INFO - 2015-12-17 14:08:08,999 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.10 Median:149.00 stddev:6.12 (4.1%) stddev-sans-first:6.08 14:08:09 INFO - 2015-12-17 14:08:08,999 DEBUG : BROWSER_OUTPUT: Values: 142.0 141.0 160.0 153.0 149.0 152.0 149.0 147.0 148.0 140.0 14:08:09 INFO - 2015-12-17 14:08:08,999 DEBUG : BROWSER_OUTPUT: 14:08:09 INFO - 2015-12-17 14:08:08,999 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.50 stddev:3.41 (5.0%) stddev-sans-first:3.56 14:08:09 INFO - 2015-12-17 14:08:08,999 DEBUG : BROWSER_OUTPUT: Values: 67.0 71.0 65.0 66.0 69.0 77.0 67.0 69.0 67.0 68.0 14:08:09 INFO - 2015-12-17 14:08:08,999 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:08:09 INFO - 2015-12-17 14:08:09,000 DEBUG : BROWSER_OUTPUT: 14:08:09 INFO - 2015-12-17 14:08:09,841 INFO : Browser exited with error code: 0 14:08:09 INFO - 2015-12-17 14:08:09,894 INFO : Completed test kraken (00:01:00) 14:08:09 INFO - 2015-12-17 14:08:09,894 INFO : Starting test v8_7 14:08:09 INFO - 2015-12-17 14:08:09,894 DEBUG : operating with platform_type : linux_ 14:08:09 INFO - 2015-12-17 14:08:09,894 INFO : Initialising browser for v8_7 test... 14:08:09 INFO - 2015-12-17 14:08:09,900 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfQvp3x/profile http://localhost:58086/getInfo.html 14:08:14 INFO - 2015-12-17 14:08:14,563 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:08:14 INFO - 2015-12-17 14:08:14,564 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:08:14 INFO - 2015-12-17 14:08:14,564 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:08:14 INFO - 2015-12-17 14:08:14,564 DEBUG : BROWSER_OUTPUT: __metrics 14:08:14 INFO - 2015-12-17 14:08:14,705 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:08:15 INFO - 2015-12-17 14:08:15,549 INFO : Browser initialized. 14:08:15 INFO - 2015-12-17 14:08:15,550 INFO : Running cycle 1/1 for v8_7 test... 14:08:15 INFO - 2015-12-17 14:08:15,550 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfQvp3x/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:08:27 INFO - 2015-12-17 14:08:27,421 DEBUG : BROWSER_OUTPUT: RSS: Main: 151625728 14:08:27 INFO - 2015-12-17 14:08:27,421 DEBUG : BROWSER_OUTPUT: 14:08:48 INFO - 2015-12-17 14:08:48,854 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58086/tests/v8_7/run.html (next: http://localhost:58086/tests/v8_7/run.html) 14:08:49 INFO - 2015-12-17 14:08:49,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 145993728 14:08:49 INFO - 2015-12-17 14:08:49,100 DEBUG : BROWSER_OUTPUT: 14:08:49 INFO - 2015-12-17 14:08:49,102 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:08:49 INFO - 2015-12-17 14:08:49,102 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:08:49 INFO - 2015-12-17 14:08:49,102 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:08:49 INFO - 2015-12-17 14:08:49,102 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:08:49 INFO - 2015-12-17 14:08:49,102 DEBUG : BROWSER_OUTPUT: |0;Richards;167.0564650851988 14:08:49 INFO - 2015-12-17 14:08:49,102 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.89928598271325 14:08:49 INFO - 2015-12-17 14:08:49,103 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.17364600781684 14:08:49 INFO - 2015-12-17 14:08:49,103 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5208.333333333333 14:08:49 INFO - 2015-12-17 14:08:49,103 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1064.9627263045793 14:08:49 INFO - 2015-12-17 14:08:49,103 DEBUG : BROWSER_OUTPUT: |5;Earley;713.2667617689016 14:08:49 INFO - 2015-12-17 14:08:49,103 DEBUG : BROWSER_OUTPUT: |6;Boyer;12168.674698795181 14:08:49 INFO - 2015-12-17 14:08:49,103 DEBUG : BROWSER_OUTPUT: |7;RegExp;25150 14:08:49 INFO - 2015-12-17 14:08:49,104 DEBUG : BROWSER_OUTPUT: |8;Splay;547.645125958379 14:08:49 INFO - 2015-12-17 14:08:49,104 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 14:08:49 INFO - 2015-12-17 14:08:49,104 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:08:49 INFO - 2015-12-17 14:08:49,104 DEBUG : BROWSER_OUTPUT: __startTimestamp1450390129100__endTimestamp 14:08:49 INFO - 2015-12-17 14:08:49,104 DEBUG : BROWSER_OUTPUT: 14:08:49 INFO - 2015-12-17 14:08:49,104 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:08:49 INFO - 2015-12-17 14:08:49,105 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:08:49 INFO - 2015-12-17 14:08:49,105 DEBUG : BROWSER_OUTPUT: 14:08:49 INFO - 2015-12-17 14:08:49,105 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.06 Median:167.06 stddev:0.00 (0.0%) 14:08:49 INFO - 2015-12-17 14:08:49,105 DEBUG : BROWSER_OUTPUT: Values: 167.1 14:08:49 INFO - 2015-12-17 14:08:49,105 DEBUG : BROWSER_OUTPUT: 14:08:49 INFO - 2015-12-17 14:08:49,105 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.90 Median:187.90 stddev:0.00 (0.0%) 14:08:49 INFO - 2015-12-17 14:08:49,107 DEBUG : BROWSER_OUTPUT: Values: 187.9 14:08:49 INFO - 2015-12-17 14:08:49,107 DEBUG : BROWSER_OUTPUT: 14:08:49 INFO - 2015-12-17 14:08:49,107 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.17 Median:279.17 stddev:0.00 (0.0%) 14:08:49 INFO - 2015-12-17 14:08:49,107 DEBUG : BROWSER_OUTPUT: Values: 279.2 14:08:49 INFO - 2015-12-17 14:08:49,107 DEBUG : BROWSER_OUTPUT: 14:08:49 INFO - 2015-12-17 14:08:49,108 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 14:08:49 INFO - 2015-12-17 14:08:49,108 DEBUG : BROWSER_OUTPUT: Values: 5208.3 14:08:49 INFO - 2015-12-17 14:08:49,108 DEBUG : BROWSER_OUTPUT: 14:08:49 INFO - 2015-12-17 14:08:49,108 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1064.96 Median:1064.96 stddev:0.00 (0.0%) 14:08:49 INFO - 2015-12-17 14:08:49,108 DEBUG : BROWSER_OUTPUT: Values: 1065.0 14:08:49 INFO - 2015-12-17 14:08:49,108 DEBUG : BROWSER_OUTPUT: 14:08:49 INFO - 2015-12-17 14:08:49,108 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:713.27 Median:713.27 stddev:0.00 (0.0%) 14:08:49 INFO - 2015-12-17 14:08:49,109 DEBUG : BROWSER_OUTPUT: Values: 713.3 14:08:49 INFO - 2015-12-17 14:08:49,109 DEBUG : BROWSER_OUTPUT: 14:08:49 INFO - 2015-12-17 14:08:49,109 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12168.67 Median:12168.67 stddev:0.00 (0.0%) 14:08:49 INFO - 2015-12-17 14:08:49,109 DEBUG : BROWSER_OUTPUT: Values: 12168.7 14:08:49 INFO - 2015-12-17 14:08:49,109 DEBUG : BROWSER_OUTPUT: 14:08:49 INFO - 2015-12-17 14:08:49,109 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25150.00 Median:25150.00 stddev:0.00 (0.0%) 14:08:49 INFO - 2015-12-17 14:08:49,109 DEBUG : BROWSER_OUTPUT: Values: 25150.0 14:08:49 INFO - 2015-12-17 14:08:49,109 DEBUG : BROWSER_OUTPUT: 14:08:49 INFO - 2015-12-17 14:08:49,110 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:547.65 Median:547.65 stddev:0.00 (0.0%) 14:08:49 INFO - 2015-12-17 14:08:49,110 DEBUG : BROWSER_OUTPUT: Values: 547.6 14:08:49 INFO - 2015-12-17 14:08:49,110 DEBUG : BROWSER_OUTPUT: 14:08:49 INFO - 2015-12-17 14:08:49,110 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 14:08:49 INFO - 2015-12-17 14:08:49,110 DEBUG : BROWSER_OUTPUT: Values: 4835.7 14:08:49 INFO - 2015-12-17 14:08:49,110 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:08:49 INFO - 2015-12-17 14:08:49,110 DEBUG : BROWSER_OUTPUT: 14:08:49 INFO - 2015-12-17 14:08:49,977 INFO : Browser exited with error code: 0 14:08:49 INFO - 2015-12-17 14:08:49,989 INFO : Completed test v8_7 (00:00:40) 14:08:50 INFO - 2015-12-17 14:08:50,137 INFO : Completed test suite (00:20:11) 14:08:50 INFO - 2015-12-17 14:08:50,138 DEBUG : Working with test: dromaeo_css 14:08:50 INFO - 2015-12-17 14:08:50,138 DEBUG : Generating results file: dromaeo_css 14:08:50 INFO - 2015-12-17 14:08:50,139 DEBUG : Working with test: kraken 14:08:50 INFO - 2015-12-17 14:08:50,139 DEBUG : Generating results file: kraken 14:08:50 INFO - 2015-12-17 14:08:50,139 INFO : javascript benchmark 14:08:50 INFO - 2015-12-17 14:08:50,139 DEBUG : Working with test: v8_7 14:08:50 INFO - 2015-12-17 14:08:50,140 DEBUG : Generating results file: v8_7 14:08:50 INFO - 2015-12-17 14:08:50,140 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:08:50 INFO - 2015-12-17 14:08:50,216 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 14:08:50 INFO - 2015-12-17 14:08:50,216 DEBUG : process_Request line: dromaeo_css 7087.23 graph.html#tests=[[72,64,43]] 14:08:50 INFO - 2015-12-17 14:08:50,216 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:08:50 INFO - 2015-12-17 14:08:50,247 DEBUG : process_Request line: kraken 1512.60 graph.html#tests=[[232,64,43]] 14:08:50 INFO - 2015-12-17 14:08:50,247 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:08:50 INFO - 2015-12-17 14:08:50,282 DEBUG : process_Request line: v8_7 21606.32 graph.html#tests=[[230,64,43]] 14:08:50 INFO - 2015-12-17 14:08:50,284 INFO : javascript benchmark 14:08:50 INFO - 2015-12-17 14:08:50,287 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3174.3809957058374, 3197.712205901467, 3205.246767009754, 3237.0612522368515, 3242.043597138844, 5175.146100893348, 5269.789208431663, 5329.413764485904, 5335.306410166678, 5375.113106337454, 5302.098643230651, 5303.893922121555, 5311.1502159654465, 5316.5215130638335, 5353.491418315254, 4885.462599114095, 4976.950230497685, 5027.673201241926, 5050.393952725678, 5069.087564238435, 5047.848564543069, 5053.5451809337155, 5060.4686507916695, 5096.159133742928, 5103.081445339856, 4775.641826863, 4814.951850481485, 4865.24588688752, 4945.184044632631, 4947.678400903929, 4937.728424936627, 4956.107900577895, 4963.280324352949, 4973.950260497385, 5015.498450154992, 4728.40894888139, 4920.188168952154, 4923.655344125913, 4944.184209605447, 4952.182889823211, 5156.9742151289, 5198.636095473318, 5205.6616319939085, 5205.765740541685, 5245.160774276135, 5800.332961709415, 5886.117082437669, 5887.528997680175, 5893.970530147365, 5922.733476993546, 5684.516816070639, 5799.159121927339, 5879.8530036749, 5887.35239123696, 5945.4946329562035, 5387.0, 5442.700651464207, 5445.9727701361635, 5457.972710136424, 5473.370562385337, 5892.970535147382, 5954.0, 5970.582059255898, 5972.940270597239, 5985.162077309094, 5568.638038527482, 5662.178984047372, 5713.5714821388565, 5771.0477771168125, 5773.855653608609, 5817.76728930838, 5834.416558344132, 5845.912311315334, 5852.853678658068, 5873.559483038789, 5709.286339207599, 5817.011108111631, 5821.214136091573, 5835.854103647358, 5840.5035571976005, 5595.972020139873, 5685.602007859493, 5701.059325211377, 5710.229119068956, 5775.8556036099435, 4449.510553839075, 4483.910321793546, 4487.147441986012, 4515.435570553681, 4518.4126063612175, 3986.863743832994, 3993.0616305168264, 3993.3211354069877, 3993.560708322082, 4034.415009823559, 5350.0904846176245, 5372.328458942632, 5452.863678408072, 5483.150111732688, 5531.474509921551, 5853.239078919798, 5876.618019828783, 5888.087346461305, 5890.587658863924, 5924.170616113747, 5484.095124304445, 5526.530244929146, 5530.7511161997, 5531.751071201806, 5541.251930989345, 4980.501949805063, 5037.143685573461, 5045.5459008689395, 5062.898742025139, 5149.150390185578, 5944.197533333031, 5967.045272756425, 5973.970130149409, 5983.820485385359, 5989.131575921554, 5887.470127688529, 5895.64626122434, 5898.026825573732, 5899.144624029577, 5903.0555111182, 5695.316562012585, 5826.388229235869, 5865.14955331466, 5868.94131058684, 5870.14882841994, 5636.126400407943, 5643.774249030157, 5691.658500489983, 5700.572457065819, 5752.511036561939, 5849.210356601804, 5866.120081987736, 5878.470937615635, 5879.794207202727, 5893.823185304448, 5592.245046918614, 5708.058170401837, 5711.914321285101, 5714.0, 5722.027255366681, 5651.717414129359, 5723.685197314021, 5736.684482353344, 5747.827565173052, 5769.048107062287, 5533.197686335539, 5556.222128901876, 5580.358258800127, 5588.077967135378, 5608.355039170548, 5609.775608975595, 5614.101743720985, 5637.182608521659, 5677.829665110054, 5730.5129064030025, 5560.610757246954, 5612.494875461228, 5619.915701264403, 5652.123920792284, 5664.376918538875], "unit": "score", "name": "dojo.html", "value": 5351.907448803643}, {"lowerIsBetter": false, "replicates": [567.8268128220892, 570.8810730967303, 572.6764378126359, 573.5870173475097, 590.0794760174126, 37238.0, 37819.05452363692, 37933.0, 38017.61982380172, 38195.427068593955, 42812.78593607035, 43307.35038974418, 43321.783391083, 43350.56649433513, 43441.56558434415, 8669.783255418617, 8813.250873675745, 8825.867611985825, 8833.11668833118, 8857.42426742263, 8631.611577478998, 8679.435836670596, 8729.869051964226, 8766.824663506726, 8810.339224558153, 8665.95667021664, 8694.695685651004, 8750.956245218797, 8773.64905403783, 8805.867911981326, 8760.299176065899, 8774.868376974351, 8847.513386763725, 8864.867026994569, 8869.0, 8634.956825215897, 8709.95645021777, 8744.475331480067, 8758.386912916098, 8775.078616745213, 39434.0, 39723.20553588912, 39798.0, 39919.0, 40076.799616001736, 3280.3439312137666, 3466.116140384211, 3554.5201397811225, 3582.8566857325936, 3776.244751049801, 29874.551881721793, 30300.848495757382, 30364.54453183204, 30470.84764576163, 30571.541426878615, 3887.747296425723, 4052.0, 4060.187962407501, 4070.1656160487323, 4213.789310534461, 250503.0, 251138.0, 251234.0, 251235.0, 251528.0, 51784.22323665148, 51839.48160518422, 58481.70759146177, 58498.0, 58625.70687146537, 53232.0, 53263.0, 53383.73308133434, 53449.46550534523, 53467.0, 13899.79150312746, 14115.364808583638, 14141.43434262618, 14147.717045659028, 14204.076735012191, 10372.0, 10589.09992650618, 10636.946815265874, 10745.462726863625, 10770.461476926122, 19192.726546108614, 19660.70508942367, 19897.0, 19928.800711992986, 19932.0, 7669.309762121436, 7834.8433031339055, 7951.960240198878, 7988.201179881965, 8049.154838741965, 928.9442633442015, 941.8398872191743, 978.9363691360039, 983.2674657380154, 1134.9886501135047, 28542.571861422097, 28671.71328286732, 29199.270018249288, 29326.560101598494, 29498.705012949595, 993.0714781679153, 1016.1565900302732, 1060.8196606576746, 1072.7586293083993, 1127.9605213817476, 14511.0, 14546.127232366092, 14650.487232947009, 14812.185329806964, 14850.554483365517, 321501.0, 325644.0, 326993.0, 327022.0, 327152.0, 50484.0, 50552.0, 50641.74679126581, 50748.0, 51000.0, 1329.308759445083, 1352.0197856554116, 1363.4478036395276, 1367.6785955300297, 1372.9519466818813, 27259.454810904066, 28342.0, 28467.857660711565, 29271.0, 30017.849910750305, 42471.3629295567, 42615.7869210652, 42888.0, 42996.57003429926, 43124.56875431331, 252487.0, 252749.0, 254310.0, 255028.0, 255099.0, 30573.55411567025, 32078.19804504906, 32264.67735322617, 32686.83656581702, 32695.673043269264, 38963.220735585695, 43112.78443607762, 43363.78318108389, 43926.0, 43970.0, 32965.34069318648, 33039.83480082584, 33236.335273294884, 33285.0, 33617.495737564444, 33439.66560334365, 33479.33041339208, 33793.83103084469, 33808.49287260742, 35510.46734298936, 32090.518642220854, 32484.0, 32635.673643263264, 32777.34445311033, 32789.83605081959, 29144.7085529142, 29777.5533367004, 30082.247943800703, 30172.849135754182, 30188.24529386783, 24153.75846241515, 24290.635640465054, 24538.754612454362, 24558.386040349134, 24628.507429850943], "unit": "score", "name": "ext.html", "value": 18043.01789715497}, {"lowerIsBetter": false, "replicates": [354.2542947096362, 359.0986623574826, 362.06948143271796, 362.0730928822217, 364.9087728067982, 16288.755668664964, 16877.66244675106, 17631.64736705267, 17836.0, 18462.815371846278, 9755.756106097351, 9933.701988940325, 14644.121352718845, 14650.560483185494, 14663.926680366583, 4720.929186062212, 4845.612351011928, 5039.924401133986, 5221.451747566508, 5233.712145831978, 5083.18669012958, 5129.25625784263, 5133.589312854962, 5141.974290128544, 5433.972830135844, 5903.144044113601, 5989.43100405463, 6183.474404675608, 6373.617582945015, 6387.872242555146, 6254.155688981998, 6405.35946405358, 6423.357664233586, 6686.197656281277, 6704.5306828522025, 6405.19935008124, 6405.903911441332, 6452.257990331078, 6458.515611329169, 6466.224053113609, 21743.67384489234, 22624.660630090562, 23145.421364465856, 23205.88397058004, 23208.3037508875, 2276.9544609107893, 2298.138198175684, 2305.262316058862, 2322.431004403915, 2429.9028038878423, 14273.71452570953, 14300.499482518166, 14704.33830477631, 14907.776383354258, 14933.626659333495, 1772.0962309222261, 1795.2370242646953, 1880.0129931785784, 1957.4616980330381, 1972.4871533401276, 62577.37422625806, 65700.02235302902, 70096.64951675209, 71673.28326716718, 72231.63884180546, 14985.850141498446, 14988.925055374872, 15142.621434464007, 15148.0, 15181.696366072838, 24185.51628967411, 24273.150439734523, 24431.87784061104, 24455.266342009767, 24459.51080978406, 8282.503049816909, 8336.583170841433, 8426.662933482592, 8455.873161902577, 8486.660533578712, 7041.507094503438, 7042.225355210922, 7050.0129981801565, 7073.469489788286, 7086.822829429202, 7628.580428076398, 7628.618569071524, 7721.343685786771, 7759.57322347265, 7786.1824508426935, 1810.4478134169206, 1842.8065053169491, 2839.7444230019396, 2914.737673609385, 2925.1078421081775, 829.8921140251729, 843.236870632079, 859.621766422772, 982.1700662939804, 1015.28422462164, 15503.922480387526, 16563.254653540618, 16755.2460139294, 17511.912440437718, 18411.355602554115, 890.8040231149137, 891.4473026723473, 893.3523195683077, 911.3893691226893, 1013.964511242103, 9590.616375345047, 9742.61029558824, 10183.388996660076, 10322.22583306255, 10409.739756506147, 377068.0, 381180.0, 382060.0, 385827.0, 495782.0, 76991.0, 80128.59935700284, 83680.0, 84019.0, 84274.0, 1133.240728711765, 1149.1094401838475, 1151.861776586815, 1171.2913687219109, 1178.0987544528443, 15764.921175394049, 16007.0, 16060.518184454486, 16069.517914462585, 16092.436764713178, 34549.65450345464, 34930.0, 36072.0, 36373.09067273339, 36788.0, 45185.77407112943, 45418.77290613526, 45976.0, 46065.53934460613, 46172.76913615411, 9048.909510904807, 9450.669226577036, 9657.9034209657, 9690.273229507675, 9825.213982881209, 8972.955135224543, 11422.885771142182, 11488.712782180512, 11737.47181376823, 15235.3905843765, 13814.585562433143, 14674.55976320712, 14802.703945921237, 14967.476138335105, 15013.624659383166, 13928.885689145047, 13977.650558736113, 14051.718965620426, 14445.0, 14507.1295722257, 14542.345594448063, 14692.485762998243, 14776.039557428732, 14917.254137293308, 15019.09885406879, 9144.725658230263, 9312.394694344846, 9517.048295170705, 9540.809183816424, 9573.09055639741, 9430.57562409707, 11049.723756906142, 14142.434302628191, 14402.135871847722, 14439.78340324917], "unit": "score", "name": "jquery.html", "value": 9449.53952460006}, {"lowerIsBetter": false, "replicates": [1418.631155899466, 1467.1343907094813, 1592.8566429021394, 1616.814066382365, 1742.3640371264491, 6620.668966551665, 6743.561668491557, 7265.41876649868, 7557.735479258227, 7593.77218683439, 7052.894206586905, 7338.743143989961, 7355.632218389086, 7382.335589796917, 7384.556926584409, 2160.481484443734, 2198.8900554972265, 2203.3389983005113, 2205.4155648753012, 2216.1357070742424, 2160.2547121243147, 2197.8241740660787, 2200.2629119244993, 2200.7579166291694, 2209.304069218199, 2162.740471143465, 2165.123125134315, 2186.8250539956844, 2211.2039665720326, 2217.623004089309, 2162.718846549946, 2193.2762188477764, 2196.9560608787733, 2197.0333053456507, 2201.7908298711595, 2130.2544109561686, 2179.564087182554, 2179.9891000544894, 2183.148572056899, 2190.671399290103, 7320.487565870391, 7398.963005184994, 7404.518706284074, 7424.480286379956, 7444.664990075459, 4513.7743112844555, 4534.86395408135, 4539.704919180276, 4559.635229181657, 4559.77201139945, 3038.5745995560637, 3083.1983684242036, 3097.132802815193, 3148.449021421265, 3161.462551366273, 1021.7905329407454, 1038.9948050259775, 1054.4200689620754, 1063.0645032371463, 1084.6366467233486, 10044.89955100447, 10049.397036177852, 10083.142932850717, 10102.494875256209, 10105.696829095212, 4088.9182216355507, 4098.549159592442, 4105.035316700573, 4148.79256037197, 4173.08192197716, 8678.088800675965, 8702.39083264178, 8714.956425217833, 8716.912830871737, 8720.215180633773, 4525.162844873643, 4576.4508259009135, 4586.380838586748, 4586.403767510269, 4597.563231493003, 3925.5878132796215, 3977.940330895039, 4003.4395184674167, 4155.542890282067, 4202.873913782591, 3399.8300084995653, 3408.386490431746, 3415.4364529852296, 3424.8630054797527, 3435.9312813743586, 1017.1201910347644, 1027.7276521721749, 1029.5264178477835, 1031.7523794289466, 1040.6565833275151, 1201.3512703140382, 1234.4074844074894, 1240.076143273249, 1250.2123662092824, 1257.3838818978634, 6956.513044086966, 7102.573845569283, 7145.749898753519, 7184.209736928934, 7318.817029574197, 1107.44074242507, 1110.9944450277696, 1120.3613940054254, 1124.9943750281195, 1128.5203788389902, 5676.233708449389, 5687.43125687428, 5696.629719068247, 5710.2862142232225, 5747.712614369265, 8694.565271736388, 8756.56217189138, 8854.24738897188, 8856.601452934634, 9043.909560904307, 8691.304695624334, 8802.559872006374, 8818.779530511789, 8832.470051796912, 8841.955790221007, 6982.685779139951, 7010.684519196547, 7105.182903966007, 7107.928920710727, 7131.144262688407, 6845.760398386033, 6885.965570172117, 6888.138982627172, 6889.414399776075, 6901.206361268519, 7789.805254868447, 7932.0878099017045, 8028.43800933929, 8065.596720163851, 8089.312408445113, 7961.880571791312, 8210.835783284181, 8271.54506502148, 8305.543195124326, 8358.832823343377, 5540.556755459473, 5761.337446193574, 6157.0, 6170.259568851767, 6233.376662333731, 7085.114360704912, 7091.893621595784, 7099.183593886562, 7125.251848555827, 7125.5368401053765, 6571.411585184591, 6708.597484150967, 6756.290589488033, 6778.0510728497065, 6893.20728116273, 6655.534112612071, 6707.429868461236, 6734.6295953721055, 6796.150481189851, 6828.590284582742, 6496.317886621837, 6522.673866306761, 6584.901226481702, 6586.407223349922, 6605.5376123670885, 6145.170401995673, 6235.438810507076, 6299.338569450325, 6300.527460440577, 6304.05439184126, 6232.8130156095385, 6263.6241825490615, 6275.74897004133, 6276.058591211355, 6286.591371560834], "unit": "score", "name": "mootools.html", "value": 4317.972147284912}, {"lowerIsBetter": false, "replicates": [331.24806688816386, 331.8373996741597, 338.8796977073139, 339.45009085281833, 347.1806536573686, 6248.718807653655, 6287.15123458333, 6335.619862808235, 6352.523560732946, 6371.840703982402, 6233.719482623282, 6293.370662933704, 6301.716422760976, 6329.0, 6353.459955903742, 4744.8102075917095, 4745.738984355859, 4746.620270378378, 4749.838823335383, 4754.9762251188695, 4747.738874361926, 4749.240121580548, 4753.073150735608, 4759.809607615691, 4765.571098601125, 4632.953670463303, 4652.8138874444985, 4703.270992996091, 4717.834875779348, 4717.882052948687, 4658.930116048262, 4666.043461090469, 4715.174844402233, 4718.442913838425, 4722.409698787652, 4058.431819545266, 4061.715679902408, 4062.045419326456, 4064.4919385076864, 4074.9388759168637, 5975.581709280352, 5986.161937328778, 5999.370066143036, 6003.909941350883, 6012.78955236569, 5367.329083864517, 5455.536279416255, 5463.9180412293845, 5468.699221542814, 5485.945140548583, 6649.60102393858, 6650.7339706411685, 6659.300773418819, 6664.8000559983275, 6674.0, 4444.755538445384, 4465.843695470643, 4479.3057076153245, 4491.842785502492, 4495.1009798040195, 6785.084013658142, 6889.448844092461, 6891.310868913119, 6921.4808889333, 6931.0, 4626.953730462719, 4627.5603817637275, 4639.211334073216, 4657.580817726421, 4666.766661666903, 4689.906201876011, 4697.95302046982, 4700.647451441156, 4701.130290896127, 4713.29300604912, 5484.0, 5494.780208791603, 5505.201745746925, 5505.366882808528, 5508.889822203533, 6613.14029176204, 6703.631300278434, 6721.4958878084335, 6723.058771771955, 6745.08941292929, 1618.5629879932353, 1646.7694522766822, 1650.1996531682125, 1650.3563610192034, 1650.801903771555, 1076.531708706715, 1077.7575045614674, 1079.1097344690504, 1087.5160553553592, 1089.0470838016736, 6352.460040896483, 6374.713137908805, 6375.947968585224, 6378.011408231639, 6394.072859435356, 6816.659167041628, 6821.147356580427, 6826.829329266808, 6833.658317084225, 6876.449884009267, 6246.812595622138, 6335.904961425582, 6370.299267080617, 6378.968105159444, 6384.265809431882, 3689.6494832990825, 3720.6837418819164, 3732.79469629173, 3739.1960728442973, 3743.1952130291575, 6939.23668396476, 6962.651867406609, 6974.442044636518, 6982.1970473395195, 6983.2318444971015, 6958.165020197507, 7003.54476958996, 7009.9649501752165, 7013.754518591825, 7020.964895175492, 7169.426445884316, 7181.784546463615, 7183.748568800067, 7184.676689548983, 7186.281371862772, 7027.086478757728, 7031.894521582282, 7037.612931288828, 7040.436765058681, 7043.6830342633675, 6807.3873351398615, 6953.06133671968, 6963.79108626742, 6967.0, 6970.477214209056, 7029.753958611424, 7045.542039767399, 7069.39910107626, 7079.787606371817, 7105.50261481712, 4534.070515544239, 4572.6799124061, 4576.222042252892, 4593.150267200579, 4593.6554758392585, 6867.0, 7023.754168604074, 7039.612821294878, 7039.683214255473, 7062.4703147263135, 6798.082258895183, 6823.044773731781, 6823.727050917908, 6836.692348844214, 6840.042394064934, 6774.085498457645, 6805.081314022544, 6808.863822723617, 6812.182538095461, 6813.1142951415995, 6529.902051469327, 6633.469322454289, 6667.066610674607, 6673.265940746611, 6676.232233293039, 6832.145981752281, 6835.863282734417, 6838.247792742894, 6845.452363810784, 6845.520813543203, 6590.505712071518, 6642.335766423319, 6650.767223147167, 6656.267810540739, 6687.531872769054], "unit": "score", "name": "prototype.html", "value": 5000.139000422453}, {"lowerIsBetter": false, "replicates": [734.7905846833653, 738.9261073892608, 798.5568009754587, 820.6635279535392, 906.2976193450075, 12937.547185848498, 13160.210387376765, 13211.93394033031, 13248.536301229458, 13313.866861331384, 12318.692032699164, 13052.804207936864, 13235.735285294288, 14270.571882843506, 14271.429142834275, 817.6157206113132, 831.3556993330187, 832.1096426823271, 832.4880198677799, 834.1950018232404, 815.2703330519182, 817.0767033252446, 820.4379999700225, 821.5112008355019, 825.4015838517057, 864.2783275964578, 869.9347548933823, 872.3065163195243, 874.0429229993148, 875.5972252763736, 862.2584577263548, 867.7136544940217, 871.7166920750718, 872.402404353017, 874.1346067393298, 636.3413866647998, 639.3095456906576, 639.9616023038633, 640.2093414632925, 642.4507046475289, 12961.416736246798, 13166.473341066347, 13291.268980206085, 13325.0, 13383.263920484369, 11824.881751182464, 12247.938760306231, 12590.874091259153, 12615.180013299107, 12691.619251422471, 10407.271490995634, 10448.895511044944, 10579.84130238047, 10816.242862999594, 10827.566897324097, 3652.543432070991, 3701.222743223926, 3719.1260053887313, 3821.8853434396733, 3857.4599556062176, 44364.55635443669, 47026.294605580944, 47269.52730472686, 47484.28773568399, 47619.285710714365, 8825.470471771714, 8898.510581918057, 8913.598888050054, 9093.636254549743, 9095.408798428214, 17210.741838872425, 17217.311307547807, 17254.654906901793, 17555.824441755674, 17794.199261033285, 7499.850003000019, 7692.461527693008, 7724.806879827936, 7737.148913619498, 7751.069871615329, 4318.740875547477, 4366.497852746975, 4419.027813880941, 4451.310046942729, 4512.3908272382805, 3072.969270307313, 3089.1813669377634, 3099.0392978176837, 3102.9844850775603, 3104.425681248976, 526.9815556455505, 548.2790130977752, 550.1335396750135, 563.808305176242, 566.3260719743492, 635.8315046512678, 672.7578071894114, 680.8910574308087, 687.2131409536054, 728.7522242437491, 8754.343424243207, 8783.253423459077, 8826.382153249338, 8874.689385871463, 8925.464472131693, 659.6998365743575, 664.4850241063215, 677.4952660268132, 679.4123083532709, 687.9793606191822, 4054.878353649395, 4128.174365126986, 4242.193983143193, 4244.363345498138, 4271.231178387858, 61119.0, 61125.0, 61143.38856611377, 61680.0, 62357.68821155865, 49158.0, 49807.25289120666, 52196.47803521916, 52859.471405285454, 53696.731516342166, 46805.0, 47812.28281575779, 51648.741756290976, 51933.740331298104, 52726.73636631869, 8877.644894204159, 9018.188363047357, 9261.907380926104, 9355.502108822013, 9375.0, 35081.824590877906, 35433.64566354304, 36136.27727445489, 36550.8172459136, 37862.24275514529, 45515.31727024031, 45542.31686524639, 46018.53981460143, 46096.0, 46445.0, 11277.830832537355, 11393.6998490507, 12053.011253143133, 12090.576829810914, 12156.75686486283, 12453.564125255572, 12790.872091278969, 12845.550405735754, 13109.344532773513, 13116.672083197996, 11519.25124866881, 11874.584389546324, 12027.63917082454, 12273.079519036286, 12296.385180740748, 11607.535698571963, 11947.94026029899, 12182.451789669663, 12228.510859565518, 12253.938730306292, 11101.333919964827, 11230.382328971986, 11387.658370248906, 11548.480318385526, 11611.205526013111, 9858.457784821903, 9879.555420005972, 9891.802163956825, 10033.648822291185, 10264.897351026395, 9151.267898567965, 9205.907940920504, 9222.44665320083, 9419.764505887408, 10312.226583006455], "unit": "score", "name": "yui.html", "value": 6431.780368142129}], "name": "dromaeo_css", "value": 7087.232263091896}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 106.0, 113.0, 111.0, 113.0, 124.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [153.0, 126.0, 149.0, 167.0, 132.0, 148.0, 153.0, 126.0, 172.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 145.8}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 160.0, 162.0, 161.0, 164.0, 161.0, 171.0, 164.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.8}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 73.0, 72.0, 72.0, 138.0, 71.0, 78.0, 71.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.1}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 137.0, 94.0, 94.0, 94.0, 142.0, 93.0, 93.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 111.0, 109.0, 109.0, 110.0, 110.0, 110.0, 111.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [174.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 149.0}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [62.0, 65.0, 60.0, 61.0, 60.0, 60.0, 58.0, 60.0, 59.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 60.4}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 69.0, 71.0, 69.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [82.0, 92.0, 83.0, 85.0, 85.0, 83.0, 84.0, 83.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [116.0, 121.0, 120.0, 123.0, 121.0, 125.0, 121.0, 120.0, 123.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.9}, {"lowerIsBetter": true, "replicates": [142.0, 141.0, 160.0, 153.0, 149.0, 152.0, 149.0, 147.0, 148.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.1}, {"lowerIsBetter": true, "replicates": [67.0, 71.0, 65.0, 66.0, 69.0, 77.0, 67.0, 69.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1512.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.0564650851988], "unit": "score", "name": "Richards", "value": 211.31777200000008}, {"lowerIsBetter": false, "replicates": [187.89928598271325], "unit": "score", "name": "DeltaBlue", "value": 351.879996}, {"lowerIsBetter": false, "replicates": [279.17364600781684], "unit": "score", "name": "Encrypt", "value": 953.4603419999996}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1064.9627263045793], "unit": "score", "name": "RayTrace", "value": 694.8496709999997}, {"lowerIsBetter": false, "replicates": [713.2667617689016], "unit": "score", "name": "Earley", "value": 934.3811260000003}, {"lowerIsBetter": false, "replicates": [12168.674698795181], "unit": "score", "name": "Boyer", "value": 54.768741584158384}, {"lowerIsBetter": false, "replicates": [25150.0], "unit": "score", "name": "RegExp", "value": 36.22206759443341}, {"lowerIsBetter": false, "replicates": [547.645125958379], "unit": "score", "name": "Splay", "value": 148.802566}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21606.324711930974}]} 14:08:50 INFO - RETURN: dromaeo_css: 7087.23 14:08:50 INFO - RETURN: kraken: 1512.60 14:08:50 INFO - RETURN: v8_7: 21606.32 14:08:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21606.32"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1512.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "7087.23"}}} 14:08:50 INFO - Return code: 0 14:08:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:08:50 INFO - # TBPL SUCCESS # 14:08:50 INFO - Running post-action listener: _resource_record_post_action 14:08:50 INFO - Running post-run listener: _resource_record_post_run 14:08:51 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 554799104; Read time: 8; Write time: 633740 14:08:51 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234713088; Read time: 0; Write time: 380936 14:08:51 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 320086016; Read time: 8; Write time: 252804 14:08:51 INFO - Running post-run listener: _upload_blobber_files 14:08:51 INFO - Blob upload gear active. 14:08:51 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:08:51 INFO - Copying logs to upload dir... 14:08:51 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1276.085742 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-12-17 14:08:50.915640) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 14:08:50.918726) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1450385999.341558-607460702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/hrFIooBTRmqAVyCqZN7LZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010067 build_url: 'https://queue.taskcluster.net/v1/task/hrFIooBTRmqAVyCqZN7LZw/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-17 14:08:50.970290) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 14:08:50.970653) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1450385999.341558-607460702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004717 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 14:08:51.020050) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 14:08:51.020375) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 14:08:51.020694) ========= ========= Total master_lag: 0.25 =========