builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-033 starttime: 1448077235.8 results: success (0) buildid: 20151120173025 builduid: 651ab1dec87a48b596125f5f8a8ea728 revision: 809ef65b4a96cfb02ef3acfdb664fa03394a0195 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:35.797152) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:35.797901) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:35.798400) ========= 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=a194aa7faa1be204aaca7d660000020b-1448076445.467965-301246221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006723 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:35.822472) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:35.823091) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:35.837493) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:35.837993) ========= 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=a194aa7faa1be204aaca7d660000020b-1448076445.467965-301246221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:35.890860) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:35.891269) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:35.891655) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:35.891927) ========= 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=a194aa7faa1be204aaca7d660000020b-1448076445.467965-301246221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 19:40:36-- 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% 39.9M=0s 2015-11-20 19:40:36 (39.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168607 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:36.073933) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:36.074291) ========= 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=a194aa7faa1be204aaca7d660000020b-1448076445.467965-301246221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020796 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:36.123635) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:36.123958) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 809ef65b4a96cfb02ef3acfdb664fa03394a0195 --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 809ef65b4a96cfb02ef3acfdb664fa03394a0195 --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=a194aa7faa1be204aaca7d660000020b-1448076445.467965-301246221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 19:40:36,289 truncating revision to first 12 chars 2015-11-20 19:40:36,289 Setting DEBUG logging. 2015-11-20 19:40:36,289 attempt 1/10 2015-11-20 19:40:36,290 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/809ef65b4a96?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 19:40:36,531 unpacking tar archive at: fx-team-809ef65b4a96/testing/mozharness/ program finished with exit code 0 elapsedTime=0.549053 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:36.685937) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:36.686332) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:36.695966) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:36.696278) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 19:40:36.696697) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-11-20 19:40:36.696989) ========= /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=a194aa7faa1be204aaca7d660000020b-1448076445.467965-301246221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:40:36 INFO - MultiFileLogger online at 20151120 19:40:36 in /builds/slave/test-pgo 19:40:36 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 19:40:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:40:36 INFO - {'append_to_log': False, 19:40:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:40:36 INFO - 'blob_upload_branch': 'Fx-Team', 19:40:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:40:36 INFO - 'branch': 'Fx-Team', 19:40:36 INFO - 'buildbot_json_path': 'buildprops.json', 19:40:36 INFO - 'config_files': ('talos/linux_config.py',), 19:40:36 INFO - 'default_actions': ('clobber', 19:40:36 INFO - 'read-buildbot-config', 19:40:36 INFO - 'download-and-extract', 19:40:36 INFO - 'populate-webroot', 19:40:36 INFO - 'create-virtualenv', 19:40:36 INFO - 'install', 19:40:36 INFO - 'run-tests'), 19:40:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:40:36 INFO - 'download_minidump_stackwalk': True, 19:40:36 INFO - 'download_symbols': 'ondemand', 19:40:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:40:36 INFO - 'tooltool.py': '/tools/tooltool.py', 19:40:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:40:36 INFO - '/tools/misc-python/virtualenv.py')}, 19:40:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:40:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:40:36 INFO - 'installer_path': 'installer.exe', 19:40:36 INFO - 'log_level': 'info', 19:40:36 INFO - 'log_name': 'talos', 19:40:36 INFO - 'log_to_console': True, 19:40:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:40:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:40:36 INFO - 'opt_config_files': (), 19:40:36 INFO - 'pip_index': False, 19:40:36 INFO - 'sps_profile': False, 19:40:36 INFO - 'sps_profile_interval': 0, 19:40:36 INFO - 'suite': 'dromaeojs-e10s', 19:40:36 INFO - 'system_bits': '64', 19:40:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:40:36 INFO - 'title': 'talos-linux64-ix-033', 19:40:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:40:36 INFO - 'use_talos_json': True, 19:40:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:40:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:40:36 INFO - 'work_dir': 'build'} 19:40:36 INFO - ##### 19:40:36 INFO - ##### Running clobber step. 19:40:36 INFO - ##### 19:40:36 INFO - Running pre-action listener: _resource_record_pre_action 19:40:36 INFO - Running main action method: clobber 19:40:36 INFO - rmtree: /builds/slave/test-pgo/build 19:40:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:40:37 INFO - Running post-action listener: _resource_record_post_action 19:40:37 INFO - ##### 19:40:37 INFO - ##### Running read-buildbot-config step. 19:40:37 INFO - ##### 19:40:37 INFO - Running pre-action listener: _resource_record_pre_action 19:40:37 INFO - Running main action method: read_buildbot_config 19:40:37 INFO - Using buildbot properties: 19:40:37 INFO - { 19:40:37 INFO - "properties": { 19:40:37 INFO - "buildnumber": 348, 19:40:37 INFO - "product": "firefox", 19:40:37 INFO - "script_repo_revision": "production", 19:40:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:40:37 INFO - "repository": "", 19:40:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 19:40:37 INFO - "buildid": "20151120173025", 19:40:37 INFO - "slavename": "talos-linux64-ix-033", 19:40:37 INFO - "pgo_build": "True", 19:40:37 INFO - "basedir": "/builds/slave/test-pgo", 19:40:37 INFO - "project": "", 19:40:37 INFO - "platform": "ubuntu64_hw", 19:40:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:40:37 INFO - "slavebuilddir": "test", 19:40:37 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:40:37 INFO - "branch": "fx-team", 19:40:37 INFO - "repo_path": "integration/fx-team", 19:40:37 INFO - "stage_platform": "linux64-pgo", 19:40:37 INFO - "builduid": "651ab1dec87a48b596125f5f8a8ea728", 19:40:37 INFO - "revision": "809ef65b4a96cfb02ef3acfdb664fa03394a0195" 19:40:37 INFO - }, 19:40:37 INFO - "sourcestamp": { 19:40:37 INFO - "repository": "", 19:40:37 INFO - "hasPatch": false, 19:40:37 INFO - "project": "", 19:40:37 INFO - "branch": "fx-team-linux64-pgo-talos", 19:40:37 INFO - "changes": [ 19:40:37 INFO - { 19:40:37 INFO - "category": null, 19:40:37 INFO - "files": [ 19:40:37 INFO - { 19:40:37 INFO - "url": null, 19:40:37 INFO - "name": "https://queue.taskcluster.net/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 19:40:37 INFO - } 19:40:37 INFO - ], 19:40:37 INFO - "repository": "", 19:40:37 INFO - "rev": "809ef65b4a96cfb02ef3acfdb664fa03394a0195", 19:40:37 INFO - "who": "sendchange", 19:40:37 INFO - "when": 1448077196, 19:40:37 INFO - "number": 6691820, 19:40:37 INFO - "comments": "", 19:40:37 INFO - "project": "", 19:40:37 INFO - "at": "Fri 20 Nov 2015 19:39:56", 19:40:37 INFO - "branch": "fx-team-linux64-pgo-talos", 19:40:37 INFO - "revlink": "", 19:40:37 INFO - "properties": [ 19:40:37 INFO - [ 19:40:37 INFO - "buildid", 19:40:37 INFO - "20151120173025", 19:40:37 INFO - "Change" 19:40:37 INFO - ], 19:40:37 INFO - [ 19:40:37 INFO - "builduid", 19:40:37 INFO - "651ab1dec87a48b596125f5f8a8ea728", 19:40:37 INFO - "Change" 19:40:37 INFO - ], 19:40:37 INFO - [ 19:40:37 INFO - "pgo_build", 19:40:37 INFO - "True", 19:40:37 INFO - "Change" 19:40:37 INFO - ] 19:40:37 INFO - ], 19:40:37 INFO - "revision": "809ef65b4a96cfb02ef3acfdb664fa03394a0195" 19:40:37 INFO - } 19:40:37 INFO - ], 19:40:37 INFO - "revision": "809ef65b4a96cfb02ef3acfdb664fa03394a0195" 19:40:37 INFO - } 19:40:37 INFO - } 19:40:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 19:40:37 INFO - Running post-action listener: _resource_record_post_action 19:40:37 INFO - ##### 19:40:37 INFO - ##### Running download-and-extract step. 19:40:37 INFO - ##### 19:40:37 INFO - Running pre-action listener: _resource_record_pre_action 19:40:37 INFO - Running main action method: download_and_extract 19:40:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:40: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')]} 19:40:37 INFO - https://queue.taskcluster.net/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:40:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/test_packages.json 19:40:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/test_packages.json 19:40:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:40:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:40:37 INFO - Downloaded 1302 bytes. 19:40:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:40:38 INFO - Using the following test package requirements: 19:40:38 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:40:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:40:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:40:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:40:38 INFO - u'jsshell-linux-x86_64.zip'], 19:40:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:40:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:40:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:40:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:40:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:40:38 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:40:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:40:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:40:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:40:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:40:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:40:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:40:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:40: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')]} 19:40:38 INFO - https://queue.taskcluster.net/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:40:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:40:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:40:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:40:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:40:39 INFO - Downloaded 22523880 bytes. 19:40:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 19:40:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:40:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:40:40 INFO - Return code: 0 19:40:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:40 INFO - https://queue.taskcluster.net/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:40:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:40:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:40:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:40:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:40:41 INFO - Downloaded 22523880 bytes. 19:40:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 19:40:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:40:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:40:42 INFO - Return code: 0 19:40: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')]} 19:40:42 INFO - https://queue.taskcluster.net/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:40:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:40:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:40:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:40:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:40:44 INFO - Downloaded 11130997 bytes. 19:40:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 19:40:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:40:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 19:40:44 INFO - Return code: 0 19:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:44 INFO - https://queue.taskcluster.net/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:40:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:40:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:40:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:40:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:40:45 INFO - Downloaded 57449998 bytes. 19:40:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:40:45 INFO - mkdir: /builds/slave/test-pgo/properties 19:40:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:40:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:40:45 INFO - Contents: 19:40:45 INFO - build_url:https://queue.taskcluster.net/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:40:45 INFO - Running post-action listener: _resource_record_post_action 19:40:45 INFO - Running post-action listener: set_extra_try_arguments 19:40:45 INFO - ##### 19:40:45 INFO - ##### Running populate-webroot step. 19:40:45 INFO - ##### 19:40:45 INFO - Running pre-action listener: _resource_record_pre_action 19:40:45 INFO - Running main action method: populate_webroot 19:40:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:40:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:40:45 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 19:40:45 INFO - '../fennec_ids.txt'], 19:40:45 INFO - 'tests': ['tcheck2']}, 19:40:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:40:45 INFO - '--tppagecycles', 19:40:45 INFO - '7'], 19:40:45 INFO - 'tests': ['tsvgm']}}, 19:40:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:40:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:40:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:40:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:40:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:40:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:40:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:40:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:45 INFO - 'talos_options': ['--e10s'], 19:40:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:40:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:45 INFO - 'tests': ['damp', 'tps']}, 19:40:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:45 INFO - 'talos_options': ['--e10s'], 19:40:45 INFO - 'tests': ['damp', 'tps']}, 19:40:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:40:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:40:45 INFO - 'other': {'tests': ['a11yr', 19:40:45 INFO - 'ts_paint', 19:40:45 INFO - 'tpaint', 19:40:45 INFO - 'sessionrestore', 19:40:45 INFO - 'sessionrestore_no_auto_restore']}, 19:40:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:40:45 INFO - 'tests': ['a11yr', 19:40:45 INFO - 'ts_paint', 19:40:45 INFO - 'tpaint', 19:40:45 INFO - 'sessionrestore', 19:40:45 INFO - 'sessionrestore_no_auto_restore']}, 19:40:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:40:45 INFO - 'tests': ['a11yr', 19:40:45 INFO - 'ts_paint', 19:40:45 INFO - 'tpaint', 19:40:45 INFO - 'sessionrestore', 19:40:45 INFO - 'sessionrestore_no_auto_restore']}, 19:40:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:40:45 INFO - 'tests': ['a11yr', 19:40:45 INFO - 'ts_paint', 19:40:45 INFO - 'tpaint', 19:40:45 INFO - 'sessionrestore', 19:40:45 INFO - 'sessionrestore_no_auto_restore']}, 19:40:45 INFO - 'other_l64': {'tests': ['a11yr', 19:40:45 INFO - 'ts_paint', 19:40:45 INFO - 'tpaint', 19:40:45 INFO - 'sessionrestore', 19:40:45 INFO - 'sessionrestore_no_auto_restore']}, 19:40:45 INFO - 'other_nol64': {'tests': ['a11yr', 19:40:45 INFO - 'ts_paint', 19:40:45 INFO - 'tpaint', 19:40:45 INFO - 'sessionrestore', 19:40:45 INFO - 'sessionrestore_no_auto_restore']}, 19:40:45 INFO - 'svgr': {'tests': ['tsvgx', 19:40:45 INFO - 'tsvgr_opacity', 19:40:45 INFO - 'tart', 19:40:45 INFO - 'tscrollx', 19:40:45 INFO - 'cart']}, 19:40:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:40:45 INFO - 'tests': ['tsvgx', 19:40:45 INFO - 'tsvgr_opacity', 19:40:45 INFO - 'tart', 19:40:45 INFO - 'tscrollx', 19:40:45 INFO - 'cart']}, 19:40:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:45 INFO - 'tests': ['tp5o']}, 19:40:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:45 INFO - 'talos_options': ['--e10s'], 19:40:45 INFO - 'tests': ['tp5o']}, 19:40:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:45 INFO - 'talos_options': ['--xperf_path', 19:40:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:40:45 INFO - 'tests': ['tp5n']}, 19:40:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:45 INFO - 'talos_options': ['--e10s', 19:40:45 INFO - '--xperf_path', 19:40:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:40:45 INFO - 'tests': ['tp5n']}}, 19:40:45 INFO - 'talos.zip': {'path': '', 19:40:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:40:45 INFO - Running post-action listener: _resource_record_post_action 19:40:45 INFO - ##### 19:40:45 INFO - ##### Running create-virtualenv step. 19:40:45 INFO - ##### 19:40:45 INFO - Running pre-action listener: _resource_record_pre_action 19:40:45 INFO - Running main action method: create_virtualenv 19:40:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:40:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 19:40:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:40:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:40:45 INFO - Using real prefix '/usr' 19:40:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:40:46 INFO - Installing distribute.............................................................................................................................................................................................done. 19:40:48 INFO - Installing pip.................done. 19:40:48 INFO - Return code: 0 19:40:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:48 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 0x7f4d0ee3bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf986c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ed70>, '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 0x108fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ffb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448076445.467965-301246221', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:40:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 19:40:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:40:48 INFO - Using env: {'DISPLAY': ':0', 19:40:48 INFO - 'HOME': '/home/cltbld', 19:40:48 INFO - 'LANG': 'en_US.UTF-8', 19:40:48 INFO - 'LANGUAGE': 'en_US:en', 19:40:48 INFO - 'LOGNAME': 'cltbld', 19:40:48 INFO - 'MAIL': '/var/mail/cltbld', 19:40:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:48 INFO - 'MOZ_NO_REMOTE': '1', 19:40:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:48 INFO - 'NO_EM_RESTART': '1', 19:40:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:40:48 INFO - 'PWD': '/builds/slave/test-pgo', 19:40:48 INFO - 'SHELL': '/bin/bash', 19:40:48 INFO - 'SHLVL': '1', 19:40:48 INFO - 'TERM': 'linux', 19:40:48 INFO - 'TMOUT': '86400', 19:40:48 INFO - 'USER': 'cltbld', 19:40:48 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448076445.467965-301246221', 19:40:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:48 INFO - '_': '/tools/buildbot/bin/python'} 19:40:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:40:48 INFO - Cleaning up... 19:40:48 INFO - Return code: 0 19:40:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:48 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 0x7f4d0ee3bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf986c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ed70>, '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 0x108fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ffb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448076445.467965-301246221', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:40:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 19:40:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:40:48 INFO - Using env: {'DISPLAY': ':0', 19:40:48 INFO - 'HOME': '/home/cltbld', 19:40:48 INFO - 'LANG': 'en_US.UTF-8', 19:40:48 INFO - 'LANGUAGE': 'en_US:en', 19:40:48 INFO - 'LOGNAME': 'cltbld', 19:40:48 INFO - 'MAIL': '/var/mail/cltbld', 19:40:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:48 INFO - 'MOZ_NO_REMOTE': '1', 19:40:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:48 INFO - 'NO_EM_RESTART': '1', 19:40:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:40:48 INFO - 'PWD': '/builds/slave/test-pgo', 19:40:48 INFO - 'SHELL': '/bin/bash', 19:40:48 INFO - 'SHLVL': '1', 19:40:48 INFO - 'TERM': 'linux', 19:40:48 INFO - 'TMOUT': '86400', 19:40:48 INFO - 'USER': 'cltbld', 19:40:48 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448076445.467965-301246221', 19:40:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:48 INFO - '_': '/tools/buildbot/bin/python'} 19:40:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:48 INFO - Downloading/unpacking psutil>=0.7.1 19:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:50 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:40:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:40:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:40:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:40:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:40:50 INFO - Installing collected packages: psutil 19:40:50 INFO - Running setup.py install for psutil 19:40:50 INFO - building 'psutil._psutil_linux' extension 19:40:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:40:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:40:50 INFO - building 'psutil._psutil_posix' extension 19:40:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:40:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:40:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:40:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:40:51 INFO - Successfully installed psutil 19:40:51 INFO - Cleaning up... 19:40:51 INFO - Return code: 0 19:40:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:51 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 0x7f4d0ee3bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf986c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ed70>, '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 0x108fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ffb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448076445.467965-301246221', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:40:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 19:40:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:40:51 INFO - Using env: {'DISPLAY': ':0', 19:40:51 INFO - 'HOME': '/home/cltbld', 19:40:51 INFO - 'LANG': 'en_US.UTF-8', 19:40:51 INFO - 'LANGUAGE': 'en_US:en', 19:40:51 INFO - 'LOGNAME': 'cltbld', 19:40:51 INFO - 'MAIL': '/var/mail/cltbld', 19:40:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:51 INFO - 'MOZ_NO_REMOTE': '1', 19:40:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:51 INFO - 'NO_EM_RESTART': '1', 19:40:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:40:51 INFO - 'PWD': '/builds/slave/test-pgo', 19:40:51 INFO - 'SHELL': '/bin/bash', 19:40:51 INFO - 'SHLVL': '1', 19:40:51 INFO - 'TERM': 'linux', 19:40:51 INFO - 'TMOUT': '86400', 19:40:51 INFO - 'USER': 'cltbld', 19:40:51 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448076445.467965-301246221', 19:40:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:51 INFO - '_': '/tools/buildbot/bin/python'} 19:40:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:40:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:40:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:40:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:40:53 INFO - Installing collected packages: mozsystemmonitor 19:40:53 INFO - Running setup.py install for mozsystemmonitor 19:40:53 INFO - Successfully installed mozsystemmonitor 19:40:53 INFO - Cleaning up... 19:40:53 INFO - Return code: 0 19:40:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:40:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:53 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 0x7f4d0ee3bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf986c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ed70>, '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 0x108fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ffb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448076445.467965-301246221', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:40:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:40:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:40:53 INFO - Using env: {'DISPLAY': ':0', 19:40:53 INFO - 'HOME': '/home/cltbld', 19:40:53 INFO - 'LANG': 'en_US.UTF-8', 19:40:53 INFO - 'LANGUAGE': 'en_US:en', 19:40:53 INFO - 'LOGNAME': 'cltbld', 19:40:53 INFO - 'MAIL': '/var/mail/cltbld', 19:40:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:53 INFO - 'MOZ_NO_REMOTE': '1', 19:40:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:53 INFO - 'NO_EM_RESTART': '1', 19:40:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:40:53 INFO - 'PWD': '/builds/slave/test-pgo', 19:40:53 INFO - 'SHELL': '/bin/bash', 19:40:53 INFO - 'SHLVL': '1', 19:40:53 INFO - 'TERM': 'linux', 19:40:53 INFO - 'TMOUT': '86400', 19:40:53 INFO - 'USER': 'cltbld', 19:40:53 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448076445.467965-301246221', 19:40:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:53 INFO - '_': '/tools/buildbot/bin/python'} 19:40:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:53 INFO - Downloading/unpacking blobuploader==1.2.4 19:40:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:55 INFO - Downloading blobuploader-1.2.4.tar.gz 19:40:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:40:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:40:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:40:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:40:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:40:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:40:55 INFO - Downloading docopt-0.6.1.tar.gz 19:40:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:40:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:40:56 INFO - Installing collected packages: blobuploader, requests, docopt 19:40:56 INFO - Running setup.py install for blobuploader 19:40:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:40:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:40:56 INFO - Running setup.py install for requests 19:40:56 INFO - Running setup.py install for docopt 19:40:56 INFO - Successfully installed blobuploader requests docopt 19:40:56 INFO - Cleaning up... 19:40:56 INFO - Return code: 0 19:40:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:56 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 0x7f4d0ee3bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf986c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ed70>, '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 0x108fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ffb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448076445.467965-301246221', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:40:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 19:40:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:40:56 INFO - Using env: {'DISPLAY': ':0', 19:40:56 INFO - 'HOME': '/home/cltbld', 19:40:56 INFO - 'LANG': 'en_US.UTF-8', 19:40:56 INFO - 'LANGUAGE': 'en_US:en', 19:40:56 INFO - 'LOGNAME': 'cltbld', 19:40:56 INFO - 'MAIL': '/var/mail/cltbld', 19:40:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:56 INFO - 'MOZ_NO_REMOTE': '1', 19:40:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:56 INFO - 'NO_EM_RESTART': '1', 19:40:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:40:56 INFO - 'PWD': '/builds/slave/test-pgo', 19:40:56 INFO - 'SHELL': '/bin/bash', 19:40:56 INFO - 'SHLVL': '1', 19:40:56 INFO - 'TERM': 'linux', 19:40:56 INFO - 'TMOUT': '86400', 19:40:56 INFO - 'USER': 'cltbld', 19:40:56 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448076445.467965-301246221', 19:40:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:56 INFO - '_': '/tools/buildbot/bin/python'} 19:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:40:56 INFO - Running setup.py (path:/tmp/pip-YEApMM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:40:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:40:56 INFO - Running setup.py (path:/tmp/pip-0s0Xzq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:40:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:40:56 INFO - Running setup.py (path:/tmp/pip-fz1Oqh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:40:57 INFO - Running setup.py (path:/tmp/pip-PguNaM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:40:57 INFO - Running setup.py (path:/tmp/pip-d_pTU5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:40:57 INFO - Running setup.py (path:/tmp/pip-JRMGPQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:40:57 INFO - Running setup.py (path:/tmp/pip-_Oix44-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:40:57 INFO - Running setup.py (path:/tmp/pip-v9SLhB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:40:57 INFO - Running setup.py (path:/tmp/pip-s70NN6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:40:57 INFO - Running setup.py (path:/tmp/pip-I3SlyJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:40:57 INFO - Running setup.py (path:/tmp/pip-E7FbNc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:40:57 INFO - Running setup.py (path:/tmp/pip-mlfDnj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:40:57 INFO - Running setup.py (path:/tmp/pip-TleORk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:40:57 INFO - Running setup.py (path:/tmp/pip-PZgfeX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:40:57 INFO - Running setup.py (path:/tmp/pip-DnreC2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:40:57 INFO - Running setup.py (path:/tmp/pip-XJWWor-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:40:57 INFO - Running setup.py (path:/tmp/pip-px0Zmq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:40:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:40:58 INFO - Running setup.py install for manifestparser 19:40:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:40:58 INFO - Running setup.py install for mozcrash 19:40:58 INFO - Running setup.py install for mozdebug 19:40:58 INFO - Running setup.py install for mozdevice 19:40:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:40:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:40:58 INFO - Running setup.py install for mozfile 19:40:58 INFO - Running setup.py install for mozhttpd 19:40:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:40:58 INFO - Running setup.py install for mozinfo 19:40:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:40:58 INFO - Running setup.py install for mozInstall 19:40:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:40:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:40:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:40:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:40:58 INFO - Running setup.py install for mozleak 19:40:58 INFO - Running setup.py install for mozlog 19:40:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:40:59 INFO - Running setup.py install for moznetwork 19:40:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:40:59 INFO - Running setup.py install for mozprocess 19:40:59 INFO - Running setup.py install for mozprofile 19:40:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:40:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:40:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:40:59 INFO - Running setup.py install for mozrunner 19:40:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:40:59 INFO - Running setup.py install for mozscreenshot 19:40:59 INFO - Running setup.py install for moztest 19:40:59 INFO - Running setup.py install for mozversion 19:40:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:40:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:40:59 INFO - Cleaning up... 19:40:59 INFO - Return code: 0 19:40:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:40:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:40:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:40:59 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 0x7f4d0ee3bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf986c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ed70>, '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 0x108fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ffb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448076445.467965-301246221', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:40:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 19:40:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:40:59 INFO - Using env: {'DISPLAY': ':0', 19:40:59 INFO - 'HOME': '/home/cltbld', 19:40:59 INFO - 'LANG': 'en_US.UTF-8', 19:40:59 INFO - 'LANGUAGE': 'en_US:en', 19:40:59 INFO - 'LOGNAME': 'cltbld', 19:40:59 INFO - 'MAIL': '/var/mail/cltbld', 19:40:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:59 INFO - 'MOZ_NO_REMOTE': '1', 19:40:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:40:59 INFO - 'NO_EM_RESTART': '1', 19:40:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:40:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:40:59 INFO - 'PWD': '/builds/slave/test-pgo', 19:40:59 INFO - 'SHELL': '/bin/bash', 19:40:59 INFO - 'SHLVL': '1', 19:40:59 INFO - 'TERM': 'linux', 19:40:59 INFO - 'TMOUT': '86400', 19:40:59 INFO - 'USER': 'cltbld', 19:40:59 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448076445.467965-301246221', 19:40:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:59 INFO - '_': '/tools/buildbot/bin/python'} 19:41:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:41:00 INFO - Running setup.py (path:/tmp/pip-s7jF_u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 19:41:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:41:00 INFO - Running setup.py (path:/tmp/pip-_Dnv1W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:41:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:41:00 INFO - Running setup.py (path:/tmp/pip-R75uTE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 19:41:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:41:00 INFO - Running setup.py (path:/tmp/pip-rv19nM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:41:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:41:00 INFO - Running setup.py (path:/tmp/pip-GMVImI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 19:41:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:41:00 INFO - Running setup.py (path:/tmp/pip-ndTUjF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 19:41:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:41:00 INFO - Running setup.py (path:/tmp/pip-7BKWUy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 19:41:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:41:00 INFO - Running setup.py (path:/tmp/pip-ZIaQd4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 19:41:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:41:00 INFO - Running setup.py (path:/tmp/pip-N5PgUQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 19:41:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:41:00 INFO - Running setup.py (path:/tmp/pip-HgDNoe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:41:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:41:00 INFO - Running setup.py (path:/tmp/pip-ALPeG1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 19:41:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:41:00 INFO - Running setup.py (path:/tmp/pip-vDrKjP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:41:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 19:41:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:41:00 INFO - Running setup.py (path:/tmp/pip-sMpqzl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:41:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 19:41:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:41:01 INFO - Running setup.py (path:/tmp/pip-qgaXSz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:41:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 19:41:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:41:01 INFO - Running setup.py (path:/tmp/pip-QF7JYl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:41:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 19:41:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:41:01 INFO - Running setup.py (path:/tmp/pip-18sRPj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:41:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 19:41:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:41:01 INFO - Running setup.py (path:/tmp/pip-40Aloo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:41:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 19:41:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:41:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:41:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 19:41:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:41:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:41:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:41: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 19:41: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 19:41: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 19:41: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 19:41: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 19:41: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 19:41:02 INFO - Downloading blessings-1.5.1.tar.gz 19:41:02 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 19:41:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:41:03 INFO - Installing collected packages: blessings 19:41:03 INFO - Running setup.py install for blessings 19:41:03 INFO - Successfully installed blessings 19:41:03 INFO - Cleaning up... 19:41:03 INFO - Return code: 0 19:41:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:41:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:41:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:41:03 INFO - Reading from file tmpfile_stdout 19:41:03 INFO - Current package versions: 19:41:03 INFO - argparse == 1.2.1 19:41:03 INFO - blessings == 1.5.1 19:41:03 INFO - blobuploader == 1.2.4 19:41:03 INFO - docopt == 0.6.1 19:41:03 INFO - manifestparser == 1.1 19:41:03 INFO - mozInstall == 1.12 19:41:03 INFO - mozcrash == 0.16 19:41:03 INFO - mozdebug == 0.1 19:41:03 INFO - mozdevice == 0.47 19:41:03 INFO - mozfile == 1.2 19:41:03 INFO - mozhttpd == 0.7 19:41:03 INFO - mozinfo == 0.9 19:41:03 INFO - mozleak == 0.1 19:41:03 INFO - mozlog == 3.0 19:41:03 INFO - moznetwork == 0.27 19:41:03 INFO - mozprocess == 0.22 19:41:03 INFO - mozprofile == 0.27 19:41:03 INFO - mozrunner == 6.11 19:41:03 INFO - mozscreenshot == 0.1 19:41:03 INFO - mozsystemmonitor == 0.0 19:41:03 INFO - moztest == 0.7 19:41:03 INFO - mozversion == 1.4 19:41:03 INFO - psutil == 3.1.1 19:41:03 INFO - requests == 1.2.3 19:41:03 INFO - wsgiref == 0.1.2 19:41:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:41:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:41:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f4d0ee3bc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf986c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ed70>, '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 0x108fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ffb0>, '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': 'a194aa7faa1be204aaca7d660000020b-1448076445.467965-301246221', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:41:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 19:41:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:41:03 INFO - Using env: {'DISPLAY': ':0', 19:41:03 INFO - 'HOME': '/home/cltbld', 19:41:03 INFO - 'LANG': 'en_US.UTF-8', 19:41:03 INFO - 'LANGUAGE': 'en_US:en', 19:41:03 INFO - 'LOGNAME': 'cltbld', 19:41:03 INFO - 'MAIL': '/var/mail/cltbld', 19:41:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:03 INFO - 'MOZ_NO_REMOTE': '1', 19:41:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:41:03 INFO - 'NO_EM_RESTART': '1', 19:41:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:41:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:41:03 INFO - 'PWD': '/builds/slave/test-pgo', 19:41:03 INFO - 'SHELL': '/bin/bash', 19:41:03 INFO - 'SHLVL': '1', 19:41:03 INFO - 'TERM': 'linux', 19:41:03 INFO - 'TMOUT': '86400', 19:41:03 INFO - 'USER': 'cltbld', 19:41:03 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448076445.467965-301246221', 19:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:03 INFO - '_': '/tools/buildbot/bin/python'} 19:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 19:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 19:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 19:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 19:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 19:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 19:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 19:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 19:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:41:03 INFO - Cleaning up... 19:41:03 INFO - Return code: 0 19:41:03 INFO - Running post-action listener: _resource_record_post_action 19:41:03 INFO - Running post-action listener: _start_resource_monitoring 19:41:03 INFO - Starting resource monitoring. 19:41:03 INFO - ##### 19:41:03 INFO - ##### Running install step. 19:41:03 INFO - ##### 19:41:03 INFO - Running pre-action listener: _resource_record_pre_action 19:41:03 INFO - Running main action method: install 19:41:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:41:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:41:03 INFO - Reading from file tmpfile_stdout 19:41:03 INFO - Detecting whether we're running mozinstall >=1.0... 19:41:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:41:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:41:03 INFO - Reading from file tmpfile_stdout 19:41:03 INFO - Output received: 19:41:03 INFO - Usage: mozinstall [options] installer 19:41:03 INFO - Options: 19:41:03 INFO - -h, --help show this help message and exit 19:41:03 INFO - -d DEST, --destination=DEST 19:41:03 INFO - Directory to install application into. [default: 19:41:03 INFO - "/builds/slave/test-pgo"] 19:41:03 INFO - --app=APP Application being installed. [default: firefox] 19:41:03 INFO - mkdir: /builds/slave/test-pgo/build/application 19:41:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 19:41:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 19:41:18 INFO - Reading from file tmpfile_stdout 19:41:18 INFO - Output received: 19:41:18 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:41:18 INFO - Running post-action listener: _resource_record_post_action 19:41:18 INFO - ##### 19:41:18 INFO - ##### Running run-tests step. 19:41:18 INFO - ##### 19:41:18 INFO - Running pre-action listener: _resource_record_pre_action 19:41:18 INFO - Running main action method: run_tests 19:41:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:41:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:41:18 INFO - Python 2.7.3 19:41:18 INFO - Return code: 0 19:41:18 INFO - grabbing minidump binary from tooltool 19:41: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')]} 19:41:18 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 0x108ed70>, '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 0x108fb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ffb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:41:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 19:41:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:41:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:41:18 INFO - Return code: 0 19:41:18 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:41:18 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:41:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:41:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:41:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:41:18 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/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 19:41:18 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/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost 19:41:18 INFO - Using env: {'DISPLAY': ':0', 19:41:18 INFO - 'HOME': '/home/cltbld', 19:41:18 INFO - 'LANG': 'en_US.UTF-8', 19:41:18 INFO - 'LANGUAGE': 'en_US:en', 19:41:18 INFO - 'LOGNAME': 'cltbld', 19:41:18 INFO - 'MAIL': '/var/mail/cltbld', 19:41:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:41:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:41:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:18 INFO - 'MOZ_NO_REMOTE': '1', 19:41:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:41:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:41:18 INFO - 'NO_EM_RESTART': '1', 19:41:18 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:41:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:41:18 INFO - 'PWD': '/builds/slave/test-pgo', 19:41:18 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:41:18 INFO - 'SHELL': '/bin/bash', 19:41:18 INFO - 'SHLVL': '1', 19:41:18 INFO - 'TERM': 'linux', 19:41:18 INFO - 'TMOUT': '86400', 19:41:18 INFO - 'USER': 'cltbld', 19:41:18 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1448076445.467965-301246221', 19:41:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:18 INFO - '_': '/tools/buildbot/bin/python'} 19:41:18 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/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] with output_timeout 3600 19:41:18 INFO - mozversion INFO | application_buildid: 20151120173025 19:41:18 INFO - mozversion INFO | application_changeset: 809ef65b4a96cfb02ef3acfdb664fa03394a0195 19:41:18 INFO - mozversion INFO | application_display_name: Nightly 19:41:18 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:41:18 INFO - mozversion INFO | application_name: Firefox 19:41:18 INFO - mozversion INFO | application_remotingname: firefox 19:41:18 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 19:41:18 INFO - mozversion INFO | application_vendor: Mozilla 19:41:18 INFO - mozversion INFO | application_version: 45.0a1 19:41:18 INFO - mozversion INFO | platform_buildid: 20151120173025 19:41:18 INFO - mozversion INFO | platform_changeset: 809ef65b4a96cfb02ef3acfdb664fa03394a0195 19:41:18 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 19:41:18 INFO - mozversion INFO | platform_version: 45.0a1 19:41:18 INFO - 2015-11-20 19:41:18,685 DEBUG : using testdate: 1448077278 19:41:18 INFO - 2015-11-20 19:41:18,685 DEBUG : actual date: 1448077278 19:41:18 INFO - 2015-11-20 19:41:18,694 INFO : starting webserver on 'localhost:52591' 19:41:18 INFO - 2015-11-20 19:41:18,694 INFO : Starting test suite talos-linux64-ix-033.e 19:41:18 INFO - 2015-11-20 19:41:18,694 INFO : Starting test dromaeo_css 19:41:18 INFO - 2015-11-20 19:41:18,694 DEBUG : operating with platform_type : linux_ 19:41:18 INFO - 2015-11-20 19:41:18,695 INFO : Initialising browser for dromaeo_css test... 19:41:18 INFO - 2015-11-20 19:41:18,704 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVH5W4v/profile http://localhost:52591/getInfo.html 19:41:30 INFO - 2015-11-20 19:41:30,305 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:41:30 INFO - 2015-11-20 19:41:30,305 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:41:30 INFO - 2015-11-20 19:41:30,305 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:41:30 INFO - 2015-11-20 19:41:30,305 DEBUG : BROWSER_OUTPUT: __metrics 19:41:31 INFO - 2015-11-20 19:41:31,673 INFO : Browser initialized. 19:41:31 INFO - 2015-11-20 19:41:31,673 INFO : Running cycle 1/1 for dromaeo_css test... 19:41:31 INFO - 2015-11-20 19:41:31,674 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVH5W4v/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:41:43 INFO - 2015-11-20 19:41:43,416 DEBUG : BROWSER_OUTPUT: RSS: Main: 142249984 19:41:43 INFO - 2015-11-20 19:41:43,416 DEBUG : BROWSER_OUTPUT: 19:42:33 INFO - 2015-11-20 19:42:33,039 DEBUG : BROWSER_OUTPUT: 1448077353035 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:44:42 INFO - 2015-11-20 19:44:42,265 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52591/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52591/tests/dromaeo/cssquery-ext.html) 19:44:43 INFO - 2015-11-20 19:44:43,653 DEBUG : BROWSER_OUTPUT: RSS: Main: 147574784 19:44:43 INFO - 2015-11-20 19:44:43,653 DEBUG : BROWSER_OUTPUT: 19:47:45 INFO - 2015-11-20 19:47:45,731 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52591/tests/dromaeo/cssquery-ext.html (next: http://localhost:52591/tests/dromaeo/cssquery-jquery.html) 19:47:46 INFO - 2015-11-20 19:47:46,317 DEBUG : BROWSER_OUTPUT: RSS: Main: 142123008 19:47:46 INFO - 2015-11-20 19:47:46,317 DEBUG : BROWSER_OUTPUT: 19:50:47 INFO - 2015-11-20 19:50:47,933 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52591/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52591/tests/dromaeo/cssquery-mootools.html) 19:50:48 INFO - 2015-11-20 19:50:48,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 143273984 19:50:48 INFO - 2015-11-20 19:50:48,526 DEBUG : BROWSER_OUTPUT: 19:53:50 INFO - 2015-11-20 19:53:50,152 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52591/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52591/tests/dromaeo/cssquery-prototype.html) 19:53:50 INFO - 2015-11-20 19:53:50,762 DEBUG : BROWSER_OUTPUT: RSS: Main: 139812864 19:53:50 INFO - 2015-11-20 19:53:50,762 DEBUG : BROWSER_OUTPUT: 19:56:53 INFO - 2015-11-20 19:56:53,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52591/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52591/tests/dromaeo/cssquery-yui.html) 19:56:53 INFO - 2015-11-20 19:56:53,682 DEBUG : BROWSER_OUTPUT: RSS: Main: 141426688 19:56:53 INFO - 2015-11-20 19:56:53,682 DEBUG : BROWSER_OUTPUT: 19:59:55 INFO - 2015-11-20 19:59:55,968 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52591/tests/dromaeo/cssquery-yui.html (next: http://localhost:52591/tests/dromaeo/cssquery-dojo.html) 19:59:56 INFO - 2015-11-20 19:59:56,218 DEBUG : BROWSER_OUTPUT: RSS: Main: 144277504 19:59:56 INFO - 2015-11-20 19:59:56,218 DEBUG : BROWSER_OUTPUT: 19:59:56 INFO - 2015-11-20 19:59:56,218 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:59:56 INFO - 2015-11-20 19:59:56,218 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:59:56 INFO - 2015-11-20 19:59:56,219 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:59:56 INFO - 2015-11-20 19:59:56,219 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:59:56 INFO - 2015-11-20 19:59:56,222 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3209.839508024598;3221.2430078931447;3273.5744353234077;3287.161773747695;3289.9013029609105;5231.372235331756;5397.163439666853;5402.567794576435;5436.864078398042;5439.3200849893765;5335.33308336458;5335.599830012755;5362.0616392131315;5450.828071964527;5472;4813.109574728686;4878.512148785128;4936.284238785374;4937.65436419449;4973.082299753126;4975.477574854643;4979.8008079676765;5115.462876397981;5135.178371460567;5181.35233095863;4820.831270905502;4898.044881248158;5037.219231019198;5054.368203974504;5144.3826740791155;4872.585830204402;4986.2769898364895;4992.650514463989;5007.023630392075;5009.223570346602;4944.703317800908;4980.850574482772;4983.401991761012;4985.476524964899;5022.146235139999;5070.873228169326;5170.431252562253;5174.120399532088;5245.239440281176;5252.789888404497;5823.097419899922;5833.591648584601;5843.094320380348;5859.062549991981;5916.1421593868645;5847.8538036549;5854.707264636793;5870.0607902735355;5872.970635146797;5875;5309.548688361494;5359.839204823823;5394.91907621386;5455.645383050089;5463.125899856004;5951.880962380728;6057.151998720183;6061.787837425669;6099.2680878294;6106.114613381035;5844;5854.121881717776;5873.353931067579;5874.441928016831;5895.322037965689;5749.626274292157;5754.136879468113;5900.763969441175;5915;5948.910766338508;5800.88398232033;5826.446487583673;5829.591928565044;5868.765249390062;5872.647641141545;5795.217645617872;5856.882862342729;5861.824145275648;5875.706214689249;5885.529157667376;4397.582229688174;4407.669424793089;4437.755923424178;4495.100979804052;4514.25514790056;4001.1797581495725;4017.0760725033406;4035.8183881725395;4044.69664775143;4052.3111071117983;5362.034833729888;5542.8337149885565;5591.888162236733;5594.104943209149;5598.664080155204;5682.176084467729;5726.627769195073;5759.510441612426;5784.681842498619;5821.476067153976;5627.352854421794;5656.208130861683;5656.660600363992;5671.2060311556415;5674.687892165971;4925.38432695913;5032.974835125801;5146.485351464824;5171.7672704728375;5219.269302297681;5828.0966450200285;5936.614120082181;5944.286685597843;5950.642961422329;5968.313643930916;5834.591578589458;5878.882422351615;5886.6173698709445;5922.200502932049;5929.347771745019;5836.445537673914;5877.265341832271;5914.822555323347;6018.307894592178;6029.216201893726;5849.005669036359;5856.267966504187;5869.7945571904775;5872.0898260769645;5873.765049397976;5886.175935369138;5916.822495325147;5940.435658612425;5941.792037278848;5953.553483488842;5551.22282880389;5604.2154098425435;5653.773849045992;5740.1102829061565;5770.451807078321;5671.404502527175;5676.631018983753;5702.51528620072;5737.827865164052;5742.971285143714;5599.888002239851;5634.380218175916;5638.295213098363;5641.464060914206;5645.943540564706;5558.666480011212;5655.349634791887;5658.207850900795;5699.800506982236;5729.197912292199;5623.718814059363;5633.267675202197;5635.943640563706;5647.237622920853;5704.543636509153 19:59:56 INFO - 2015-11-20 19:59:56,223 DEBUG : BROWSER_OUTPUT: |1;ext.html;540.2736224474976;577.8616126231324;595.7110801261388;596.4274296675192;600.3636145685574;38133.42799858001;39126.8043659782;39212.82361529155;39545.60454395455;39609;42687.78656106715;43337.34993975085;43392;43400.3489947651;43500.129997400036;8765.079666635007;8906.42108262964;8908.287337013024;8910.242629376478;8936;8724.607392667314;8768.386212965095;8804.515751633657;8816.691415800447;8848;8769.342299327544;8819.470831750115;8887.511186884718;8895.77760555988;8899.065598112202;8753.47479151253;8764.43031202973;8823.338249631302;8826.161514656098;8826.940767107988;8667.089955554702;8779.56102194894;8783.297336213087;8795.47227166372;8821.161989610977;40623.18753624911;40739.38890916639;41141.1771764566;41226.38160427596;41229.1754164918;3151.4957606782805;3243.351329734063;3310.9172270693184;3549.4498352755104;3550.1124718820297;30063.398732025238;30187.245318866986;30234.54648180279;30337;31288.21779455509;2860.2706309891055;2865.4555634429394;2889.422115576872;2995.326051638364;3226.3547290541987;421072;425368;425407;425941.57321347314;426885;41741;42410.57589424128;42568.14863702709;58723.119153212734;59157;41659.1668166641;41679;41880.58119418767;41905.58094419078;41906.790466047474;14979.325930332943;15035.398584056735;15042.247887605576;15120;15124.848751512563;12059.155859089955;12157.63527094171;12193.451294691582;12208.938955305166;12237.510499579917;14294.142351458946;14515.637109072357;14527.201003944885;14538.85461145375;14552.85447145536;5509.173623956439;5636.97181514098;5642.7178641067785;5658.236138121301;5673.929015909246;908.169025341818;914.5564401265381;947.1570302430843;1041.390786389955;1071.981617463413;28625.427491450053;33122.17194570155;33404.83297583545;33925.66074339225;34058.65941340555;1017.8524114003428;1041.6458404142627;1048.895110488945;1084.251866212311;1129.0910816792398;15017.399304027716;16569.91715041441;17295;17386.65226695459;17539.123043848012;388453;391300;391402;391769;393021;55235;55845.441545584836;55872.72063639656;55901;55907;1330.2085259270718;1334.6663334166458;1343.1605246720799;1353.4383230959238;1358.2258112875566;29994.70005299919;30700.692993069784;30820.22949426282;30822;31191.68808311888;46583.53416465792;46946.765266173454;47224.2916356248;47284.29073563831;47290;297411;297987;298436;299025;299185;32974.83512582422;46146;46565.53434465612;46959.765201173774;47970.76014620044;43806.56193438025;44409.77795111004;44535;44733;45633;37098.81450592838;37135.81432092822;38161.23677526489;38473.615263847;38997.61002390053;36892.262154756216;37447.43828842624;37664.81167594145;37887;38319.808400957816;36540.442169047914;36636.633633663325;36915.81542092272;37099.443508346856;37129.81435092807;32579.511307329936;33327.50008749822;33346;34181.829090854386;34390.656093438745;26049;26233.868830656487;27473;28478.57282140811;29417.705822941498 19:59:56 INFO - 2015-11-20 19:59:56,226 DEBUG : BROWSER_OUTPUT: |2;jquery.html;338.70025027850363;343.11305275861895;343.5842630417195;345.15265024365186;347.14948376477633;16111.919440402797;16340.91829540852;17305;17601.735973960367;17933.103344832773;10770.192235582343;11456.599019034335;16067.437639682614;16155.676886462265;16170.19149042546;4853;5031.823886163985;5045.495450454961;5045.924311135336;5062.620303477235;4992.201247800353;5023.899522009558;5034.5468907798295;5039;5045.243213517983;4860.878478038059;4948.307236986807;5006.148954677714;5024.82413115541;5144.845654630349;5136.974315128437;5163.302954101224;5176.0683077046115;5179.119549676564;5205.089109405839;4650.441946966385;5381.327334083239;5419.187121931703;5426.891462170774;5431.511163995259;12084.577039803564;12295.323757193351;13826.65433364174;20119.0946407412;20141.09365078575;2028.7565492141036;2037.4397040813747;2051.98974005129;2088.968665470019;2111.3349294972036;9363.76590585234;9453.101955314234;9589.18491928187;9610.038996100335;9638.855417168748;1775.1301862087614;1791.7222830461299;1799.514131184586;1837.843783278423;1910.2263583248807;58417;59306.703466482824;59577.106343404885;61150.694246528925;62017.10837470433;9739.756506087262;10071.194304455626;10153.695389138338;10189.54147063384;10532.42013697936;13255.801162982563;13255.93372033153;13263.535776247785;13344.733105337838;13351.46594136243;7531;7653.961730191313;7787.3770098392;7828.138904720477;7830.960845195737;7615.276548727862;7619.69521219145;7620.5808680522;7646.923530764732;7654.502457340255;4406.361077643724;4444.977775111104;4504.48198457175;4538.704984176018;4564.885877853014;1778.4664600619762;1786.9553261168576;1788.0791392432907;1796.2904652662125;1831.4963385069213;396.64103985892814;411.5185233277073;411.94232807406985;419.9412082308479;944.527736131934;10152.492375381202;10517.579296828042;10756.731081723019;10899.564017439372;10911.781764364669;426.42645641611983;429.5275197283026;432.0236266038712;442.4513603132093;447.94624645042154;5914.615549989237;5917.792877249276;5927.851803704942;5966.731497082642;5984.281886173687;543295;543936;550247;558930;560381;74705.25294746982;76076;76938.61530692311;77198.61400692961;77305;456.37932411919763;459.29498220231784;460.9677322587387;461.10085333599613;461.1284671970046;9818.85271720939;9909.702708918456;10010.399376037461;10036.247281453774;10157.933416991405;34448.31103377968;34472.310553789284;34566.65433345635;34599.308013840084;34664.48003279902;45457.77271113623;46937.53062469332;47052.29421558611;47307.52692473169;48197;9464.148226659634;9514.904850951401;9520.809583808146;9958.203343732339;10014.499275036365;17349.306027759252;17815.554611134827;17969.191386387905;17971.640567188322;18029.188686509402;14240;14338.068025578305;14401.855981440052;14638.853611464176;14881.181535015678;13798.862011379757;14176.787348189579;14239.932005099452;14364.425422982964;14842.777358339417;13968.441262349392;14428.783568246276;14517.419303227753;14674.486392976194;15090.17004064787;9001.18989290967;9132.589033493641;9203.953980230055;9271.490068046322;9301.395409298373;9770.169535589555;9843.557039933077;11103.888961110286;14110.78833817473;14515.709685806436 19:59:56 INFO - 2015-11-20 19:59:56,226 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1406.4093080906018;1473.0940471609956;1567.3103834312908;1569.4742261342449;1689.5100420877945;6150.384961503847;6215.347388524207;6238.84402889928;6645.800625981216;6726.966365168168;6917.100776899008;7209.170945341288;7221.241769614194;7225.530340527862;7227.313405226509;2213.9889300553514;2242.3048854855047;2260.1863329201474;2261.08426087434;2264.728232612089;2233.9218127365543;2247.449374903143;2292.060255295329;2292.988535057322;2296.632538793793;2216.523447458796;2222.75549689534;2254.8534345267585;2268.115434980359;2279.042802023146;2156.9568608627897;2181.5964046651343;2194.967075493877;2214.30249471416;2215.4793623498463;2253.5380247049316;2280.8061314788265;2296.6210575255063;2296.8745314795797;2299.0803678528555;7482.289182527706;7501.249875012455;7532.510386824839;7536.924630753732;7543.434242431785;4492.955070449287;4563.954360456386;4580.473245576734;4597.724136551784;4600.746958917258;2944.455275773989;3059.464593696094;3129.9061028168962;3152.1016510294457;3153.30627262002;943.1370296178987;946.3328353510758;953.4088864903804;954.4702690007043;976.3897564022486;10060.597576096947;10079.244056695703;10090.293679442515;10115;10207.948960255226;4040.252553277653;4062.8171732272117;4115.053537686349;4131.029208136086;4161.230172418052;8783.604737786814;8788.516631585197;8797.516136612549;8811.867821982676;8825.338099642553;4518.977405112953;4535.523770004168;4542.318652202196;4545.227311357077;4556.886077848014;4085.55058943516;4112.540048282876;4152.91694166121;4249.723767955073;4256.61690447855;3480.617132115465;3491.1621210909707;3491.2144767427126;3505.789652620851;3527.6472352764517;1066.4347895615335;1068.054771527204;1068.1614932278123;1075.6665433715573;1082.2694681090234;1023.8515415264894;1034.4982683398546;1035.435687550272;1161.8315344275034;1312.835895513061;6783.355581219875;6856.760013399607;6866;6871.312868713088;6909.170899492093;427.6642835374216;429.8173276357598;431.76253060816424;433.37810242301765;434.244414718394;5669.1496275558175;5670.064439367458;5673.177389278614;5674.035413979634;5694.316681998187;8246.505209687319;8443.831123377498;8452.61963211657;8481;8483.897093377822;8871.334649901155;9031.683891063782;9092.181703646704;9175.220106290906;9220.308476864262;7011.088558487364;7037.577745335297;7044.15470143586;7081.787546373617;7116.288371162946;6452.9677351612945;6921.6193109379465;6950.679370919509;6958.721651133898;6966.3730264276455;7801.102873169658;7857.960710196412;7885.974823272938;8028.237317454832;8034.47775894565;7932.881006784787;8035.236652518001;8035.4375193738215;8052.476589021695;8202.425830191829;6772.830679233059;7036.542624729376;7082.433405327664;7083.831167857245;7115.1106111736035;7083.5041547091205;7203;7214.062171917617;7214.494985350975;7236.674349654383;6625.4037136657935;6728.091707619605;6785.59286442815;6810;7019.543729657556;6593.868122637425;6657.73369065232;6697.866042679217;6776.085228494288;6792.728290868507;6453.290138084901;6720.193576770819;6762.120924279812;6793.048973143665;6844.589324640538;6170.5372097092;6259.499240060875;6276.372362763687;6282.654454005074;6290.591111577733;6256.968715156395;6301.212348456443;6310.463610593151;6353.459955903615;6358.491320694241 19:59:56 INFO - 2015-11-20 19:59:56,226 DEBUG : BROWSER_OUTPUT: |4;prototype.html;314.214463840399;314.57689407746585;322.6692640043954;323.20330385599493;327.1592008538058;6250.406211409914;6306.495480361572;6339.3343698911585;6368.649724265164;6499.967500162505;6240.719167637467;6286.937130628692;6293.056041593763;6315.273743519497;6324.462420694235;4584.564466375689;4699.859004229878;4706.035262771124;4778.617710583154;4780.976095119537;4677.929831052537;4724.4566874809325;4725.716457012591;4730;4737.620990320766;4672.415948006499;4679.181143299926;4692.343071969927;4693.741844198567;4694.647901407391;4696.624270058404;4698.459677137122;4699.694519856198;4702.670813043088;4708.058388322315;3963.6036396360423;4052.4731784867777;4054.6553542948886;4061.817218225187;4065.6950728695465;5935.139404786325;5948.553858460633;5953.077273022688;5970.253718285215;5978.55160862937;5446.101393270105;5475.123980163195;5476.808311709071;5479.0959491683825;5485.0949593317055;6509.121268628769;6597.076409302702;6628.403443690091;6648.069270302161;6673.532852700313;4478.664100192466;4482.955170448319;4485.170243504962;4493.438320209973;4501.864944051684;6914.688839002257;6942.305769423067;6974.988626649108;6988.860222795515;7001.194862590816;4579.129965306648;4581.129585378767;4588.059447813191;4588.449386073626;4590.67865249436;4551.180787458289;4582.152301824173;4626.768661566975;4630.328602352707;4640.932585505285;5449.346078470529;5449.591280653967;5455.972720136374;5458.536024437888;5462.617616766788;6747.392734653905;6759.864802704017;6762.83092922671;6764;6769.424598909148;1616.0869108953405;1622.0105735501336;1630.7146249406308;1634.0685809088704;1634.7384418492984;1062.2776511971779;1068.7915856407926;1070.577122036791;1073.0396295315804;1091.9181061420425;6455.644939528277;6576.736930522821;6578.079068930354;6590.604563726191;6593.175853018372;7005.1944026436595;7042.7887163385185;7044.859102817915;7049.7885063448175;7066.434685225169;6589.341065893468;6634.402903738686;6639.43564796988;6640.900386494206;6649.767258145942;3733.6453036961443;3768.566614839274;3784.735068545175;3807.600201978808;3812.5234345706785;7221.24176961422;7224.133104027445;7239.095113110861;7244.529105608119;7260.419166466776;7196.96401517989;7205.92794072063;7207.207207207203;7217.783466496014;7221.819454513679;7059.964700176466;7250.891236631454;7263.455240856957;7268.672909719181;7270.272972702687;7053.047838541731;7055.118110236221;7060.505764596634;7061.611611361424;7074.221835598183;6926.549774264657;6959.686814093277;6966.059581956371;6970.059042029261;6977.232504424611;7038.788836334713;7207.639618018973;7260.528065675925;7268.309510596697;7271.4546409020595;4568.588827005586;4598.218302888584;4608.055348653451;4608.907821843477;4621;7001.124859392576;7001.474889383215;7023.192332881579;7037.542559733601;7038.964805175941;6605.867882642417;6776.98345248197;6825.522213445011;6838.350356716104;6853.725850966105;6767.898481522682;6789.1852977643;6805.591664500146;6812.0803691503;6819.727210911707;6510.7721229756735;6625.403713665601;6676.599404035774;6679.365460281266;6685;6488.545801793829;6652.966735166487;6849.760258390932;6854;6861.245263021164;6522;6634.668266586555;6639.070530125883;6675.165604299463;6691.799246022627 19:59:56 INFO - 2015-11-20 19:59:56,228 DEBUG : BROWSER_OUTPUT: |5;yui.html;799.4683535448927;825.8596038673425;827.2967977219363;854.4189950833435;890.09655199972;12759.681007974794;13004.54484093057;13026.283554404505;13159.60521184366;13213.27326997016;12793.168444051153;12833.743325133515;12989.155704879176;13734.656633584165;13756.174629522237;824.6577670266832;829.929455996241;840.6385254340662;840.8990921089478;842.2714352085433;833.5332213960202;837.3050368194384;838.9454685445457;839.3788596438652;839.8572242718752;860.178529504325;864.6325311742515;865.9307255419583;869.2133619074748;872.0930232558131;857.1471385970937;858.3347905373323;858.9226969572768;861.0958493581745;862.9784255393633;639.5075791640411;639.8016614849365;641.102456560814;641.3073880209363;643.703896207745;13742.725145497034;13817.378217980215;13843.86156138446;13853.584392468141;13856.376463059187;12100.878991210064;12135.696607584881;12282.324472154029;12320.445579948924;12555.435005424777;9940.701778946643;9969.601215951354;9991.200703943667;10079.496025198783;10152.746181345452;3621.764585301947;3622.764520306198;3644.0525463379713;3698.85204591816;3784.4890939723336;50967.49032509702;51192.488075119516;51382.7430862847;51631;51766;9962.252831037702;10002.649907253211;10121.493925303852;10156;10160.644377446903;17959.281628734967;18036;18064.729029064576;18121.728174077398;18177.454676359732;6908.205556361083;7013.438924885997;7346;7683.0780306363595;7786.1824508426935;4169.91660166801;4182.64447521964;4207.495100587949;4219.092895027584;4255.5318914919335;3032.302570408774;3040.7567394608377;3065.984670076635;3069.3247485553143;3070.293832418556;546.1698218707543;549.716895798664;561.2731512691075;564.8474911773798;565.3922033813667;575.9683217423081;612.7365232949785;646.8479907221799;673.5049738442241;676.8612434450926;8256.958715206505;8327.125651806595;8396.370272229608;8511.914880851236;8532.8720069199;545.961782675209;646.8556734425458;656.9080328753978;670.9463242940553;689.5931400473745;3752.5684546277525;3957.1294315250598;4034.616711412411;4037.5356833963883;4119.9176016480105;59236;59341.70329148413;59402.405975939684;59980.70009650011;60050;46902.5309746905;48107;49014.75492622514;49841.75079124654;50000.24999625009;47219.05561888743;47475.05049899052;47677.76161119172;49105.263421048716;49160.26259606109;8571.785705357415;8702.82594348122;8750.431221970552;8781.585941528687;8892.555372231232;33626;33841.661583384834;34602.13494662654;34733.47899781455;34907.127321816144;40641.59358406378;42874;43229.135417292106;46146.76926615345;46444;10911.345319280868;10953.288036277616;11016.394098324668;11082.445877706245;11132.109431245643;12187.51249949992;12506.499740010298;12592.622221333375;12868.227906325275;12984.740305193654;10965.342079475256;11116.833247501132;11192.776144477228;11574;11846;11199;11325.15061370417;11775.293482391084;12115.636530904087;12183.208091474025;10079.546420410952;11128.88871111311;11264.887351126385;11313.490892910004;11836.408179591159;9635;9716.659916902874;9838.557264923238;10045.949770251102;10101.24240681937;8829.33779966518;9382.390144640576;9411.29415293842;9931.00689931001;9972.900270997487 19:59:56 INFO - 2015-11-20 19:59:56,228 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:59:56 INFO - 2015-11-20 19:59:56,228 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:59:56 INFO - 2015-11-20 19:59:56,228 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,327 19:59:56 INFO - 2015-11-20 19:59:56,228 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:59:56 INFO - 2015-11-20 19:59:56,228 DEBUG : BROWSER_OUTPUT: __startTimestamp1448078396217__endTimestamp 19:59:56 INFO - 2015-11-20 19:59:56,228 DEBUG : BROWSER_OUTPUT: 19:59:56 INFO - 2015-11-20 19:59:56,229 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:59:56 INFO - 2015-11-20 19:59:56,229 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:59:56 INFO - 2015-11-20 19:59:56,229 DEBUG : BROWSER_OUTPUT: 19:59:56 INFO - 2015-11-20 19:59:56,229 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5427.78 Median:5647.24 stddev:604.68 (10.7%) stddev-sans-first:580.96 19:59:56 INFO - 2015-11-20 19:59:56,229 DEBUG : BROWSER_OUTPUT: Values: 3209.8 3221.2 3273.6 3287.2 3289.9 5231.4 5397.2 5402.6 5436.9 5439.3 5335.3 5335.6 5362.1 5450.8 5472.0 4813.1 4878.5 4936.3 4937.7 4973.1 4975.5 4979.8 5115.5 5135.2 5181.4 4820.8 4898.0 5037.2 5054.4 5144.4 4872.6 4986.3 4992.7 5007.0 5009.2 4944.7 4980.9 4983.4 4985.5 5022.1 5070.9 5170.4 5174.1 5245.2 5252.8 5823.1 5833.6 5843.1 5859.1 5916.1 5847.9 5854.7 5870.1 5873.0 5875.0 5309.5 5359.8 5394.9 5455.6 5463.1 5951.9 6057.2 6061.8 6099.3 6106.1 5844.0 5854.1 5873.4 5874.4 5895.3 5749.6 5754.1 5900.8 5915.0 5948.9 5800.9 5826.4 5829.6 5868.8 5872.6 5795.2 5856.9 5861.8 5875.7 5885.5 4397.6 4407.7 4437.8 4495.1 4514.3 4001.2 4017.1 4035.8 4044.7 4052.3 5362.0 5542.8 5591.9 5594.1 5598.7 5682.2 5726.6 5759.5 5784.7 5821.5 5627.4 5656.2 5656.7 5671.2 5674.7 4925.4 5033.0 5146.5 5171.8 5219.3 5828.1 5936.6 5944.3 5950.6 5968.3 5834.6 5878.9 5886.6 5922.2 5929.3 5836.4 5877.3 5914.8 6018.3 6029.2 5849.0 5856.3 5869.8 5872.1 5873.8 5886.2 5916.8 5940.4 5941.8 5953.6 5551.2 5604.2 5653.8 5740.1 5770.5 5671.4 5676.6 5702.5 5737.8 5743.0 5599.9 5634.4 5638.3 5641.5 5645.9 5558.7 5655.3 5658.2 5699.8 5729.2 5623.7 5633.3 5635.9 5647.2 5704.5 19:59:56 INFO - 2015-11-20 19:59:56,229 DEBUG : BROWSER_OUTPUT: 19:59:56 INFO - 2015-11-20 19:59:56,229 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:52945.40 Median:215213.40 stddev:98971.86 (46.0%) stddev-sans-first:99171.29 19:59:56 INFO - 2015-11-20 19:59:56,231 DEBUG : BROWSER_OUTPUT: Values: 540.3 577.9 595.7 596.4 600.4 38133.4 39126.8 39212.8 39545.6 39609.0 42687.8 43337.3 43392.0 43400.3 43500.1 8765.1 8906.4 8908.3 8910.2 8936.0 8724.6 8768.4 8804.5 8816.7 8848.0 8769.3 8819.5 8887.5 8895.8 8899.1 8753.5 8764.4 8823.3 8826.2 8826.9 8667.1 8779.6 8783.3 8795.5 8821.2 40623.2 40739.4 41141.2 41226.4 41229.2 3151.5 3243.4 3310.9 3549.4 3550.1 30063.4 30187.2 30234.5 30337.0 31288.2 2860.3 2865.5 2889.4 2995.3 3226.4 421072.0 425368.0 425407.0 425941.6 426885.0 41741.0 42410.6 42568.1 58723.1 59157.0 41659.2 41679.0 41880.6 41905.6 41906.8 14979.3 15035.4 15042.2 15120.0 15124.8 12059.2 12157.6 12193.5 12208.9 12237.5 14294.1 14515.6 14527.2 14538.9 14552.9 5509.2 5637.0 5642.7 5658.2 5673.9 908.2 914.6 947.2 1041.4 1072.0 28625.4 33122.2 33404.8 33925.7 34058.7 1017.9 1041.6 1048.9 1084.3 1129.1 15017.4 16569.9 17295.0 17386.7 17539.1 388453.0 391300.0 391402.0 391769.0 393021.0 55235.0 55845.4 55872.7 55901.0 55907.0 1330.2 1334.7 1343.2 1353.4 1358.2 29994.7 30700.7 30820.2 30822.0 31191.7 46583.5 46946.8 47224.3 47284.3 47290.0 297411.0 297987.0 298436.0 299025.0 299185.0 32974.8 46146.0 46565.5 46959.8 47970.8 43806.6 44409.8 44535.0 44733.0 45633.0 37098.8 37135.8 38161.2 38473.6 38997.6 36892.3 37447.4 37664.8 37887.0 38319.8 36540.4 36636.6 36915.8 37099.4 37129.8 32579.5 33327.5 33346.0 34181.8 34390.7 26049.0 26233.9 27473.0 28478.6 29417.7 19:59:56 INFO - 2015-11-20 19:59:56,231 DEBUG : BROWSER_OUTPUT: 19:59:56 INFO - 2015-11-20 19:59:56,231 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28347.19 Median:2446.46 stddev:90142.98 (3684.6%) stddev-sans-first:90371.32 19:59:56 INFO - 2015-11-20 19:59:56,232 DEBUG : BROWSER_OUTPUT: Values: 338.7 343.1 343.6 345.2 347.1 16111.9 16340.9 17305.0 17601.7 17933.1 10770.2 11456.6 16067.4 16155.7 16170.2 4853.0 5031.8 5045.5 5045.9 5062.6 4992.2 5023.9 5034.5 5039.0 5045.2 4860.9 4948.3 5006.1 5024.8 5144.8 5137.0 5163.3 5176.1 5179.1 5205.1 4650.4 5381.3 5419.2 5426.9 5431.5 12084.6 12295.3 13826.7 20119.1 20141.1 2028.8 2037.4 2052.0 2089.0 2111.3 9363.8 9453.1 9589.2 9610.0 9638.9 1775.1 1791.7 1799.5 1837.8 1910.2 58417.0 59306.7 59577.1 61150.7 62017.1 9739.8 10071.2 10153.7 10189.5 10532.4 13255.8 13255.9 13263.5 13344.7 13351.5 7531.0 7654.0 7787.4 7828.1 7831.0 7615.3 7619.7 7620.6 7646.9 7654.5 4406.4 4445.0 4504.5 4538.7 4564.9 1778.5 1787.0 1788.1 1796.3 1831.5 396.6 411.5 411.9 419.9 944.5 10152.5 10517.6 10756.7 10899.6 10911.8 426.4 429.5 432.0 442.5 447.9 5914.6 5917.8 5927.9 5966.7 5984.3 543295.0 543936.0 550247.0 558930.0 560381.0 74705.3 76076.0 76938.6 77198.6 77305.0 456.4 459.3 461.0 461.1 461.1 9818.9 9909.7 10010.4 10036.2 10157.9 34448.3 34472.3 34566.7 34599.3 34664.5 45457.8 46937.5 47052.3 47307.5 48197.0 9464.1 9514.9 9520.8 9958.2 10014.5 17349.3 17815.6 17969.2 17971.6 18029.2 14240.0 14338.1 14401.9 14638.9 14881.2 13798.9 14176.8 14239.9 14364.4 14842.8 13968.4 14428.8 14517.4 14674.5 15090.2 9001.2 9132.6 9204.0 9271.5 9301.4 9770.2 9843.6 11103.9 14110.8 14515.7 19:59:56 INFO - 2015-11-20 19:59:56,232 DEBUG : BROWSER_OUTPUT: 19:59:56 INFO - 2015-11-20 19:59:56,232 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5200.62 Median:6267.94 stddev:2677.74 (42.7%) stddev-sans-first:2670.07 19:59:56 INFO - 2015-11-20 19:59:56,233 DEBUG : BROWSER_OUTPUT: Values: 1406.4 1473.1 1567.3 1569.5 1689.5 6150.4 6215.3 6238.8 6645.8 6727.0 6917.1 7209.2 7221.2 7225.5 7227.3 2214.0 2242.3 2260.2 2261.1 2264.7 2233.9 2247.4 2292.1 2293.0 2296.6 2216.5 2222.8 2254.9 2268.1 2279.0 2157.0 2181.6 2195.0 2214.3 2215.5 2253.5 2280.8 2296.6 2296.9 2299.1 7482.3 7501.2 7532.5 7536.9 7543.4 4493.0 4564.0 4580.5 4597.7 4600.7 2944.5 3059.5 3129.9 3152.1 3153.3 943.1 946.3 953.4 954.5 976.4 10060.6 10079.2 10090.3 10115.0 10207.9 4040.3 4062.8 4115.1 4131.0 4161.2 8783.6 8788.5 8797.5 8811.9 8825.3 4519.0 4535.5 4542.3 4545.2 4556.9 4085.6 4112.5 4152.9 4249.7 4256.6 3480.6 3491.2 3491.2 3505.8 3527.6 1066.4 1068.1 1068.2 1075.7 1082.3 1023.9 1034.5 1035.4 1161.8 1312.8 6783.4 6856.8 6866.0 6871.3 6909.2 427.7 429.8 431.8 433.4 434.2 5669.1 5670.1 5673.2 5674.0 5694.3 8246.5 8443.8 8452.6 8481.0 8483.9 8871.3 9031.7 9092.2 9175.2 9220.3 7011.1 7037.6 7044.2 7081.8 7116.3 6453.0 6921.6 6950.7 6958.7 6966.4 7801.1 7858.0 7886.0 8028.2 8034.5 7932.9 8035.2 8035.4 8052.5 8202.4 6772.8 7036.5 7082.4 7083.8 7115.1 7083.5 7203.0 7214.1 7214.5 7236.7 6625.4 6728.1 6785.6 6810.0 7019.5 6593.9 6657.7 6697.9 6776.1 6792.7 6453.3 6720.2 6762.1 6793.0 6844.6 6170.5 6259.5 6276.4 6282.7 6290.6 6257.0 6301.2 6310.5 6353.5 6358.5 19:59:56 INFO - 2015-11-20 19:59:56,233 DEBUG : BROWSER_OUTPUT: 19:59:56 INFO - 2015-11-20 19:59:56,233 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5598.53 Median:6494.26 stddev:1750.51 (27.0%) stddev-sans-first:1709.89 19:59:56 INFO - 2015-11-20 19:59:56,233 DEBUG : BROWSER_OUTPUT: Values: 314.2 314.6 322.7 323.2 327.2 6250.4 6306.5 6339.3 6368.6 6500.0 6240.7 6286.9 6293.1 6315.3 6324.5 4584.6 4699.9 4706.0 4778.6 4781.0 4677.9 4724.5 4725.7 4730.0 4737.6 4672.4 4679.2 4692.3 4693.7 4694.6 4696.6 4698.5 4699.7 4702.7 4708.1 3963.6 4052.5 4054.7 4061.8 4065.7 5935.1 5948.6 5953.1 5970.3 5978.6 5446.1 5475.1 5476.8 5479.1 5485.1 6509.1 6597.1 6628.4 6648.1 6673.5 4478.7 4483.0 4485.2 4493.4 4501.9 6914.7 6942.3 6975.0 6988.9 7001.2 4579.1 4581.1 4588.1 4588.4 4590.7 4551.2 4582.2 4626.8 4630.3 4640.9 5449.3 5449.6 5456.0 5458.5 5462.6 6747.4 6759.9 6762.8 6764.0 6769.4 1616.1 1622.0 1630.7 1634.1 1634.7 1062.3 1068.8 1070.6 1073.0 1091.9 6455.6 6576.7 6578.1 6590.6 6593.2 7005.2 7042.8 7044.9 7049.8 7066.4 6589.3 6634.4 6639.4 6640.9 6649.8 3733.6 3768.6 3784.7 3807.6 3812.5 7221.2 7224.1 7239.1 7244.5 7260.4 7197.0 7205.9 7207.2 7217.8 7221.8 7060.0 7250.9 7263.5 7268.7 7270.3 7053.0 7055.1 7060.5 7061.6 7074.2 6926.5 6959.7 6966.1 6970.1 6977.2 7038.8 7207.6 7260.5 7268.3 7271.5 4568.6 4598.2 4608.1 4608.9 4621.0 7001.1 7001.5 7023.2 7037.5 7039.0 6605.9 6777.0 6825.5 6838.4 6853.7 6767.9 6789.2 6805.6 6812.1 6819.7 6510.8 6625.4 6676.6 6679.4 6685.0 6488.5 6653.0 6849.8 6854.0 6861.2 6522.0 6634.7 6639.1 6675.2 6691.8 19:59:56 INFO - 2015-11-20 19:59:56,233 DEBUG : BROWSER_OUTPUT: 19:59:56 INFO - 2015-11-20 19:59:56,234 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13887.91 Median:47576.41 stddev:16198.01 (34.0%) stddev-sans-first:16213.63 19:59:56 INFO - 2015-11-20 19:59:56,235 DEBUG : BROWSER_OUTPUT: Values: 799.5 825.9 827.3 854.4 890.1 12759.7 13004.5 13026.3 13159.6 13213.3 12793.2 12833.7 12989.2 13734.7 13756.2 824.7 829.9 840.6 840.9 842.3 833.5 837.3 838.9 839.4 839.9 860.2 864.6 865.9 869.2 872.1 857.1 858.3 858.9 861.1 863.0 639.5 639.8 641.1 641.3 643.7 13742.7 13817.4 13843.9 13853.6 13856.4 12100.9 12135.7 12282.3 12320.4 12555.4 9940.7 9969.6 9991.2 10079.5 10152.7 3621.8 3622.8 3644.1 3698.9 3784.5 50967.5 51192.5 51382.7 51631.0 51766.0 9962.3 10002.6 10121.5 10156.0 10160.6 17959.3 18036.0 18064.7 18121.7 18177.5 6908.2 7013.4 7346.0 7683.1 7786.2 4169.9 4182.6 4207.5 4219.1 4255.5 3032.3 3040.8 3066.0 3069.3 3070.3 546.2 549.7 561.3 564.8 565.4 576.0 612.7 646.8 673.5 676.9 8257.0 8327.1 8396.4 8511.9 8532.9 546.0 646.9 656.9 670.9 689.6 3752.6 3957.1 4034.6 4037.5 4119.9 59236.0 59341.7 59402.4 59980.7 60050.0 46902.5 48107.0 49014.8 49841.8 50000.2 47219.1 47475.1 47677.8 49105.3 49160.3 8571.8 8702.8 8750.4 8781.6 8892.6 33626.0 33841.7 34602.1 34733.5 34907.1 40641.6 42874.0 43229.1 46146.8 46444.0 10911.3 10953.3 11016.4 11082.4 11132.1 12187.5 12506.5 12592.6 12868.2 12984.7 10965.3 11116.8 11192.8 11574.0 11846.0 11199.0 11325.2 11775.3 12115.6 12183.2 10079.5 11128.9 11264.9 11313.5 11836.4 9635.0 9716.7 9838.6 10045.9 10101.2 8829.3 9382.4 9411.3 9931.0 9972.9 19:59:56 INFO - 2015-11-20 19:59:56,235 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:59:56 INFO - 2015-11-20 19:59:56,235 DEBUG : BROWSER_OUTPUT: 19:59:56 INFO - 2015-11-20 19:59:56,957 INFO : Browser exited with error code: 0 19:59:56 INFO - 2015-11-20 19:59:56,976 INFO : Completed test dromaeo_css (00:18:38) 19:59:56 INFO - 2015-11-20 19:59:56,976 INFO : Starting test kraken 19:59:56 INFO - 2015-11-20 19:59:56,976 DEBUG : operating with platform_type : linux_ 19:59:56 INFO - 2015-11-20 19:59:56,976 INFO : Initialising browser for kraken test... 19:59:56 INFO - 2015-11-20 19:59:56,982 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1Lb1Qq/profile http://localhost:52591/getInfo.html 20:00:02 INFO - 2015-11-20 20:00:02,493 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:00:02 INFO - 2015-11-20 20:00:02,493 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:00:02 INFO - 2015-11-20 20:00:02,494 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:00:02 INFO - 2015-11-20 20:00:02,494 DEBUG : BROWSER_OUTPUT: __metrics 20:00:03 INFO - 2015-11-20 20:00:03,661 INFO : Browser initialized. 20:00:03 INFO - 2015-11-20 20:00:03,661 INFO : Running cycle 1/1 for kraken test... 20:00:03 INFO - 2015-11-20 20:00:03,662 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1Lb1Qq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:00:15 INFO - 2015-11-20 20:00:15,435 DEBUG : BROWSER_OUTPUT: RSS: Main: 139907072 20:00:15 INFO - 2015-11-20 20:00:15,435 DEBUG : BROWSER_OUTPUT: 20:00:17 INFO - 2015-11-20 20:00:17,898 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52591/tests/kraken/driver.html?testName=audio-beat-detection) 20:00:18 INFO - 2015-11-20 20:00:18,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 141881344 20:00:18 INFO - 2015-11-20 20:00:18,505 DEBUG : BROWSER_OUTPUT: 20:00:21 INFO - 2015-11-20 20:00:21,163 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52591/tests/kraken/driver.html?testName=audio-dft) 20:00:21 INFO - 2015-11-20 20:00:21,770 DEBUG : BROWSER_OUTPUT: RSS: Main: 142032896 20:00:21 INFO - 2015-11-20 20:00:21,770 DEBUG : BROWSER_OUTPUT: 20:00:24 INFO - 2015-11-20 20:00:24,630 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52591/tests/kraken/driver.html?testName=audio-fft) 20:00:25 INFO - 2015-11-20 20:00:25,212 DEBUG : BROWSER_OUTPUT: RSS: Main: 136667136 20:00:25 INFO - 2015-11-20 20:00:25,213 DEBUG : BROWSER_OUTPUT: 20:00:27 INFO - 2015-11-20 20:00:27,250 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52591/tests/kraken/driver.html?testName=audio-oscillator) 20:00:27 INFO - 2015-11-20 20:00:27,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 137256960 20:00:27 INFO - 2015-11-20 20:00:27,838 DEBUG : BROWSER_OUTPUT: 20:00:30 INFO - 2015-11-20 20:00:30,012 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52591/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:00:30 INFO - 2015-11-20 20:00:30,580 DEBUG : BROWSER_OUTPUT: RSS: Main: 137490432 20:00:30 INFO - 2015-11-20 20:00:30,580 DEBUG : BROWSER_OUTPUT: 20:00:33 INFO - 2015-11-20 20:00:33,592 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52591/tests/kraken/driver.html?testName=imaging-darkroom) 20:00:34 INFO - 2015-11-20 20:00:34,179 DEBUG : BROWSER_OUTPUT: RSS: Main: 138551296 20:00:34 INFO - 2015-11-20 20:00:34,179 DEBUG : BROWSER_OUTPUT: 20:00:37 INFO - 2015-11-20 20:00:37,623 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52591/tests/kraken/driver.html?testName=imaging-desaturate) 20:00:38 INFO - 2015-11-20 20:00:38,216 DEBUG : BROWSER_OUTPUT: RSS: Main: 139681792 20:00:38 INFO - 2015-11-20 20:00:38,216 DEBUG : BROWSER_OUTPUT: 20:00:41 INFO - 2015-11-20 20:00:41,056 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52591/tests/kraken/driver.html?testName=json-parse-financial) 20:00:41 INFO - 2015-11-20 20:00:41,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 139739136 20:00:41 INFO - 2015-11-20 20:00:41,641 DEBUG : BROWSER_OUTPUT: 20:00:43 INFO - 2015-11-20 20:00:43,230 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52591/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:00:43 INFO - 2015-11-20 20:00:43,805 DEBUG : BROWSER_OUTPUT: RSS: Main: 139583488 20:00:43 INFO - 2015-11-20 20:00:43,806 DEBUG : BROWSER_OUTPUT: 20:00:45 INFO - 2015-11-20 20:00:45,648 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52591/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:00:46 INFO - 2015-11-20 20:00:46,249 DEBUG : BROWSER_OUTPUT: RSS: Main: 140353536 20:00:46 INFO - 2015-11-20 20:00:46,249 DEBUG : BROWSER_OUTPUT: 20:00:48 INFO - 2015-11-20 20:00:48,382 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52591/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:00:48 INFO - 2015-11-20 20:00:48,955 DEBUG : BROWSER_OUTPUT: RSS: Main: 139579392 20:00:48 INFO - 2015-11-20 20:00:48,955 DEBUG : BROWSER_OUTPUT: 20:00:51 INFO - 2015-11-20 20:00:51,412 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52591/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:00:52 INFO - 2015-11-20 20:00:52,006 DEBUG : BROWSER_OUTPUT: RSS: Main: 140320768 20:00:52 INFO - 2015-11-20 20:00:52,006 DEBUG : BROWSER_OUTPUT: 20:00:54 INFO - 2015-11-20 20:00:54,607 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52591/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:00:55 INFO - 2015-11-20 20:00:55,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 140537856 20:00:55 INFO - 2015-11-20 20:00:55,193 DEBUG : BROWSER_OUTPUT: 20:00:56 INFO - 2015-11-20 20:00:56,881 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52591/tests/kraken/driver.html?testName=ai-astar) 20:00:57 INFO - 2015-11-20 20:00:57,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 139030528 20:00:57 INFO - 2015-11-20 20:00:57,131 DEBUG : BROWSER_OUTPUT: 20:00:57 INFO - 2015-11-20 20:00:57,131 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:00:57 INFO - 2015-11-20 20:00:57,131 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:00:57 INFO - 2015-11-20 20:00:57,131 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:00:57 INFO - 2015-11-20 20:00:57,131 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:00:57 INFO - 2015-11-20 20:00:57,132 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;105;110;111;112;123;109;110;110;110 20:00:57 INFO - 2015-11-20 20:00:57,132 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;130;154;166;125;149;155;130;163;129 20:00:57 INFO - 2015-11-20 20:00:57,132 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;162;161;162;161;162;166;169;162 20:00:57 INFO - 2015-11-20 20:00:57,132 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;72;160;73;73;72;73;165;72 20:00:57 INFO - 2015-11-20 20:00:57,132 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;136;91;91;92;141;91;91;129 20:00:57 INFO - 2015-11-20 20:00:57,132 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;109;110;110;110;110;110 20:00:57 INFO - 2015-11-20 20:00:57,132 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;147;150;147;147;149;146;147;146 20:00:57 INFO - 2015-11-20 20:00:57,132 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;97;96;97;97;96;96;96;97 20:00:57 INFO - 2015-11-20 20:00:57,132 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;64;62;61;60;60;64;63;60;62;61 20:00:57 INFO - 2015-11-20 20:00:57,132 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;68;70;69;70;70;71;70 20:00:57 INFO - 2015-11-20 20:00:57,132 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;85;94;85;86;85;87;85;95;101 20:00:57 INFO - 2015-11-20 20:00:57,132 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;118;133;120;118;122;116;119;116;125 20:00:57 INFO - 2015-11-20 20:00:57,132 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;151;152;150;150;161;149;148;160;148 20:00:57 INFO - 2015-11-20 20:00:57,132 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;69;68;68;70;67;66;67;68 20:00:57 INFO - 2015-11-20 20:00:57,132 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:00:57 INFO - 2015-11-20 20:00:57,133 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:00:57 INFO - 2015-11-20 20:00:57,133 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,723 20:00:57 INFO - 2015-11-20 20:00:57,133 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:00:57 INFO - 2015-11-20 20:00:57,133 DEBUG : BROWSER_OUTPUT: __startTimestamp1448078457129__endTimestamp 20:00:57 INFO - 2015-11-20 20:00:57,133 DEBUG : BROWSER_OUTPUT: 20:00:57 INFO - 2015-11-20 20:00:57,141 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:00:57 INFO - 2015-11-20 20:00:57,141 DEBUG : BROWSER_OUTPUT: Number of tests: 14 20:00:57 INFO - 2015-11-20 20:00:57,141 DEBUG : BROWSER_OUTPUT: 20:00:57 INFO - 2015-11-20 20:00:57,141 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.00 Median:110.00 stddev:4.59 (4.2%) stddev-sans-first:4.86 20:00:57 INFO - 2015-11-20 20:00:57,141 DEBUG : BROWSER_OUTPUT: Values: 110.0 105.0 110.0 111.0 112.0 123.0 109.0 110.0 110.0 110.0 20:00:57 INFO - 2015-11-20 20:00:57,141 DEBUG : BROWSER_OUTPUT: 20:00:57 INFO - 2015-11-20 20:00:57,141 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.10 Median:152.00 stddev:15.25 (10.0%) stddev-sans-first:16.07 20:00:57 INFO - 2015-11-20 20:00:57,141 DEBUG : BROWSER_OUTPUT: Values: 150.0 130.0 154.0 166.0 125.0 149.0 155.0 130.0 163.0 129.0 20:00:57 INFO - 2015-11-20 20:00:57,141 DEBUG : BROWSER_OUTPUT: 20:00:57 INFO - 2015-11-20 20:00:57,141 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.80 Median:162.00 stddev:2.62 (1.6%) stddev-sans-first:2.69 20:00:57 INFO - 2015-11-20 20:00:57,141 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 162.0 161.0 162.0 161.0 162.0 166.0 169.0 162.0 20:00:57 INFO - 2015-11-20 20:00:57,141 DEBUG : BROWSER_OUTPUT: 20:00:57 INFO - 2015-11-20 20:00:57,141 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.60 Median:73.00 stddev:37.92 (51.9%) stddev-sans-first:39.68 20:00:57 INFO - 2015-11-20 20:00:57,141 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 72.0 160.0 73.0 73.0 72.0 73.0 165.0 72.0 20:00:57 INFO - 2015-11-20 20:00:57,142 DEBUG : BROWSER_OUTPUT: 20:00:57 INFO - 2015-11-20 20:00:57,142 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.30 Median:91.00 stddev:21.61 (23.7%) stddev-sans-first:22.29 20:00:57 INFO - 2015-11-20 20:00:57,142 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 136.0 91.0 91.0 92.0 141.0 91.0 91.0 129.0 20:00:57 INFO - 2015-11-20 20:00:57,142 DEBUG : BROWSER_OUTPUT: 20:00:57 INFO - 2015-11-20 20:00:57,142 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:00:57 INFO - 2015-11-20 20:00:57,142 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 109.0 110.0 110.0 110.0 110.0 110.0 20:00:57 INFO - 2015-11-20 20:00:57,142 DEBUG : BROWSER_OUTPUT: 20:00:57 INFO - 2015-11-20 20:00:57,142 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:1.25 (0.9%) stddev-sans-first:1.32 20:00:57 INFO - 2015-11-20 20:00:57,142 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 147.0 150.0 147.0 147.0 149.0 146.0 147.0 146.0 20:00:57 INFO - 2015-11-20 20:00:57,142 DEBUG : BROWSER_OUTPUT: 20:00:57 INFO - 2015-11-20 20:00:57,142 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 20:00:57 INFO - 2015-11-20 20:00:57,142 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 97.0 96.0 97.0 97.0 96.0 96.0 96.0 97.0 20:00:57 INFO - 2015-11-20 20:00:57,142 DEBUG : BROWSER_OUTPUT: 20:00:57 INFO - 2015-11-20 20:00:57,142 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.70 Median:62.00 stddev:1.57 (2.5%) stddev-sans-first:1.42 20:00:57 INFO - 2015-11-20 20:00:57,142 DEBUG : BROWSER_OUTPUT: Values: 64.0 62.0 61.0 60.0 60.0 64.0 63.0 60.0 62.0 61.0 20:00:57 INFO - 2015-11-20 20:00:57,143 DEBUG : BROWSER_OUTPUT: 20:00:57 INFO - 2015-11-20 20:00:57,143 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:70.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 20:00:57 INFO - 2015-11-20 20:00:57,143 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 68.0 70.0 69.0 70.0 70.0 71.0 70.0 20:00:57 INFO - 2015-11-20 20:00:57,143 DEBUG : BROWSER_OUTPUT: 20:00:57 INFO - 2015-11-20 20:00:57,143 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:85.50 stddev:5.75 (6.7%) stddev-sans-first:5.93 20:00:57 INFO - 2015-11-20 20:00:57,143 DEBUG : BROWSER_OUTPUT: Values: 85.0 85.0 94.0 85.0 86.0 85.0 87.0 85.0 95.0 101.0 20:00:57 INFO - 2015-11-20 20:00:57,143 DEBUG : BROWSER_OUTPUT: 20:00:57 INFO - 2015-11-20 20:00:57,143 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.10 Median:121.00 stddev:5.20 (4.3%) stddev-sans-first:5.40 20:00:57 INFO - 2015-11-20 20:00:57,143 DEBUG : BROWSER_OUTPUT: Values: 124.0 118.0 133.0 120.0 118.0 122.0 116.0 119.0 116.0 125.0 20:00:57 INFO - 2015-11-20 20:00:57,143 DEBUG : BROWSER_OUTPUT: 20:00:57 INFO - 2015-11-20 20:00:57,143 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.00 Median:150.50 stddev:5.83 (3.9%) stddev-sans-first:4.94 20:00:57 INFO - 2015-11-20 20:00:57,143 DEBUG : BROWSER_OUTPUT: Values: 141.0 151.0 152.0 150.0 150.0 161.0 149.0 148.0 160.0 148.0 20:00:57 INFO - 2015-11-20 20:00:57,143 DEBUG : BROWSER_OUTPUT: 20:00:57 INFO - 2015-11-20 20:00:57,143 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.50 stddev:1.20 (1.7%) stddev-sans-first:1.22 20:00:57 INFO - 2015-11-20 20:00:57,143 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 68.0 68.0 70.0 67.0 66.0 67.0 68.0 20:00:57 INFO - 2015-11-20 20:00:57,144 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:00:57 INFO - 2015-11-20 20:00:57,144 DEBUG : BROWSER_OUTPUT: 20:00:58 INFO - 2015-11-20 20:00:58,073 INFO : Browser exited with error code: 0 20:00:58 INFO - 2015-11-20 20:00:58,124 INFO : Completed test kraken (00:01:01) 20:00:58 INFO - 2015-11-20 20:00:58,125 INFO : Starting test v8_7 20:00:58 INFO - 2015-11-20 20:00:58,125 DEBUG : operating with platform_type : linux_ 20:00:58 INFO - 2015-11-20 20:00:58,125 INFO : Initialising browser for v8_7 test... 20:00:58 INFO - 2015-11-20 20:00:58,131 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1IHZLW/profile http://localhost:52591/getInfo.html 20:01:03 INFO - 2015-11-20 20:01:03,694 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:01:03 INFO - 2015-11-20 20:01:03,695 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:01:03 INFO - 2015-11-20 20:01:03,695 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:01:03 INFO - 2015-11-20 20:01:03,695 DEBUG : BROWSER_OUTPUT: __metrics 20:01:04 INFO - 2015-11-20 20:01:04,985 INFO : Browser initialized. 20:01:04 INFO - 2015-11-20 20:01:04,985 INFO : Running cycle 1/1 for v8_7 test... 20:01:04 INFO - 2015-11-20 20:01:04,986 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1IHZLW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:01:16 INFO - 2015-11-20 20:01:16,794 DEBUG : BROWSER_OUTPUT: RSS: Main: 139997184 20:01:16 INFO - 2015-11-20 20:01:16,795 DEBUG : BROWSER_OUTPUT: 20:01:38 INFO - 2015-11-20 20:01:38,191 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52591/tests/v8_7/run.html (next: http://localhost:52591/tests/v8_7/run.html) 20:01:38 INFO - 2015-11-20 20:01:38,442 DEBUG : BROWSER_OUTPUT: RSS: Main: 138547200 20:01:38 INFO - 2015-11-20 20:01:38,442 DEBUG : BROWSER_OUTPUT: 20:01:38 INFO - 2015-11-20 20:01:38,443 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:01:38 INFO - 2015-11-20 20:01:38,443 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:01:38 INFO - 2015-11-20 20:01:38,443 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:01:38 INFO - 2015-11-20 20:01:38,443 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:01:38 INFO - 2015-11-20 20:01:38,444 DEBUG : BROWSER_OUTPUT: |0;Richards;166.19577862722286 20:01:38 INFO - 2015-11-20 20:01:38,444 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.93857965451056 20:01:38 INFO - 2015-11-20 20:01:38,444 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.2690582959641 20:01:38 INFO - 2015-11-20 20:01:38,444 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 20:01:38 INFO - 2015-11-20 20:01:38,444 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1053.740779768177 20:01:38 INFO - 2015-11-20 20:01:38,444 DEBUG : BROWSER_OUTPUT: |5;Earley;745.7121551081283 20:01:38 INFO - 2015-11-20 20:01:38,444 DEBUG : BROWSER_OUTPUT: |6;Boyer;12192.77108433735 20:01:38 INFO - 2015-11-20 20:01:38,445 DEBUG : BROWSER_OUTPUT: |7;RegExp;25225 20:01:38 INFO - 2015-11-20 20:01:38,445 DEBUG : BROWSER_OUTPUT: |8;Splay;616.0767846430714 20:01:38 INFO - 2015-11-20 20:01:38,445 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 20:01:38 INFO - 2015-11-20 20:01:38,445 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:01:38 INFO - 2015-11-20 20:01:38,445 DEBUG : BROWSER_OUTPUT: __startTimestamp1448078498442__endTimestamp 20:01:38 INFO - 2015-11-20 20:01:38,446 DEBUG : BROWSER_OUTPUT: 20:01:38 INFO - 2015-11-20 20:01:38,446 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:01:38 INFO - 2015-11-20 20:01:38,446 DEBUG : BROWSER_OUTPUT: Number of tests: 10 20:01:38 INFO - 2015-11-20 20:01:38,446 DEBUG : BROWSER_OUTPUT: 20:01:38 INFO - 2015-11-20 20:01:38,446 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.20 Median:166.20 stddev:0.00 (0.0%) 20:01:38 INFO - 2015-11-20 20:01:38,446 DEBUG : BROWSER_OUTPUT: Values: 166.2 20:01:38 INFO - 2015-11-20 20:01:38,448 DEBUG : BROWSER_OUTPUT: 20:01:38 INFO - 2015-11-20 20:01:38,448 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.94 Median:191.94 stddev:0.00 (0.0%) 20:01:38 INFO - 2015-11-20 20:01:38,448 DEBUG : BROWSER_OUTPUT: Values: 191.9 20:01:38 INFO - 2015-11-20 20:01:38,448 DEBUG : BROWSER_OUTPUT: 20:01:38 INFO - 2015-11-20 20:01:38,448 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.27 Median:280.27 stddev:0.00 (0.0%) 20:01:38 INFO - 2015-11-20 20:01:38,449 DEBUG : BROWSER_OUTPUT: Values: 280.3 20:01:38 INFO - 2015-11-20 20:01:38,449 DEBUG : BROWSER_OUTPUT: 20:01:38 INFO - 2015-11-20 20:01:38,449 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 20:01:38 INFO - 2015-11-20 20:01:38,449 DEBUG : BROWSER_OUTPUT: Values: 5040.2 20:01:38 INFO - 2015-11-20 20:01:38,449 DEBUG : BROWSER_OUTPUT: 20:01:38 INFO - 2015-11-20 20:01:38,449 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1053.74 Median:1053.74 stddev:0.00 (0.0%) 20:01:38 INFO - 2015-11-20 20:01:38,449 DEBUG : BROWSER_OUTPUT: Values: 1053.7 20:01:38 INFO - 2015-11-20 20:01:38,450 DEBUG : BROWSER_OUTPUT: 20:01:38 INFO - 2015-11-20 20:01:38,450 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:745.71 Median:745.71 stddev:0.00 (0.0%) 20:01:38 INFO - 2015-11-20 20:01:38,450 DEBUG : BROWSER_OUTPUT: Values: 745.7 20:01:38 INFO - 2015-11-20 20:01:38,450 DEBUG : BROWSER_OUTPUT: 20:01:38 INFO - 2015-11-20 20:01:38,450 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12192.77 Median:12192.77 stddev:0.00 (0.0%) 20:01:38 INFO - 2015-11-20 20:01:38,450 DEBUG : BROWSER_OUTPUT: Values: 12192.8 20:01:38 INFO - 2015-11-20 20:01:38,450 DEBUG : BROWSER_OUTPUT: 20:01:38 INFO - 2015-11-20 20:01:38,450 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25225.00 Median:25225.00 stddev:0.00 (0.0%) 20:01:38 INFO - 2015-11-20 20:01:38,451 DEBUG : BROWSER_OUTPUT: Values: 25225.0 20:01:38 INFO - 2015-11-20 20:01:38,451 DEBUG : BROWSER_OUTPUT: 20:01:38 INFO - 2015-11-20 20:01:38,451 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:616.08 Median:616.08 stddev:0.00 (0.0%) 20:01:38 INFO - 2015-11-20 20:01:38,451 DEBUG : BROWSER_OUTPUT: Values: 616.1 20:01:38 INFO - 2015-11-20 20:01:38,451 DEBUG : BROWSER_OUTPUT: 20:01:38 INFO - 2015-11-20 20:01:38,451 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 20:01:38 INFO - 2015-11-20 20:01:38,451 DEBUG : BROWSER_OUTPUT: Values: 4835.7 20:01:38 INFO - 2015-11-20 20:01:38,452 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:01:38 INFO - 2015-11-20 20:01:38,452 DEBUG : BROWSER_OUTPUT: 20:01:39 INFO - 2015-11-20 20:01:39,377 INFO : Browser exited with error code: 0 20:01:39 INFO - 2015-11-20 20:01:39,391 INFO : Completed test v8_7 (00:00:41) 20:01:39 INFO - 2015-11-20 20:01:39,484 INFO : Completed test suite (00:20:20) 20:01:39 INFO - 2015-11-20 20:01:39,485 DEBUG : Working with test: dromaeo_css 20:01:39 INFO - 2015-11-20 20:01:39,485 DEBUG : Generating results file: dromaeo_css 20:01:39 INFO - 2015-11-20 20:01:39,487 DEBUG : Working with test: kraken 20:01:39 INFO - 2015-11-20 20:01:39,487 DEBUG : Generating results file: kraken 20:01:39 INFO - 2015-11-20 20:01:39,487 INFO : javascript benchmark 20:01:39 INFO - 2015-11-20 20:01:39,487 DEBUG : Working with test: v8_7 20:01:39 INFO - 2015-11-20 20:01:39,487 DEBUG : Generating results file: v8_7 20:01:39 INFO - 2015-11-20 20:01:39,488 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:01:39 INFO - 2015-11-20 20:01:39,543 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 20:01:39 INFO - 2015-11-20 20:01:39,543 DEBUG : process_Request line: dromaeo_css 6873.15 graph.html#tests=[[72,64,43]] 20:01:39 INFO - 2015-11-20 20:01:39,544 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:01:39 INFO - 2015-11-20 20:01:39,590 DEBUG : process_Request line: kraken 1527.70 graph.html#tests=[[232,64,43]] 20:01:39 INFO - 2015-11-20 20:01:39,590 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:01:39 INFO - 2015-11-20 20:01:39,627 DEBUG : process_Request line: v8_7 21297.29 graph.html#tests=[[230,64,43]] 20:01:39 INFO - 2015-11-20 20:01:39,628 INFO : javascript benchmark 20:01:39 INFO - 2015-11-20 20:01:39,631 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3209.839508024598, 3221.2430078931447, 3273.5744353234077, 3287.161773747695, 3289.9013029609105, 5231.372235331756, 5397.163439666853, 5402.567794576435, 5436.864078398042, 5439.3200849893765, 5335.33308336458, 5335.599830012755, 5362.0616392131315, 5450.828071964527, 5472.0, 4813.109574728686, 4878.512148785128, 4936.284238785374, 4937.65436419449, 4973.082299753126, 4975.477574854643, 4979.8008079676765, 5115.462876397981, 5135.178371460567, 5181.35233095863, 4820.831270905502, 4898.044881248158, 5037.219231019198, 5054.368203974504, 5144.3826740791155, 4872.585830204402, 4986.2769898364895, 4992.650514463989, 5007.023630392075, 5009.223570346602, 4944.703317800908, 4980.850574482772, 4983.401991761012, 4985.476524964899, 5022.146235139999, 5070.873228169326, 5170.431252562253, 5174.120399532088, 5245.239440281176, 5252.789888404497, 5823.097419899922, 5833.591648584601, 5843.094320380348, 5859.062549991981, 5916.1421593868645, 5847.8538036549, 5854.707264636793, 5870.0607902735355, 5872.970635146797, 5875.0, 5309.548688361494, 5359.839204823823, 5394.91907621386, 5455.645383050089, 5463.125899856004, 5951.880962380728, 6057.151998720183, 6061.787837425669, 6099.2680878294, 6106.114613381035, 5844.0, 5854.121881717776, 5873.353931067579, 5874.441928016831, 5895.322037965689, 5749.626274292157, 5754.136879468113, 5900.763969441175, 5915.0, 5948.910766338508, 5800.88398232033, 5826.446487583673, 5829.591928565044, 5868.765249390062, 5872.647641141545, 5795.217645617872, 5856.882862342729, 5861.824145275648, 5875.706214689249, 5885.529157667376, 4397.582229688174, 4407.669424793089, 4437.755923424178, 4495.100979804052, 4514.25514790056, 4001.1797581495725, 4017.0760725033406, 4035.8183881725395, 4044.69664775143, 4052.3111071117983, 5362.034833729888, 5542.8337149885565, 5591.888162236733, 5594.104943209149, 5598.664080155204, 5682.176084467729, 5726.627769195073, 5759.510441612426, 5784.681842498619, 5821.476067153976, 5627.352854421794, 5656.208130861683, 5656.660600363992, 5671.2060311556415, 5674.687892165971, 4925.38432695913, 5032.974835125801, 5146.485351464824, 5171.7672704728375, 5219.269302297681, 5828.0966450200285, 5936.614120082181, 5944.286685597843, 5950.642961422329, 5968.313643930916, 5834.591578589458, 5878.882422351615, 5886.6173698709445, 5922.200502932049, 5929.347771745019, 5836.445537673914, 5877.265341832271, 5914.822555323347, 6018.307894592178, 6029.216201893726, 5849.005669036359, 5856.267966504187, 5869.7945571904775, 5872.0898260769645, 5873.765049397976, 5886.175935369138, 5916.822495325147, 5940.435658612425, 5941.792037278848, 5953.553483488842, 5551.22282880389, 5604.2154098425435, 5653.773849045992, 5740.1102829061565, 5770.451807078321, 5671.404502527175, 5676.631018983753, 5702.51528620072, 5737.827865164052, 5742.971285143714, 5599.888002239851, 5634.380218175916, 5638.295213098363, 5641.464060914206, 5645.943540564706, 5558.666480011212, 5655.349634791887, 5658.207850900795, 5699.800506982236, 5729.197912292199, 5623.718814059363, 5633.267675202197, 5635.943640563706, 5647.237622920853, 5704.543636509153], "unit": "ms", "name": "dojo.html", "value": 5388.405340141704}, {"lowerIsBetter": false, "replicates": [540.2736224474976, 577.8616126231324, 595.7110801261388, 596.4274296675192, 600.3636145685574, 38133.42799858001, 39126.8043659782, 39212.82361529155, 39545.60454395455, 39609.0, 42687.78656106715, 43337.34993975085, 43392.0, 43400.3489947651, 43500.129997400036, 8765.079666635007, 8906.42108262964, 8908.287337013024, 8910.242629376478, 8936.0, 8724.607392667314, 8768.386212965095, 8804.515751633657, 8816.691415800447, 8848.0, 8769.342299327544, 8819.470831750115, 8887.511186884718, 8895.77760555988, 8899.065598112202, 8753.47479151253, 8764.43031202973, 8823.338249631302, 8826.161514656098, 8826.940767107988, 8667.089955554702, 8779.56102194894, 8783.297336213087, 8795.47227166372, 8821.161989610977, 40623.18753624911, 40739.38890916639, 41141.1771764566, 41226.38160427596, 41229.1754164918, 3151.4957606782805, 3243.351329734063, 3310.9172270693184, 3549.4498352755104, 3550.1124718820297, 30063.398732025238, 30187.245318866986, 30234.54648180279, 30337.0, 31288.21779455509, 2860.2706309891055, 2865.4555634429394, 2889.422115576872, 2995.326051638364, 3226.3547290541987, 421072.0, 425368.0, 425407.0, 425941.57321347314, 426885.0, 41741.0, 42410.57589424128, 42568.14863702709, 58723.119153212734, 59157.0, 41659.1668166641, 41679.0, 41880.58119418767, 41905.58094419078, 41906.790466047474, 14979.325930332943, 15035.398584056735, 15042.247887605576, 15120.0, 15124.848751512563, 12059.155859089955, 12157.63527094171, 12193.451294691582, 12208.938955305166, 12237.510499579917, 14294.142351458946, 14515.637109072357, 14527.201003944885, 14538.85461145375, 14552.85447145536, 5509.173623956439, 5636.97181514098, 5642.7178641067785, 5658.236138121301, 5673.929015909246, 908.169025341818, 914.5564401265381, 947.1570302430843, 1041.390786389955, 1071.981617463413, 28625.427491450053, 33122.17194570155, 33404.83297583545, 33925.66074339225, 34058.65941340555, 1017.8524114003428, 1041.6458404142627, 1048.895110488945, 1084.251866212311, 1129.0910816792398, 15017.399304027716, 16569.91715041441, 17295.0, 17386.65226695459, 17539.123043848012, 388453.0, 391300.0, 391402.0, 391769.0, 393021.0, 55235.0, 55845.441545584836, 55872.72063639656, 55901.0, 55907.0, 1330.2085259270718, 1334.6663334166458, 1343.1605246720799, 1353.4383230959238, 1358.2258112875566, 29994.70005299919, 30700.692993069784, 30820.22949426282, 30822.0, 31191.68808311888, 46583.53416465792, 46946.765266173454, 47224.2916356248, 47284.29073563831, 47290.0, 297411.0, 297987.0, 298436.0, 299025.0, 299185.0, 32974.83512582422, 46146.0, 46565.53434465612, 46959.765201173774, 47970.76014620044, 43806.56193438025, 44409.77795111004, 44535.0, 44733.0, 45633.0, 37098.81450592838, 37135.81432092822, 38161.23677526489, 38473.615263847, 38997.61002390053, 36892.262154756216, 37447.43828842624, 37664.81167594145, 37887.0, 38319.808400957816, 36540.442169047914, 36636.633633663325, 36915.81542092272, 37099.443508346856, 37129.81435092807, 32579.511307329936, 33327.50008749822, 33346.0, 34181.829090854386, 34390.656093438745, 26049.0, 26233.868830656487, 27473.0, 28478.57282140811, 29417.705822941498], "unit": "ms", "name": "ext.html", "value": 18679.39752198168}, {"lowerIsBetter": false, "replicates": [338.70025027850363, 343.11305275861895, 343.5842630417195, 345.15265024365186, 347.14948376477633, 16111.919440402797, 16340.91829540852, 17305.0, 17601.735973960367, 17933.103344832773, 10770.192235582343, 11456.599019034335, 16067.437639682614, 16155.676886462265, 16170.19149042546, 4853.0, 5031.823886163985, 5045.495450454961, 5045.924311135336, 5062.620303477235, 4992.201247800353, 5023.899522009558, 5034.5468907798295, 5039.0, 5045.243213517983, 4860.878478038059, 4948.307236986807, 5006.148954677714, 5024.82413115541, 5144.845654630349, 5136.974315128437, 5163.302954101224, 5176.0683077046115, 5179.119549676564, 5205.089109405839, 4650.441946966385, 5381.327334083239, 5419.187121931703, 5426.891462170774, 5431.511163995259, 12084.577039803564, 12295.323757193351, 13826.65433364174, 20119.0946407412, 20141.09365078575, 2028.7565492141036, 2037.4397040813747, 2051.98974005129, 2088.968665470019, 2111.3349294972036, 9363.76590585234, 9453.101955314234, 9589.18491928187, 9610.038996100335, 9638.855417168748, 1775.1301862087614, 1791.7222830461299, 1799.514131184586, 1837.843783278423, 1910.2263583248807, 58417.0, 59306.703466482824, 59577.106343404885, 61150.694246528925, 62017.10837470433, 9739.756506087262, 10071.194304455626, 10153.695389138338, 10189.54147063384, 10532.42013697936, 13255.801162982563, 13255.93372033153, 13263.535776247785, 13344.733105337838, 13351.46594136243, 7531.0, 7653.961730191313, 7787.3770098392, 7828.138904720477, 7830.960845195737, 7615.276548727862, 7619.69521219145, 7620.5808680522, 7646.923530764732, 7654.502457340255, 4406.361077643724, 4444.977775111104, 4504.48198457175, 4538.704984176018, 4564.885877853014, 1778.4664600619762, 1786.9553261168576, 1788.0791392432907, 1796.2904652662125, 1831.4963385069213, 396.64103985892814, 411.5185233277073, 411.94232807406985, 419.9412082308479, 944.527736131934, 10152.492375381202, 10517.579296828042, 10756.731081723019, 10899.564017439372, 10911.781764364669, 426.42645641611983, 429.5275197283026, 432.0236266038712, 442.4513603132093, 447.94624645042154, 5914.615549989237, 5917.792877249276, 5927.851803704942, 5966.731497082642, 5984.281886173687, 543295.0, 543936.0, 550247.0, 558930.0, 560381.0, 74705.25294746982, 76076.0, 76938.61530692311, 77198.61400692961, 77305.0, 456.37932411919763, 459.29498220231784, 460.9677322587387, 461.10085333599613, 461.1284671970046, 9818.85271720939, 9909.702708918456, 10010.399376037461, 10036.247281453774, 10157.933416991405, 34448.31103377968, 34472.310553789284, 34566.65433345635, 34599.308013840084, 34664.48003279902, 45457.77271113623, 46937.53062469332, 47052.29421558611, 47307.52692473169, 48197.0, 9464.148226659634, 9514.904850951401, 9520.809583808146, 9958.203343732339, 10014.499275036365, 17349.306027759252, 17815.554611134827, 17969.191386387905, 17971.640567188322, 18029.188686509402, 14240.0, 14338.068025578305, 14401.855981440052, 14638.853611464176, 14881.181535015678, 13798.862011379757, 14176.787348189579, 14239.932005099452, 14364.425422982964, 14842.777358339417, 13968.441262349392, 14428.783568246276, 14517.419303227753, 14674.486392976194, 15090.17004064787, 9001.18989290967, 9132.589033493641, 9203.953980230055, 9271.490068046322, 9301.395409298373, 9770.169535589555, 9843.557039933077, 11103.888961110286, 14110.78833817473, 14515.709685806436], "unit": "ms", "name": "jquery.html", "value": 7840.8281398636045}, {"lowerIsBetter": false, "replicates": [1406.4093080906018, 1473.0940471609956, 1567.3103834312908, 1569.4742261342449, 1689.5100420877945, 6150.384961503847, 6215.347388524207, 6238.84402889928, 6645.800625981216, 6726.966365168168, 6917.100776899008, 7209.170945341288, 7221.241769614194, 7225.530340527862, 7227.313405226509, 2213.9889300553514, 2242.3048854855047, 2260.1863329201474, 2261.08426087434, 2264.728232612089, 2233.9218127365543, 2247.449374903143, 2292.060255295329, 2292.988535057322, 2296.632538793793, 2216.523447458796, 2222.75549689534, 2254.8534345267585, 2268.115434980359, 2279.042802023146, 2156.9568608627897, 2181.5964046651343, 2194.967075493877, 2214.30249471416, 2215.4793623498463, 2253.5380247049316, 2280.8061314788265, 2296.6210575255063, 2296.8745314795797, 2299.0803678528555, 7482.289182527706, 7501.249875012455, 7532.510386824839, 7536.924630753732, 7543.434242431785, 4492.955070449287, 4563.954360456386, 4580.473245576734, 4597.724136551784, 4600.746958917258, 2944.455275773989, 3059.464593696094, 3129.9061028168962, 3152.1016510294457, 3153.30627262002, 943.1370296178987, 946.3328353510758, 953.4088864903804, 954.4702690007043, 976.3897564022486, 10060.597576096947, 10079.244056695703, 10090.293679442515, 10115.0, 10207.948960255226, 4040.252553277653, 4062.8171732272117, 4115.053537686349, 4131.029208136086, 4161.230172418052, 8783.604737786814, 8788.516631585197, 8797.516136612549, 8811.867821982676, 8825.338099642553, 4518.977405112953, 4535.523770004168, 4542.318652202196, 4545.227311357077, 4556.886077848014, 4085.55058943516, 4112.540048282876, 4152.91694166121, 4249.723767955073, 4256.61690447855, 3480.617132115465, 3491.1621210909707, 3491.2144767427126, 3505.789652620851, 3527.6472352764517, 1066.4347895615335, 1068.054771527204, 1068.1614932278123, 1075.6665433715573, 1082.2694681090234, 1023.8515415264894, 1034.4982683398546, 1035.435687550272, 1161.8315344275034, 1312.835895513061, 6783.355581219875, 6856.760013399607, 6866.0, 6871.312868713088, 6909.170899492093, 427.6642835374216, 429.8173276357598, 431.76253060816424, 433.37810242301765, 434.244414718394, 5669.1496275558175, 5670.064439367458, 5673.177389278614, 5674.035413979634, 5694.316681998187, 8246.505209687319, 8443.831123377498, 8452.61963211657, 8481.0, 8483.897093377822, 8871.334649901155, 9031.683891063782, 9092.181703646704, 9175.220106290906, 9220.308476864262, 7011.088558487364, 7037.577745335297, 7044.15470143586, 7081.787546373617, 7116.288371162946, 6452.9677351612945, 6921.6193109379465, 6950.679370919509, 6958.721651133898, 6966.3730264276455, 7801.102873169658, 7857.960710196412, 7885.974823272938, 8028.237317454832, 8034.47775894565, 7932.881006784787, 8035.236652518001, 8035.4375193738215, 8052.476589021695, 8202.425830191829, 6772.830679233059, 7036.542624729376, 7082.433405327664, 7083.831167857245, 7115.1106111736035, 7083.5041547091205, 7203.0, 7214.062171917617, 7214.494985350975, 7236.674349654383, 6625.4037136657935, 6728.091707619605, 6785.59286442815, 6810.0, 7019.543729657556, 6593.868122637425, 6657.73369065232, 6697.866042679217, 6776.085228494288, 6792.728290868507, 6453.290138084901, 6720.193576770819, 6762.120924279812, 6793.048973143665, 6844.589324640538, 6170.5372097092, 6259.499240060875, 6276.372362763687, 6282.654454005074, 6290.591111577733, 6256.968715156395, 6301.212348456443, 6310.463610593151, 6353.459955903615, 6358.491320694241], "unit": "ms", "name": "mootools.html", "value": 4205.970785481711}, {"lowerIsBetter": false, "replicates": [314.214463840399, 314.57689407746585, 322.6692640043954, 323.20330385599493, 327.1592008538058, 6250.406211409914, 6306.495480361572, 6339.3343698911585, 6368.649724265164, 6499.967500162505, 6240.719167637467, 6286.937130628692, 6293.056041593763, 6315.273743519497, 6324.462420694235, 4584.564466375689, 4699.859004229878, 4706.035262771124, 4778.617710583154, 4780.976095119537, 4677.929831052537, 4724.4566874809325, 4725.716457012591, 4730.0, 4737.620990320766, 4672.415948006499, 4679.181143299926, 4692.343071969927, 4693.741844198567, 4694.647901407391, 4696.624270058404, 4698.459677137122, 4699.694519856198, 4702.670813043088, 4708.058388322315, 3963.6036396360423, 4052.4731784867777, 4054.6553542948886, 4061.817218225187, 4065.6950728695465, 5935.139404786325, 5948.553858460633, 5953.077273022688, 5970.253718285215, 5978.55160862937, 5446.101393270105, 5475.123980163195, 5476.808311709071, 5479.0959491683825, 5485.0949593317055, 6509.121268628769, 6597.076409302702, 6628.403443690091, 6648.069270302161, 6673.532852700313, 4478.664100192466, 4482.955170448319, 4485.170243504962, 4493.438320209973, 4501.864944051684, 6914.688839002257, 6942.305769423067, 6974.988626649108, 6988.860222795515, 7001.194862590816, 4579.129965306648, 4581.129585378767, 4588.059447813191, 4588.449386073626, 4590.67865249436, 4551.180787458289, 4582.152301824173, 4626.768661566975, 4630.328602352707, 4640.932585505285, 5449.346078470529, 5449.591280653967, 5455.972720136374, 5458.536024437888, 5462.617616766788, 6747.392734653905, 6759.864802704017, 6762.83092922671, 6764.0, 6769.424598909148, 1616.0869108953405, 1622.0105735501336, 1630.7146249406308, 1634.0685809088704, 1634.7384418492984, 1062.2776511971779, 1068.7915856407926, 1070.577122036791, 1073.0396295315804, 1091.9181061420425, 6455.644939528277, 6576.736930522821, 6578.079068930354, 6590.604563726191, 6593.175853018372, 7005.1944026436595, 7042.7887163385185, 7044.859102817915, 7049.7885063448175, 7066.434685225169, 6589.341065893468, 6634.402903738686, 6639.43564796988, 6640.900386494206, 6649.767258145942, 3733.6453036961443, 3768.566614839274, 3784.735068545175, 3807.600201978808, 3812.5234345706785, 7221.24176961422, 7224.133104027445, 7239.095113110861, 7244.529105608119, 7260.419166466776, 7196.96401517989, 7205.92794072063, 7207.207207207203, 7217.783466496014, 7221.819454513679, 7059.964700176466, 7250.891236631454, 7263.455240856957, 7268.672909719181, 7270.272972702687, 7053.047838541731, 7055.118110236221, 7060.505764596634, 7061.611611361424, 7074.221835598183, 6926.549774264657, 6959.686814093277, 6966.059581956371, 6970.059042029261, 6977.232504424611, 7038.788836334713, 7207.639618018973, 7260.528065675925, 7268.309510596697, 7271.4546409020595, 4568.588827005586, 4598.218302888584, 4608.055348653451, 4608.907821843477, 4621.0, 7001.124859392576, 7001.474889383215, 7023.192332881579, 7037.542559733601, 7038.964805175941, 6605.867882642417, 6776.98345248197, 6825.522213445011, 6838.350356716104, 6853.725850966105, 6767.898481522682, 6789.1852977643, 6805.591664500146, 6812.0803691503, 6819.727210911707, 6510.7721229756735, 6625.403713665601, 6676.599404035774, 6679.365460281266, 6685.0, 6488.545801793829, 6652.966735166487, 6849.760258390932, 6854.0, 6861.245263021164, 6522.0, 6634.668266586555, 6639.070530125883, 6675.165604299463, 6691.799246022627], "unit": "ms", "name": "prototype.html", "value": 5012.467391600207}, {"lowerIsBetter": false, "replicates": [799.4683535448927, 825.8596038673425, 827.2967977219363, 854.4189950833435, 890.09655199972, 12759.681007974794, 13004.54484093057, 13026.283554404505, 13159.60521184366, 13213.27326997016, 12793.168444051153, 12833.743325133515, 12989.155704879176, 13734.656633584165, 13756.174629522237, 824.6577670266832, 829.929455996241, 840.6385254340662, 840.8990921089478, 842.2714352085433, 833.5332213960202, 837.3050368194384, 838.9454685445457, 839.3788596438652, 839.8572242718752, 860.178529504325, 864.6325311742515, 865.9307255419583, 869.2133619074748, 872.0930232558131, 857.1471385970937, 858.3347905373323, 858.9226969572768, 861.0958493581745, 862.9784255393633, 639.5075791640411, 639.8016614849365, 641.102456560814, 641.3073880209363, 643.703896207745, 13742.725145497034, 13817.378217980215, 13843.86156138446, 13853.584392468141, 13856.376463059187, 12100.878991210064, 12135.696607584881, 12282.324472154029, 12320.445579948924, 12555.435005424777, 9940.701778946643, 9969.601215951354, 9991.200703943667, 10079.496025198783, 10152.746181345452, 3621.764585301947, 3622.764520306198, 3644.0525463379713, 3698.85204591816, 3784.4890939723336, 50967.49032509702, 51192.488075119516, 51382.7430862847, 51631.0, 51766.0, 9962.252831037702, 10002.649907253211, 10121.493925303852, 10156.0, 10160.644377446903, 17959.281628734967, 18036.0, 18064.729029064576, 18121.728174077398, 18177.454676359732, 6908.205556361083, 7013.438924885997, 7346.0, 7683.0780306363595, 7786.1824508426935, 4169.91660166801, 4182.64447521964, 4207.495100587949, 4219.092895027584, 4255.5318914919335, 3032.302570408774, 3040.7567394608377, 3065.984670076635, 3069.3247485553143, 3070.293832418556, 546.1698218707543, 549.716895798664, 561.2731512691075, 564.8474911773798, 565.3922033813667, 575.9683217423081, 612.7365232949785, 646.8479907221799, 673.5049738442241, 676.8612434450926, 8256.958715206505, 8327.125651806595, 8396.370272229608, 8511.914880851236, 8532.8720069199, 545.961782675209, 646.8556734425458, 656.9080328753978, 670.9463242940553, 689.5931400473745, 3752.5684546277525, 3957.1294315250598, 4034.616711412411, 4037.5356833963883, 4119.9176016480105, 59236.0, 59341.70329148413, 59402.405975939684, 59980.70009650011, 60050.0, 46902.5309746905, 48107.0, 49014.75492622514, 49841.75079124654, 50000.24999625009, 47219.05561888743, 47475.05049899052, 47677.76161119172, 49105.263421048716, 49160.26259606109, 8571.785705357415, 8702.82594348122, 8750.431221970552, 8781.585941528687, 8892.555372231232, 33626.0, 33841.661583384834, 34602.13494662654, 34733.47899781455, 34907.127321816144, 40641.59358406378, 42874.0, 43229.135417292106, 46146.76926615345, 46444.0, 10911.345319280868, 10953.288036277616, 11016.394098324668, 11082.445877706245, 11132.109431245643, 12187.51249949992, 12506.499740010298, 12592.622221333375, 12868.227906325275, 12984.740305193654, 10965.342079475256, 11116.833247501132, 11192.776144477228, 11574.0, 11846.0, 11199.0, 11325.15061370417, 11775.293482391084, 12115.636530904087, 12183.208091474025, 10079.546420410952, 11128.88871111311, 11264.887351126385, 11313.490892910004, 11836.408179591159, 9635.0, 9716.659916902874, 9838.557264923238, 10045.949770251102, 10101.24240681937, 8829.33779966518, 9382.390144640576, 9411.29415293842, 9931.00689931001, 9972.900270997487], "unit": "ms", "name": "yui.html", "value": 6335.658510202035}], "name": "dromaeo_css", "value": 6873.145379822556}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 105.0, 110.0, 111.0, 112.0, 123.0, 109.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [150.0, 130.0, 154.0, 166.0, 125.0, 149.0, 155.0, 130.0, 163.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 145.1}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 162.0, 161.0, 162.0, 161.0, 162.0, 166.0, 169.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 162.8}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 72.0, 160.0, 73.0, 73.0, 72.0, 73.0, 165.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 90.6}, {"lowerIsBetter": true, "replicates": [90.0, 91.0, 136.0, 91.0, 91.0, 92.0, 141.0, 91.0, 91.0, 129.0], "unit": "ms", "name": "audio-oscillator", "value": 104.3}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 150.0, 147.0, 147.0, 149.0, 146.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [64.0, 62.0, 61.0, 60.0, 60.0, 64.0, 63.0, 60.0, 62.0, 61.0], "unit": "ms", "name": "json-parse-financial", "value": 61.7}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 68.0, 70.0, 69.0, 70.0, 70.0, 71.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.5}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 94.0, 85.0, 86.0, 85.0, 87.0, 85.0, 95.0, 101.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 88.8}, {"lowerIsBetter": true, "replicates": [124.0, 118.0, 133.0, 120.0, 118.0, 122.0, 116.0, 119.0, 116.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.1}, {"lowerIsBetter": true, "replicates": [141.0, 151.0, 152.0, 150.0, 150.0, 161.0, 149.0, 148.0, 160.0, 148.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 151.0}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 68.0, 68.0, 70.0, 67.0, 66.0, 67.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.1}], "name": "kraken", "value": 1527.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.19577862722286], "unit": "score", "name": "Richards", "value": 212.41213400000004}, {"lowerIsBetter": false, "replicates": [191.93857965451056], "unit": "score", "name": "DeltaBlue", "value": 344.4747799999999}, {"lowerIsBetter": false, "replicates": [280.2690582959641], "unit": "score", "name": "Encrypt", "value": 949.7338080000005}, {"lowerIsBetter": false, "replicates": [5040.201005025126], "unit": "score", "name": "Decrypt", "value": 52.81158424725827}, {"lowerIsBetter": false, "replicates": [1053.740779768177], "unit": "score", "name": "RayTrace", "value": 702.2495610000001}, {"lowerIsBetter": false, "replicates": [745.7121551081283], "unit": "score", "name": "Earley", "value": 893.7268829999998}, {"lowerIsBetter": false, "replicates": [12192.77108433735], "unit": "score", "name": "Boyer", "value": 54.66050296442688}, {"lowerIsBetter": false, "replicates": [25225.0], "unit": "score", "name": "RegExp", "value": 36.11437066402381}, {"lowerIsBetter": false, "replicates": [616.0767846430714], "unit": "score", "name": "Splay", "value": 132.2740963972736}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21297.29212736987}]} 20:01:39 INFO - RETURN: dromaeo_css: 6873.15 20:01:39 INFO - RETURN: kraken: 1527.70 20:01:39 INFO - RETURN: v8_7: 21297.29 20:01:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21297.29"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1527.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6873.15"}}} 20:01:39 INFO - Return code: 0 20:01:39 INFO - # TBPL SUCCESS # 20:01:39 INFO - Running post-action listener: _resource_record_post_action 20:01:39 INFO - Running post-run listener: _resource_record_post_run 20:01:40 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 16384; Write bytes: 514056192; Read time: 2292; Write time: 1539896 20:01:40 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 100651008; Read time: 0; Write time: 160008 20:01:40 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 16384; Write bytes: 379809792; Read time: 2292; Write time: 1297736 20:01:40 INFO - Running post-run listener: _upload_blobber_files 20:01:40 INFO - Blob upload gear active. 20:01:40 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 20:01:40 INFO - Copying logs to upload dir... 20:01:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1263.985668 ========= master_lag: 1.41 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-11-20 20:01:42.094638) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 20:01:42.099675) ========= 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=a194aa7faa1be204aaca7d660000020b-1448076445.467965-301246221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009857 build_url: 'https://queue.taskcluster.net/v1/task/hn4PGcklSIOWRxOdnWaotQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 20:01:42.130220) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 20:01:42.130630) ========= 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=a194aa7faa1be204aaca7d660000020b-1448076445.467965-301246221 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004568 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 20:01:42.180229) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 20:01:42.180529) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 20:01:42.180835) ========= ========= Total master_lag: 1.60 =========