builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1447555115.49 results: success (0) buildid: 20151114173003 builduid: 445e9c6ca01b45bcb7dd8e5013607a46 revision: 5fb6f8b316ca76a5a4c47464900eaed2774d844f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 18:38:35.494367) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 18:38:35.495066) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-14 18:38:35.495379) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1447554967.110722-66501293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006481 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-14 18:38:35.532794) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-14 18:38:35.533076) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-14 18:38:35.555358) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 18:38:35.555916) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1447554967.110722-66501293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004578 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 18:38:35.612570) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 18:38:35.612914) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 18:38:35.613306) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 18:38:35.613578) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1447554967.110722-66501293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-14 18:38: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% 227M=0s 2015-11-14 18:38:36 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177579 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 18:38:35.808704) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 18:38:35.808993) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1447554967.110722-66501293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018156 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 18:38:35.858260) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 18:38:35.858562) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5fb6f8b316ca76a5a4c47464900eaed2774d844f --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 5fb6f8b316ca76a5a4c47464900eaed2774d844f --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=b4e1481c633df10bed3f4cc0000001c7-1447554967.110722-66501293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-14 18:38:36,693 truncating revision to first 12 chars 2015-11-14 18:38:36,693 Setting DEBUG logging. 2015-11-14 18:38:36,693 attempt 1/10 2015-11-14 18:38:36,693 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5fb6f8b316ca?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-14 18:38:37,024 unpacking tar archive at: fx-team-5fb6f8b316ca/testing/mozharness/ program finished with exit code 0 elapsedTime=0.603490 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 18:38:36.476085) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 18:38:36.476408) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 18:38:36.490446) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 18:38:36.490728) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 18:38:36.491142) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-11-14 18:38:36.491447) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=b4e1481c633df10bed3f4cc0000001c7-1447554967.110722-66501293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:38:37 INFO - MultiFileLogger online at 20151114 18:38:37 in /builds/slave/test-pgo 18:38:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 18:38:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:38:37 INFO - {'append_to_log': False, 18:38:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:38:37 INFO - 'blob_upload_branch': 'Fx-Team', 18:38:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:38:37 INFO - 'branch': 'Fx-Team', 18:38:37 INFO - 'buildbot_json_path': 'buildprops.json', 18:38:37 INFO - 'config_files': ('talos/linux_config.py',), 18:38:37 INFO - 'default_actions': ('clobber', 18:38:37 INFO - 'read-buildbot-config', 18:38:37 INFO - 'download-and-extract', 18:38:37 INFO - 'populate-webroot', 18:38:37 INFO - 'create-virtualenv', 18:38:37 INFO - 'install', 18:38:37 INFO - 'run-tests'), 18:38:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:38:37 INFO - 'download_minidump_stackwalk': True, 18:38:37 INFO - 'download_symbols': 'ondemand', 18:38:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:38:37 INFO - 'tooltool.py': '/tools/tooltool.py', 18:38:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:38:37 INFO - '/tools/misc-python/virtualenv.py')}, 18:38:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:38:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:38:37 INFO - 'installer_path': 'installer.exe', 18:38:37 INFO - 'log_level': 'info', 18:38:37 INFO - 'log_name': 'talos', 18:38:37 INFO - 'log_to_console': True, 18:38:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:38:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:38:37 INFO - 'opt_config_files': (), 18:38:37 INFO - 'pip_index': False, 18:38:37 INFO - 'sps_profile': False, 18:38:37 INFO - 'sps_profile_interval': 0, 18:38:37 INFO - 'suite': 'dromaeojs', 18:38:37 INFO - 'system_bits': '64', 18:38:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:38:37 INFO - 'title': 'talos-linux64-ix-001', 18:38:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:38:37 INFO - 'use_talos_json': True, 18:38:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:38:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:38:37 INFO - 'work_dir': 'build'} 18:38:37 INFO - ##### 18:38:37 INFO - ##### Running clobber step. 18:38:37 INFO - ##### 18:38:37 INFO - Running pre-action listener: _resource_record_pre_action 18:38:37 INFO - Running main action method: clobber 18:38:37 INFO - rmtree: /builds/slave/test-pgo/build 18:38:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:38:38 INFO - Running post-action listener: _resource_record_post_action 18:38:38 INFO - ##### 18:38:38 INFO - ##### Running read-buildbot-config step. 18:38:38 INFO - ##### 18:38:38 INFO - Running pre-action listener: _resource_record_pre_action 18:38:38 INFO - Running main action method: read_buildbot_config 18:38:38 INFO - Using buildbot properties: 18:38:38 INFO - { 18:38:38 INFO - "properties": { 18:38:38 INFO - "buildnumber": 782, 18:38:38 INFO - "product": "firefox", 18:38:38 INFO - "script_repo_revision": "production", 18:38:38 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:38:38 INFO - "repository": "", 18:38:38 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 18:38:38 INFO - "buildid": "20151114173003", 18:38:38 INFO - "slavename": "talos-linux64-ix-001", 18:38:38 INFO - "pgo_build": "True", 18:38:38 INFO - "basedir": "/builds/slave/test-pgo", 18:38:38 INFO - "project": "", 18:38:38 INFO - "platform": "ubuntu64_hw", 18:38:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:38:38 INFO - "slavebuilddir": "test", 18:38:38 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 18:38:38 INFO - "branch": "fx-team", 18:38:38 INFO - "repo_path": "integration/fx-team", 18:38:38 INFO - "stage_platform": "linux64-pgo", 18:38:38 INFO - "builduid": "445e9c6ca01b45bcb7dd8e5013607a46", 18:38:38 INFO - "revision": "5fb6f8b316ca76a5a4c47464900eaed2774d844f" 18:38:38 INFO - }, 18:38:38 INFO - "sourcestamp": { 18:38:38 INFO - "repository": "", 18:38:38 INFO - "hasPatch": false, 18:38:38 INFO - "project": "", 18:38:38 INFO - "branch": "fx-team-linux64-pgo-talos", 18:38:38 INFO - "changes": [ 18:38:38 INFO - { 18:38:38 INFO - "category": null, 18:38:38 INFO - "files": [ 18:38:38 INFO - { 18:38:38 INFO - "url": null, 18:38:38 INFO - "name": "https://queue.taskcluster.net/v1/task/LLvV23HGTOeFi9rqUixZag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 18:38:38 INFO - } 18:38:38 INFO - ], 18:38:38 INFO - "repository": "", 18:38:38 INFO - "rev": "5fb6f8b316ca76a5a4c47464900eaed2774d844f", 18:38:38 INFO - "who": "sendchange", 18:38:38 INFO - "when": 1447555096, 18:38:38 INFO - "number": 6662915, 18:38:38 INFO - "comments": "", 18:38:38 INFO - "project": "", 18:38:38 INFO - "at": "Sat 14 Nov 2015 18:38:16", 18:38:38 INFO - "branch": "fx-team-linux64-pgo-talos", 18:38:38 INFO - "revlink": "", 18:38:38 INFO - "properties": [ 18:38:38 INFO - [ 18:38:38 INFO - "buildid", 18:38:38 INFO - "20151114173003", 18:38:38 INFO - "Change" 18:38:38 INFO - ], 18:38:38 INFO - [ 18:38:38 INFO - "builduid", 18:38:38 INFO - "445e9c6ca01b45bcb7dd8e5013607a46", 18:38:38 INFO - "Change" 18:38:38 INFO - ], 18:38:38 INFO - [ 18:38:38 INFO - "pgo_build", 18:38:38 INFO - "True", 18:38:38 INFO - "Change" 18:38:38 INFO - ] 18:38:38 INFO - ], 18:38:38 INFO - "revision": "5fb6f8b316ca76a5a4c47464900eaed2774d844f" 18:38:38 INFO - } 18:38:38 INFO - ], 18:38:38 INFO - "revision": "5fb6f8b316ca76a5a4c47464900eaed2774d844f" 18:38:38 INFO - } 18:38:38 INFO - } 18:38:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/LLvV23HGTOeFi9rqUixZag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 18:38:38 INFO - Running post-action listener: _resource_record_post_action 18:38:38 INFO - ##### 18:38:38 INFO - ##### Running download-and-extract step. 18:38:38 INFO - ##### 18:38:38 INFO - Running pre-action listener: _resource_record_pre_action 18:38:38 INFO - Running main action method: download_and_extract 18:38:38 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:38: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')]} 18:38:38 INFO - https://queue.taskcluster.net/v1/task/LLvV23HGTOeFi9rqUixZag/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:38:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLvV23HGTOeFi9rqUixZag/artifacts/public/build/test_packages.json 18:38:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLvV23HGTOeFi9rqUixZag/artifacts/public/build/test_packages.json 18:38:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLvV23HGTOeFi9rqUixZag/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:38:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLvV23HGTOeFi9rqUixZag/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:38:41 INFO - Downloaded 1302 bytes. 18:38:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:38:41 INFO - Using the following test package requirements: 18:38:41 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:38:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:38:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:38:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:38:41 INFO - u'jsshell-linux-x86_64.zip'], 18:38:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:38:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:38:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:38:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:38:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:38:41 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:38:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:38:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:38:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:38:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:38:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:38:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:38:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:41 INFO - https://queue.taskcluster.net/v1/task/LLvV23HGTOeFi9rqUixZag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:38:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLvV23HGTOeFi9rqUixZag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:38:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLvV23HGTOeFi9rqUixZag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:38:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLvV23HGTOeFi9rqUixZag/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 18:38:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLvV23HGTOeFi9rqUixZag/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 18:38:54 INFO - Downloaded 22461877 bytes. 18:38:54 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 18:38:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:38:54 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 18:38:56 INFO - Return code: 0 18:38:56 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 18:38: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')]} 18:38:56 INFO - https://queue.taskcluster.net/v1/task/LLvV23HGTOeFi9rqUixZag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:38:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLvV23HGTOeFi9rqUixZag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:38:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLvV23HGTOeFi9rqUixZag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:38:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLvV23HGTOeFi9rqUixZag/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 18:38:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLvV23HGTOeFi9rqUixZag/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 18:38:59 INFO - Downloaded 22461877 bytes. 18:38:59 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 18:38:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:38:59 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 18:39:01 INFO - Return code: 0 18:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:39:01 INFO - https://queue.taskcluster.net/v1/task/LLvV23HGTOeFi9rqUixZag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:39:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLvV23HGTOeFi9rqUixZag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:39:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLvV23HGTOeFi9rqUixZag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:39:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLvV23HGTOeFi9rqUixZag/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 18:39:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLvV23HGTOeFi9rqUixZag/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 18:39:01 INFO - Downloaded 11131693 bytes. 18:39:01 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 18:39:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:39:01 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 18:39:02 INFO - Return code: 0 18:39:02 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')]} 18:39:02 INFO - https://queue.taskcluster.net/v1/task/LLvV23HGTOeFi9rqUixZag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:39:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLvV23HGTOeFi9rqUixZag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:39:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLvV23HGTOeFi9rqUixZag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:39:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLvV23HGTOeFi9rqUixZag/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 18:39:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LLvV23HGTOeFi9rqUixZag/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 18:39:03 INFO - Downloaded 57160120 bytes. 18:39:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LLvV23HGTOeFi9rqUixZag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:39:03 INFO - mkdir: /builds/slave/test-pgo/properties 18:39:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:39:03 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:39:03 INFO - Contents: 18:39:03 INFO - build_url:https://queue.taskcluster.net/v1/task/LLvV23HGTOeFi9rqUixZag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:39:03 INFO - Running post-action listener: _resource_record_post_action 18:39:03 INFO - Running post-action listener: set_extra_try_arguments 18:39:03 INFO - ##### 18:39:03 INFO - ##### Running populate-webroot step. 18:39:03 INFO - ##### 18:39:03 INFO - Running pre-action listener: _resource_record_pre_action 18:39:03 INFO - Running main action method: populate_webroot 18:39:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:39:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:39:03 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:39:03 INFO - '../fennec_ids.txt'], 18:39:03 INFO - 'tests': ['tcheck2']}, 18:39:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:39:03 INFO - '--tppagecycles', 18:39:03 INFO - '7'], 18:39:03 INFO - 'tests': ['tsvgm']}}, 18:39:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:39:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:39:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:39:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:39:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:39:03 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:39:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:39:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:39:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:39:03 INFO - 'talos_options': ['--e10s'], 18:39:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:39:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:39:03 INFO - 'tests': ['damp', 'tps']}, 18:39:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:39:03 INFO - 'talos_options': ['--e10s'], 18:39:03 INFO - 'tests': ['damp', 'tps']}, 18:39:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:39:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:39:03 INFO - 'other': {'tests': ['a11yr', 18:39:03 INFO - 'ts_paint', 18:39:03 INFO - 'tpaint', 18:39:03 INFO - 'sessionrestore', 18:39:03 INFO - 'sessionrestore_no_auto_restore']}, 18:39:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:39:03 INFO - 'tests': ['a11yr', 18:39:03 INFO - 'ts_paint', 18:39:03 INFO - 'tpaint', 18:39:03 INFO - 'sessionrestore', 18:39:03 INFO - 'sessionrestore_no_auto_restore']}, 18:39:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:39:03 INFO - 'tests': ['a11yr', 18:39:03 INFO - 'ts_paint', 18:39:03 INFO - 'tpaint', 18:39:03 INFO - 'sessionrestore', 18:39:03 INFO - 'sessionrestore_no_auto_restore']}, 18:39:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:39:03 INFO - 'tests': ['a11yr', 18:39:03 INFO - 'ts_paint', 18:39:03 INFO - 'tpaint', 18:39:03 INFO - 'sessionrestore', 18:39:03 INFO - 'sessionrestore_no_auto_restore']}, 18:39:03 INFO - 'other_l64': {'tests': ['a11yr', 18:39:03 INFO - 'ts_paint', 18:39:03 INFO - 'tpaint', 18:39:03 INFO - 'sessionrestore', 18:39:03 INFO - 'sessionrestore_no_auto_restore']}, 18:39:03 INFO - 'other_nol64': {'tests': ['a11yr', 18:39:03 INFO - 'ts_paint', 18:39:03 INFO - 'tpaint', 18:39:03 INFO - 'sessionrestore', 18:39:03 INFO - 'sessionrestore_no_auto_restore']}, 18:39:03 INFO - 'svgr': {'tests': ['tsvgx', 18:39:03 INFO - 'tsvgr_opacity', 18:39:03 INFO - 'tart', 18:39:03 INFO - 'tscrollx', 18:39:03 INFO - 'cart']}, 18:39:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:39:03 INFO - 'tests': ['tsvgx', 18:39:03 INFO - 'tsvgr_opacity', 18:39:03 INFO - 'tart', 18:39:03 INFO - 'tscrollx', 18:39:03 INFO - 'cart']}, 18:39:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:39:03 INFO - 'tests': ['tp5o']}, 18:39:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:39:03 INFO - 'talos_options': ['--e10s'], 18:39:03 INFO - 'tests': ['tp5o']}, 18:39:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:39:03 INFO - 'talos_options': ['--xperf_path', 18:39:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:39:03 INFO - 'tests': ['tp5n']}, 18:39:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:39:03 INFO - 'talos_options': ['--e10s', 18:39:03 INFO - '--xperf_path', 18:39:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:39:03 INFO - 'tests': ['tp5n']}}, 18:39:03 INFO - 'talos.zip': {'path': '', 18:39:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:39:03 INFO - Running post-action listener: _resource_record_post_action 18:39:03 INFO - ##### 18:39:03 INFO - ##### Running create-virtualenv step. 18:39:03 INFO - ##### 18:39:03 INFO - Running pre-action listener: _resource_record_pre_action 18:39:03 INFO - Running main action method: create_virtualenv 18:39:03 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:39:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 18:39:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:39:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:39:03 INFO - Using real prefix '/usr' 18:39:03 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:39:04 INFO - Installing distribute.............................................................................................................................................................................................done. 18:39:06 INFO - Installing pip.................done. 18:39:06 INFO - Return code: 0 18:39:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:39:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa93fd96c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba66e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdca90>, '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 0x2c2ef70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2f2e0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447554967.110722-66501293', '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 18:39:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 18:39:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:39:06 INFO - Using env: {'DISPLAY': ':0', 18:39:06 INFO - 'HOME': '/home/cltbld', 18:39:06 INFO - 'LANG': 'en_US.UTF-8', 18:39:06 INFO - 'LANGUAGE': 'en_US:en', 18:39:06 INFO - 'LOGNAME': 'cltbld', 18:39:06 INFO - 'MAIL': '/var/mail/cltbld', 18:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:06 INFO - 'MOZ_NO_REMOTE': '1', 18:39:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:06 INFO - 'NO_EM_RESTART': '1', 18:39:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:39:06 INFO - 'PWD': '/builds/slave/test-pgo', 18:39:06 INFO - 'SHELL': '/bin/bash', 18:39:06 INFO - 'SHLVL': '1', 18:39:06 INFO - 'TERM': 'linux', 18:39:06 INFO - 'TMOUT': '86400', 18:39:06 INFO - 'USER': 'cltbld', 18:39:06 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447554967.110722-66501293', 18:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:06 INFO - '_': '/tools/buildbot/bin/python'} 18:39:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:39:06 INFO - Cleaning up... 18:39:06 INFO - Return code: 0 18:39:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:39:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:39:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa93fd96c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba66e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdca90>, '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 0x2c2ef70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2f2e0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447554967.110722-66501293', '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 18:39:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 18:39:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:39:06 INFO - Using env: {'DISPLAY': ':0', 18:39:06 INFO - 'HOME': '/home/cltbld', 18:39:06 INFO - 'LANG': 'en_US.UTF-8', 18:39:06 INFO - 'LANGUAGE': 'en_US:en', 18:39:06 INFO - 'LOGNAME': 'cltbld', 18:39:06 INFO - 'MAIL': '/var/mail/cltbld', 18:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:06 INFO - 'MOZ_NO_REMOTE': '1', 18:39:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:06 INFO - 'NO_EM_RESTART': '1', 18:39:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:39:06 INFO - 'PWD': '/builds/slave/test-pgo', 18:39:06 INFO - 'SHELL': '/bin/bash', 18:39:06 INFO - 'SHLVL': '1', 18:39:06 INFO - 'TERM': 'linux', 18:39:06 INFO - 'TMOUT': '86400', 18:39:06 INFO - 'USER': 'cltbld', 18:39:06 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447554967.110722-66501293', 18:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:06 INFO - '_': '/tools/buildbot/bin/python'} 18:39:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:06 INFO - Downloading/unpacking psutil>=0.7.1 18:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:39:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:39:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:39:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:39:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:39:08 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 18:39:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:39:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:39:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:39:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:39:08 INFO - Installing collected packages: psutil 18:39:08 INFO - Running setup.py install for psutil 18:39:08 INFO - building 'psutil._psutil_linux' extension 18:39:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:39:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:39:08 INFO - building 'psutil._psutil_posix' extension 18:39:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:39:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:39:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:39:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:39:08 INFO - Successfully installed psutil 18:39:08 INFO - Cleaning up... 18:39:08 INFO - Return code: 0 18:39:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:39:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:39:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:39:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:39:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa93fd96c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba66e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdca90>, '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 0x2c2ef70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2f2e0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447554967.110722-66501293', '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 18:39:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 18:39:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:39:08 INFO - Using env: {'DISPLAY': ':0', 18:39:08 INFO - 'HOME': '/home/cltbld', 18:39:08 INFO - 'LANG': 'en_US.UTF-8', 18:39:08 INFO - 'LANGUAGE': 'en_US:en', 18:39:08 INFO - 'LOGNAME': 'cltbld', 18:39:08 INFO - 'MAIL': '/var/mail/cltbld', 18:39:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:08 INFO - 'MOZ_NO_REMOTE': '1', 18:39:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:08 INFO - 'NO_EM_RESTART': '1', 18:39:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:39:08 INFO - 'PWD': '/builds/slave/test-pgo', 18:39:08 INFO - 'SHELL': '/bin/bash', 18:39:08 INFO - 'SHLVL': '1', 18:39:08 INFO - 'TERM': 'linux', 18:39:08 INFO - 'TMOUT': '86400', 18:39:08 INFO - 'USER': 'cltbld', 18:39:08 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447554967.110722-66501293', 18:39:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:08 INFO - '_': '/tools/buildbot/bin/python'} 18:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:39:09 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 18:39:09 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 18:39:09 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 18:39:09 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 18:39:09 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 18:39:09 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 18:39:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:39:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:39:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:39:10 INFO - Installing collected packages: mozsystemmonitor 18:39:10 INFO - Running setup.py install for mozsystemmonitor 18:39:10 INFO - Successfully installed mozsystemmonitor 18:39:10 INFO - Cleaning up... 18:39:10 INFO - Return code: 0 18:39:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:39:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa93fd96c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba66e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdca90>, '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 0x2c2ef70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2f2e0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447554967.110722-66501293', '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 18:39:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 18:39:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:39:10 INFO - Using env: {'DISPLAY': ':0', 18:39:10 INFO - 'HOME': '/home/cltbld', 18:39:10 INFO - 'LANG': 'en_US.UTF-8', 18:39:10 INFO - 'LANGUAGE': 'en_US:en', 18:39:10 INFO - 'LOGNAME': 'cltbld', 18:39:10 INFO - 'MAIL': '/var/mail/cltbld', 18:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:10 INFO - 'MOZ_NO_REMOTE': '1', 18:39:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:10 INFO - 'NO_EM_RESTART': '1', 18:39:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:39:10 INFO - 'PWD': '/builds/slave/test-pgo', 18:39:10 INFO - 'SHELL': '/bin/bash', 18:39:10 INFO - 'SHLVL': '1', 18:39:10 INFO - 'TERM': 'linux', 18:39:10 INFO - 'TMOUT': '86400', 18:39:10 INFO - 'USER': 'cltbld', 18:39:10 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447554967.110722-66501293', 18:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:10 INFO - '_': '/tools/buildbot/bin/python'} 18:39:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:11 INFO - Downloading/unpacking blobuploader==1.2.4 18:39:11 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 18:39:11 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 18:39:11 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 18:39:11 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 18:39:11 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 18:39:11 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 18:39:12 INFO - Downloading blobuploader-1.2.4.tar.gz 18:39:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:39:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:39:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:39:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:39:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:39:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:39:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:39:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:39:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:39:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:39:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:39:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:39:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:39:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:39:13 INFO - Downloading docopt-0.6.1.tar.gz 18:39:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:39:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:39:13 INFO - Installing collected packages: blobuploader, requests, docopt 18:39:13 INFO - Running setup.py install for blobuploader 18:39:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:39:13 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:39:13 INFO - Running setup.py install for requests 18:39:13 INFO - Running setup.py install for docopt 18:39:14 INFO - Successfully installed blobuploader requests docopt 18:39:14 INFO - Cleaning up... 18:39:14 INFO - Return code: 0 18:39:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:39:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:39:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:39:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa93fd96c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba66e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdca90>, '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 0x2c2ef70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2f2e0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447554967.110722-66501293', '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 18:39:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 18:39:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:39:14 INFO - Using env: {'DISPLAY': ':0', 18:39:14 INFO - 'HOME': '/home/cltbld', 18:39:14 INFO - 'LANG': 'en_US.UTF-8', 18:39:14 INFO - 'LANGUAGE': 'en_US:en', 18:39:14 INFO - 'LOGNAME': 'cltbld', 18:39:14 INFO - 'MAIL': '/var/mail/cltbld', 18:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:14 INFO - 'MOZ_NO_REMOTE': '1', 18:39:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:14 INFO - 'NO_EM_RESTART': '1', 18:39:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:39:14 INFO - 'PWD': '/builds/slave/test-pgo', 18:39:14 INFO - 'SHELL': '/bin/bash', 18:39:14 INFO - 'SHLVL': '1', 18:39:14 INFO - 'TERM': 'linux', 18:39:14 INFO - 'TMOUT': '86400', 18:39:14 INFO - 'USER': 'cltbld', 18:39:14 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447554967.110722-66501293', 18:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:14 INFO - '_': '/tools/buildbot/bin/python'} 18:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:39:14 INFO - Running setup.py (path:/tmp/pip-WGSfoz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:39:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:39:14 INFO - Running setup.py (path:/tmp/pip-pRzVhX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:39:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:39:14 INFO - Running setup.py (path:/tmp/pip-sAk7Y6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:39:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:39:14 INFO - Running setup.py (path:/tmp/pip-OWuY9i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:39:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:39:14 INFO - Running setup.py (path:/tmp/pip-8LplEz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:39:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:39:14 INFO - Running setup.py (path:/tmp/pip-27OT0c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:39:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:39:14 INFO - Running setup.py (path:/tmp/pip-8nOj8S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:39:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:39:14 INFO - Running setup.py (path:/tmp/pip-Wvj2q_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:39:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:39:14 INFO - Running setup.py (path:/tmp/pip-2Sgjql-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:39:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:39:14 INFO - Running setup.py (path:/tmp/pip-toGEDX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:39:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:39:14 INFO - Running setup.py (path:/tmp/pip-F7qDhi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:39:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:39:15 INFO - Running setup.py (path:/tmp/pip-XLZL0m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:39:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:39:15 INFO - Running setup.py (path:/tmp/pip-VXz7hF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:39:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:39:15 INFO - Running setup.py (path:/tmp/pip-WJ94RW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:39:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:39:15 INFO - Running setup.py (path:/tmp/pip-EHXM9A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:39:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:39:15 INFO - Running setup.py (path:/tmp/pip-y_A2DI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:39:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:39:15 INFO - Running setup.py (path:/tmp/pip-uRU_nq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:39:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:39:15 INFO - Running setup.py install for manifestparser 18:39:15 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:39:15 INFO - Running setup.py install for mozcrash 18:39:15 INFO - Running setup.py install for mozdebug 18:39:15 INFO - Running setup.py install for mozdevice 18:39:15 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:39:15 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:39:15 INFO - Running setup.py install for mozfile 18:39:15 INFO - Running setup.py install for mozhttpd 18:39:16 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:39:16 INFO - Running setup.py install for mozinfo 18:39:16 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:39:16 INFO - Running setup.py install for mozInstall 18:39:16 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:39:16 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:39:16 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:39:16 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:39:16 INFO - Running setup.py install for mozleak 18:39:16 INFO - Running setup.py install for mozlog 18:39:16 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:39:16 INFO - Running setup.py install for moznetwork 18:39:16 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:39:16 INFO - Running setup.py install for mozprocess 18:39:16 INFO - Running setup.py install for mozprofile 18:39:16 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:39:16 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:39:16 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:39:16 INFO - Running setup.py install for mozrunner 18:39:17 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:39:17 INFO - Running setup.py install for mozscreenshot 18:39:17 INFO - Running setup.py install for moztest 18:39:17 INFO - Running setup.py install for mozversion 18:39:17 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:39:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:39:17 INFO - Cleaning up... 18:39:17 INFO - Return code: 0 18:39:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:39:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:39:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa93fd96c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba66e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdca90>, '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 0x2c2ef70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2f2e0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447554967.110722-66501293', '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 18:39:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 18:39:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:39:17 INFO - Using env: {'DISPLAY': ':0', 18:39:17 INFO - 'HOME': '/home/cltbld', 18:39:17 INFO - 'LANG': 'en_US.UTF-8', 18:39:17 INFO - 'LANGUAGE': 'en_US:en', 18:39:17 INFO - 'LOGNAME': 'cltbld', 18:39:17 INFO - 'MAIL': '/var/mail/cltbld', 18:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:17 INFO - 'MOZ_NO_REMOTE': '1', 18:39:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:17 INFO - 'NO_EM_RESTART': '1', 18:39:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:39:17 INFO - 'PWD': '/builds/slave/test-pgo', 18:39:17 INFO - 'SHELL': '/bin/bash', 18:39:17 INFO - 'SHLVL': '1', 18:39:17 INFO - 'TERM': 'linux', 18:39:17 INFO - 'TMOUT': '86400', 18:39:17 INFO - 'USER': 'cltbld', 18:39:17 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447554967.110722-66501293', 18:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:17 INFO - '_': '/tools/buildbot/bin/python'} 18:39:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:39:17 INFO - Running setup.py (path:/tmp/pip-eyrXBf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:39:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 18:39:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:39:17 INFO - Running setup.py (path:/tmp/pip-SXjbUz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:39:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:39:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:39:17 INFO - Running setup.py (path:/tmp/pip-tNJwYp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:39:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 18:39:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:39:17 INFO - Running setup.py (path:/tmp/pip-BuZ5qW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:39:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:39:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:39:17 INFO - Running setup.py (path:/tmp/pip-glyto1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:39:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 18:39:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:39:17 INFO - Running setup.py (path:/tmp/pip-WYMIS0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:39:18 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)) 18:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:39:18 INFO - Running setup.py (path:/tmp/pip-HbgJK3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:39:18 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)) 18:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:39:18 INFO - Running setup.py (path:/tmp/pip-h82UKn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 18:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:39:18 INFO - Running setup.py (path:/tmp/pip-BAO9Jo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 18:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:39:18 INFO - Running setup.py (path:/tmp/pip-LNAwaI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:39:18 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)) 18:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:39:18 INFO - Running setup.py (path:/tmp/pip-DEX4SQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 18:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:39:18 INFO - Running setup.py (path:/tmp/pip-yIJNgy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 18:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:39:18 INFO - Running setup.py (path:/tmp/pip-4XZ62i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 18:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:39:18 INFO - Running setup.py (path:/tmp/pip-l_0WJu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 18:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:39:18 INFO - Running setup.py (path:/tmp/pip-xKbJ1y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 18:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:39:18 INFO - Running setup.py (path:/tmp/pip-P3yyGP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 18:39:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:39:18 INFO - Running setup.py (path:/tmp/pip-v96JHT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 18:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 18:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:39:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:39:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:39:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:39:20 INFO - Downloading blessings-1.5.1.tar.gz 18:39:20 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 18:39:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:39:20 INFO - Installing collected packages: blessings 18:39:20 INFO - Running setup.py install for blessings 18:39:20 INFO - Successfully installed blessings 18:39:20 INFO - Cleaning up... 18:39:20 INFO - Return code: 0 18:39:20 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:39:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:39:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:39:20 INFO - Reading from file tmpfile_stdout 18:39:20 INFO - Current package versions: 18:39:20 INFO - argparse == 1.2.1 18:39:20 INFO - blessings == 1.5.1 18:39:20 INFO - blobuploader == 1.2.4 18:39:20 INFO - docopt == 0.6.1 18:39:20 INFO - manifestparser == 1.1 18:39:20 INFO - mozInstall == 1.12 18:39:20 INFO - mozcrash == 0.16 18:39:20 INFO - mozdebug == 0.1 18:39:20 INFO - mozdevice == 0.47 18:39:20 INFO - mozfile == 1.2 18:39:20 INFO - mozhttpd == 0.7 18:39:20 INFO - mozinfo == 0.9 18:39:20 INFO - mozleak == 0.1 18:39:20 INFO - mozlog == 3.0 18:39:20 INFO - moznetwork == 0.27 18:39:20 INFO - mozprocess == 0.22 18:39:20 INFO - mozprofile == 0.27 18:39:20 INFO - mozrunner == 6.11 18:39:20 INFO - mozscreenshot == 0.1 18:39:20 INFO - mozsystemmonitor == 0.0 18:39:20 INFO - moztest == 0.7 18:39:20 INFO - mozversion == 1.4 18:39:20 INFO - psutil == 3.1.1 18:39:20 INFO - requests == 1.2.3 18:39:20 INFO - wsgiref == 0.1.2 18:39:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:39:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:39:20 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa93fd96c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae56c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba66e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdca90>, '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 0x2c2ef70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2f2e0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447554967.110722-66501293', '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 18:39:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 18:39:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:39:20 INFO - Using env: {'DISPLAY': ':0', 18:39:20 INFO - 'HOME': '/home/cltbld', 18:39:20 INFO - 'LANG': 'en_US.UTF-8', 18:39:20 INFO - 'LANGUAGE': 'en_US:en', 18:39:20 INFO - 'LOGNAME': 'cltbld', 18:39:20 INFO - 'MAIL': '/var/mail/cltbld', 18:39:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:20 INFO - 'MOZ_NO_REMOTE': '1', 18:39:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:20 INFO - 'NO_EM_RESTART': '1', 18:39:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:39:20 INFO - 'PWD': '/builds/slave/test-pgo', 18:39:20 INFO - 'SHELL': '/bin/bash', 18:39:20 INFO - 'SHLVL': '1', 18:39:20 INFO - 'TERM': 'linux', 18:39:20 INFO - 'TMOUT': '86400', 18:39:20 INFO - 'USER': 'cltbld', 18:39:20 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447554967.110722-66501293', 18:39:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:20 INFO - '_': '/tools/buildbot/bin/python'} 18:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 18:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 18:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 18:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 18:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 18:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 18:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 18:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 18:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 18:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 18:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 18:39:21 INFO - Cleaning up... 18:39:21 INFO - Return code: 0 18:39:21 INFO - Running post-action listener: _resource_record_post_action 18:39:21 INFO - Running post-action listener: _start_resource_monitoring 18:39:21 INFO - Starting resource monitoring. 18:39:21 INFO - ##### 18:39:21 INFO - ##### Running install step. 18:39:21 INFO - ##### 18:39:21 INFO - Running pre-action listener: _resource_record_pre_action 18:39:21 INFO - Running main action method: install 18:39:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:39:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:39:21 INFO - Reading from file tmpfile_stdout 18:39:21 INFO - Detecting whether we're running mozinstall >=1.0... 18:39:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:39:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:39:21 INFO - Reading from file tmpfile_stdout 18:39:21 INFO - Output received: 18:39:21 INFO - Usage: mozinstall [options] installer 18:39:21 INFO - Options: 18:39:21 INFO - -h, --help show this help message and exit 18:39:21 INFO - -d DEST, --destination=DEST 18:39:21 INFO - Directory to install application into. [default: 18:39:21 INFO - "/builds/slave/test-pgo"] 18:39:21 INFO - --app=APP Application being installed. [default: firefox] 18:39:21 INFO - mkdir: /builds/slave/test-pgo/build/application 18:39:21 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'] 18:39:21 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 18:39:35 INFO - Reading from file tmpfile_stdout 18:39:35 INFO - Output received: 18:39:35 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:39:35 INFO - Running post-action listener: _resource_record_post_action 18:39:35 INFO - ##### 18:39:35 INFO - ##### Running run-tests step. 18:39:35 INFO - ##### 18:39:35 INFO - Running pre-action listener: _resource_record_pre_action 18:39:35 INFO - Running main action method: run_tests 18:39:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:39:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:39:35 INFO - Python 2.7.3 18:39:35 INFO - Return code: 0 18:39:35 INFO - grabbing minidump binary from tooltool 18:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:39:35 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 0x2bdca90>, '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 0x2c2ef70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c2f2e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:39:35 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 18:39:35 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 18:39:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:39:35 INFO - Return code: 0 18:39:35 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:39:35 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:39:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:39:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:39:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:39:35 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LLvV23HGTOeFi9rqUixZag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 18:39:35 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LLvV23HGTOeFi9rqUixZag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost 18:39:35 INFO - Using env: {'DISPLAY': ':0', 18:39:35 INFO - 'HOME': '/home/cltbld', 18:39:35 INFO - 'LANG': 'en_US.UTF-8', 18:39:35 INFO - 'LANGUAGE': 'en_US:en', 18:39:35 INFO - 'LOGNAME': 'cltbld', 18:39:35 INFO - 'MAIL': '/var/mail/cltbld', 18:39:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:39:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:39:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:35 INFO - 'MOZ_NO_REMOTE': '1', 18:39:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:39:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:35 INFO - 'NO_EM_RESTART': '1', 18:39:35 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:39:35 INFO - 'PWD': '/builds/slave/test-pgo', 18:39:35 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:39:35 INFO - 'SHELL': '/bin/bash', 18:39:35 INFO - 'SHLVL': '1', 18:39:35 INFO - 'TERM': 'linux', 18:39:35 INFO - 'TMOUT': '86400', 18:39:35 INFO - 'USER': 'cltbld', 18:39:35 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447554967.110722-66501293', 18:39:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:35 INFO - '_': '/tools/buildbot/bin/python'} 18:39:35 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LLvV23HGTOeFi9rqUixZag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost'] with output_timeout 3600 18:39:36 INFO - mozversion INFO | application_buildid: 20151114173003 18:39:36 INFO - mozversion INFO | application_changeset: 5fb6f8b316ca76a5a4c47464900eaed2774d844f 18:39:36 INFO - mozversion INFO | application_display_name: Nightly 18:39:36 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:39:36 INFO - mozversion INFO | application_name: Firefox 18:39:36 INFO - mozversion INFO | application_remotingname: firefox 18:39:36 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 18:39:36 INFO - mozversion INFO | application_vendor: Mozilla 18:39:36 INFO - mozversion INFO | application_version: 45.0a1 18:39:36 INFO - mozversion INFO | platform_buildid: 20151114173003 18:39:36 INFO - mozversion INFO | platform_changeset: 5fb6f8b316ca76a5a4c47464900eaed2774d844f 18:39:36 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 18:39:36 INFO - mozversion INFO | platform_version: 45.0a1 18:39:36 INFO - 2015-11-14 18:39:36,131 DEBUG : using testdate: 1447555176 18:39:36 INFO - 2015-11-14 18:39:36,131 DEBUG : actual date: 1447555176 18:39:36 INFO - 2015-11-14 18:39:36,141 INFO : starting webserver on 'localhost:47241' 18:39:36 INFO - 2015-11-14 18:39:36,142 INFO : Starting test suite talos-linux64-ix-001 18:39:36 INFO - 2015-11-14 18:39:36,143 INFO : Starting test dromaeo_css 18:39:36 INFO - 2015-11-14 18:39:36,143 DEBUG : operating with platform_type : linux_ 18:39:36 INFO - 2015-11-14 18:39:36,143 INFO : Initialising browser for dromaeo_css test... 18:39:36 INFO - 2015-11-14 18:39:36,156 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpc7_qLX/profile http://localhost:47241/getInfo.html 18:39:40 INFO - 2015-11-14 18:39:40,702 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:39:40 INFO - 2015-11-14 18:39:40,702 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:39:40 INFO - 2015-11-14 18:39:40,702 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:39:40 INFO - 2015-11-14 18:39:40,703 DEBUG : BROWSER_OUTPUT: __metrics 18:39:40 INFO - 2015-11-14 18:39:40,787 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:39:42 INFO - 2015-11-14 18:39:42,077 INFO : Browser initialized. 18:39:42 INFO - 2015-11-14 18:39:42,077 INFO : Running cycle 1/1 for dromaeo_css test... 18:39:42 INFO - 2015-11-14 18:39:42,077 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpc7_qLX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:39:53 INFO - 2015-11-14 18:39:53,844 DEBUG : BROWSER_OUTPUT: RSS: Main: 141062144 18:39:53 INFO - 2015-11-14 18:39:53,844 DEBUG : BROWSER_OUTPUT: 18:40:45 INFO - 2015-11-14 18:40:45,153 DEBUG : BROWSER_OUTPUT: 1447555245152 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] 18:42:53 INFO - 2015-11-14 18:42:53,428 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47241/tests/dromaeo/cssquery-ext.html) 18:42:54 INFO - 2015-11-14 18:42:54,686 DEBUG : BROWSER_OUTPUT: RSS: Main: 261509120 18:42:54 INFO - 2015-11-14 18:42:54,686 DEBUG : BROWSER_OUTPUT: 18:45:57 INFO - 2015-11-14 18:45:57,209 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47241/tests/dromaeo/cssquery-ext.html (next: http://localhost:47241/tests/dromaeo/cssquery-jquery.html) 18:45:57 INFO - 2015-11-14 18:45:57,775 DEBUG : BROWSER_OUTPUT: RSS: Main: 222220288 18:45:57 INFO - 2015-11-14 18:45:57,775 DEBUG : BROWSER_OUTPUT: 18:48:59 INFO - 2015-11-14 18:48:59,705 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47241/tests/dromaeo/cssquery-mootools.html) 18:49:00 INFO - 2015-11-14 18:49:00,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 208084992 18:49:00 INFO - 2015-11-14 18:49:00,271 DEBUG : BROWSER_OUTPUT: 18:52:02 INFO - 2015-11-14 18:52:02,171 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47241/tests/dromaeo/cssquery-prototype.html) 18:52:02 INFO - 2015-11-14 18:52:02,732 DEBUG : BROWSER_OUTPUT: RSS: Main: 195874816 18:52:02 INFO - 2015-11-14 18:52:02,732 DEBUG : BROWSER_OUTPUT: 18:55:05 INFO - 2015-11-14 18:55:05,291 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47241/tests/dromaeo/cssquery-yui.html) 18:55:05 INFO - 2015-11-14 18:55:05,860 DEBUG : BROWSER_OUTPUT: RSS: Main: 203431936 18:55:05 INFO - 2015-11-14 18:55:05,860 DEBUG : BROWSER_OUTPUT: 18:58:08 INFO - 2015-11-14 18:58:08,317 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47241/tests/dromaeo/cssquery-yui.html (next: http://localhost:47241/tests/dromaeo/cssquery-dojo.html) 18:58:08 INFO - 2015-11-14 18:58:08,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 271220736 18:58:08 INFO - 2015-11-14 18:58:08,576 DEBUG : BROWSER_OUTPUT: 18:58:08 INFO - 2015-11-14 18:58:08,576 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:58:08 INFO - 2015-11-14 18:58:08,576 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:58:08 INFO - 2015-11-14 18:58:08,576 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:58:08 INFO - 2015-11-14 18:58:08,576 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:58:08 INFO - 2015-11-14 18:58:08,577 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3129.123845323309;3201.3597280543895;3237.8057316561008;3241.88653397131;3273.819939903304;5086.771095300711;5246.632735708502;5376.8924621507595;5378.112611419116;5383.865403364918;5220.608454365919;5264.236685680574;5273.604479664022;5277.973610131953;5343.599230057742;4737.73942433166;4877.731724755137;4910.852674419764;4919.655624106314;5037.5214354636255;4710.105080034799;4955.628327875405;4979.875503112433;5008.774605142778;5084.77118529667;4605.953940460586;4711.387519622462;4728.361671174382;4731.787069581877;4817.22924332107;4842.612590992748;4846.1761500544635;4871.8782030449165;4889.828855990058;4892.9510704892855;4681.7190968542;4844.491328410537;4851.708897466164;4857.077155340474;4885.975570122162;5065.924011139836;5161.896762064737;5172.689638621695;5181.689098654055;5210.583153347723;5800.24596802413;5854.7072646367515;5866.14940833581;5867.823965281048;5872.647641141545;5874.765009399619;5877.265341832271;5881.029630111027;5891.499222566087;5898.439648233411;5217.947820521784;5313.787448502094;5314.123169676998;5380.381256155514;5426.511613954763;5882.852928676817;5884.499817515473;5885.793997210077;5904.822855314347;5949.0481522956115;5474.753636086386;5742;5754.5971781975695;5776.5089967352405;5777.768889244383;5615.466530679579;5729.770809167587;5735.1970724098655;5743.195952566644;5769.278840144982;5648.15277708347;5649.180868774005;5652.265205523256;5656.066748986454;5668.121441176624;5656.236408084856;5661.547076233891;5674.120511320752;5681.914771278434;5795.478406943395;4387.605115539617;4442.444694413199;4448.799804008828;4460.397846290774;4478.440194975628;3966.8809935701975;3985.1830374773103;3987.7009224308295;4011.9799401002806;4018.9397159042637;5342.572594192456;5530.446955304437;5533.976214400349;5538.307711536058;5544.667319960815;5636.134281996167;5709.914351284734;5763.625364351304;5785.681787501728;5821.912671309934;5411.756470958816;5464.23500709901;5466.3440387153005;5478.780848766084;5498.285222921075;4888.462269150391;4971.080350135237;4972.552470277692;4977.477364876636;5017.197248440232;5881.617694849821;5925.051991681396;5928.555358348228;5942.286925568959;5980.491658209014;5770.394108618535;5816.94183058164;5818.854528636818;5821.505172060253;5822.068469045102;5816.680082595498;5942.1383899335215;6018.608790428783;6030.065339872327;6031.698415079316;5692.5730570208225;5754.6547207167705;5758.2514273144225;5759.049756790083;5802.0426629605645;5688.744006519633;5691.516221121251;5692.914606280826;5695.914561281667;5698.430156984268;5438.673679579238;5512.39363670004;5544.972275138599;5551.8056868011045;5552.52803511706;5648.519875810603;5678.659280443187;5680.488756011813;5681.602287839977;5687.516561092353;5570.470805273492;5572.60991730575;5573.972130139324;5578.191162281528;5584.916226256691;5363.946360536344;5420.647657902381;5514.889702206014;5515.696636685021;5682.147677848356;5547.0570003098765;5557;5560;5581.832545023493;5588.245586845724 18:58:08 INFO - 2015-11-14 18:58:08,577 DEBUG : BROWSER_OUTPUT: |1;ext.html;556.283948304926;575.3670961941865;584.5966283264546;593.0896074525601;594.5154698920377;31975;39406.605933940686;40289.39565906506;40317;40350;42478.15043699124;42877.14245715084;42979;43129;43242.56757432425;7668.271514206142;7811.531308121503;8807.339449541278;8984.910150898506;8985.820283594325;10404.219683523728;10687.251892367538;10697.144228461744;10700.357978521275;10704.30422022566;10423.947880260588;10507.789844203111;10515.894841051568;10517.894821051807;10526.526306316235;7755.1469338372735;7919.920800792033;10469.110125639292;10525.105366043896;10842.891571084347;10318.277720559563;10480.790384192349;10506.106980906632;10511.316764410289;10514.474276286155;39922.40116398256;40404;40413.79793101016;40489.79755101235;40494.79752601247;3036.7818822504687;3076.3078307380883;3248.4964830451318;3548.3435564420665;3924.926500430607;29111.56332655012;29500.11499655014;29726.85136574325;29736.55395169074;29804.254893627614;3262.934741305184;3303.9834800825843;3381.205416727067;3383.610884748261;3411.181316484026;282576;283193.5840320806;283363;283998;285258;55712;56048;56491;58411.707941460874;58667;60554;60630.696846515486;60756.696216518634;60811.69594152001;60855;16125.274362653709;16319.755203671955;16352.264148113363;16369.91815040941;16370.590735231715;12340.691482712824;12383.814242786366;12458.563950261698;12480.81278780819;12489.25064496115;19377.515562110777;19586.804131958783;19620.90189549043;19676.90161549183;19779.307724229584;7466;7525.36034437079;7531.661075251627;7581.3176814087;7661.923380766121;851.6337974670951;906.207068814787;1024.9231307651955;1028.3007554862616;1040.0691381213771;28086.33179847911;28478.430431391254;28577;28671.56992645112;28828.71171288302;978.5449765858909;995.0795514149382;1003.5433877585826;1005.4570531912832;1109.5062697099713;14159.64600884986;14212.857871421153;14217.92891035559;14369.497067602793;14502.274886255645;252269;255945;256472;256917;257264;49209;49336.50663493319;49428.752856235486;49477.257841132414;49545.25682114771;1269.9428525716364;1286.4468278640088;1294.4045738960183;1295.9740805184033;1306.235852026575;26796.866015669795;27534.449311013268;28009.57985630258;28014;28059.71940280571;44392.11215775731;45008.549914501746;49843.25235121549;51219.74390128175;51268.487315127866;274679;276652;278515;279046;279131;27847.58228626532;28342.43315133727;30964.53553196749;30971.845140774152;31304.530432043994;43830.56169438393;43931;43933.78033109814;44024.55975440333;44634.55365446434;33248;35493.467597986564;35563;35673.00247271315;36056.27887442289;35030.824845875606;35613.109672257364;36074;36142.63857361498;36351.45472817857;34708.65291347054;35281.82359088188;35628.82185589056;35877.28245435024;36199.81900090483;31351.686483134876;32221.866943783887;32621;32791.34417311688;32955.34089318152;23809.523809523365;23883.641745373487;23961.760382395954;24021;24184 18:58:08 INFO - 2015-11-14 18:58:08,577 DEBUG : BROWSER_OUTPUT: |2;jquery.html;346.55640779801854;347.49613061061467;349.0697291717573;350.6651148153514;351.51490942499345;13987.230702311368;14375.353109110089;16757.748633770487;17363.913180434098;18660.973646449456;16165.110918899456;16564.503064908044;17044.744328835048;17337.47987560372;17373.913130434332;5215.426303106655;5340.412554618989;5344.545713614348;5345.492178243061;5350.250964864903;3797.126660868002;3893.4743809585766;5363.758630861621;5790.392008839074;5991.340952495222;5878.177055212273;5879.617824841393;5914.822555323347;5917.408259174092;5944.346121926585;5745.109508026263;5846.970765146169;5861.824145275648;5863.325717542494;5868.061110222387;5126.846194614168;5133.409657889353;5139.357580302462;5154.793808247666;5164.122099243138;13548.322583870866;13759.79360309596;13989.090709103875;14047.43810247589;14065.226412547307;1768.3899054826065;1837.4579499047813;1856.9721454178198;1860.1257409017876;1869.682154033804;9940.552675129564;10089.495525223709;10104.747381315452;10420.062194402464;10446;1657.5193193973732;1676.8323167683134;1716.2276975361137;1727.5940154063785;1740.8868423552556;60695;61249.693751531406;62115;62868.05697914535;63435.68282158606;7034.753783617549;7063.611501367372;7081.362677359062;7116.5411090726275;7125.1093613298335;8534.27458666008;8547.786305342415;8553.230209281195;8561.400701950804;8561.571921403905;5762.135679648002;5826.592138550261;5844.035734103911;5875.500582450454;5885.411458854081;6079.209702738704;6112.908306375408;6119.357467465941;6126.172966649535;6146.508279337642;3271.934561308808;3299.0762586475826;3311.536384906115;3332.5667663204113;3334.3498017886764;1118.05524331941;1146.8853114688463;1150.5340337163295;1151.4875880233217;1174.3775798826637;444.795394118709;462.1404188209927;467.7988464960032;483.54063639542574;500.12478163214377;10228.897711022943;11203.495842686936;11712;11830.349330786717;12116.333601651993;447.6133887898581;473.2404490792298;474.02824210369295;474.6037059055658;496.66971463976773;6475.158229430238;6704.061431399608;6726.831829204211;6796.35434633709;6813.420859226922;467937;471230;500936;537789;539165;70475.64762176156;75756.24243757602;75934;77665.6116719424;78848.21151788524;525.584788017462;535.6518263128997;535.9303290572201;537.2049366936877;537.9488948549881;11023.228374013743;11282.830757538479;11319.151063670422;11457.140714446616;11573.421328933688;33537.664623353456;33826.830865846496;34526.309473810885;34774.13064673403;35980.64019359773;46585.301220481044;47302.05395891994;48486.272705910145;48554.757226213645;49370.259446107615;6639.037339585637;6690.565113267622;6971.8257043572285;6991.335823096798;6992.1958974718555;12392;12687.492500299884;12828.358582071045;12842.422091006114;12909.677258068623;10910.290831095954;11091;11120.777584448104;11128.610498632508;11356.716082098013;10845.674629761119;10855.18586106061;10901.127909767041;10959.397233151934;11057.83413248818;11086.556537738401;11219.158563107636;11282.661520154408;11384.14618903569;11397.544098236309;6837.213720422016;6897.310268973062;6960;6979.651017449209;6981.127359080115;10879.728006799893;10883.891161088288;11065.612703555336;11360.715982100513;11450.82823757661 18:58:08 INFO - 2015-11-14 18:58:08,580 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1342.369086529332;1675.6983742926275;1729.1181497436312;1732.081996541833;1748.903810290435;6622.635755033477;7159.14090309163;7381.9630901845485;7392.7042918283205;7416.0729908761405;7261.455390845681;7356.926430735691;7357.558546487215;7359.374453171474;7385.335319821215;1916.865819392643;1951.365806113019;2165.9241926532573;2207.8012978831944;2226.944326391845;2250.954980900381;2252.605793986054;2254.0532976149975;2254.830887683422;2259.559385919746;2026.5946810637859;2084.9791502085013;2085.7914208579173;2087.488565301503;2088.571842772236;1852.0832188066927;1890.735297058406;2064.6077245323418;2083.6874468829647;2100.096958307927;2208.381653137108;2222.1333679864865;2236.8769717665523;2249.49386388063;2251.020805949417;7362.233064064586;7468.663910124003;7481.438892083062;7482.027336446227;7489.812754681122;4396.054848207618;4490.3040028795585;4497.460304763416;4500.369948207253;4505.166544189336;2853.1583182961076;2909.301767575788;2910.2578842395055;2939.235798692334;2959.556066590007;830.667732906836;861.0184389795638;861.8621020636668;864.6843901975734;911.2983003087586;9861.457619830906;9867.309288349818;9870.50647467631;9880.703578892644;9888.456134912576;3971.5631280559114;4018.578049304839;4066.552679205285;4067.9796601016806;4090.284200264942;8454.196851299117;8548.230659240699;8549.957250213709;8556.358273129415;8560.400771945904;4473.865784026484;4520.299353600197;4520.389747384127;4527.388802511685;4528.954710452919;4129.2773764591075;4141.047559061372;4141.585841415895;4143.56492568282;4150.086980864205;3573.1960308930284;3604.873829415958;3614.4216925291826;3633.6184700606054;3638.6725194732603;1156.6298784389082;1182.5979167083233;1183.0535571542732;1183.3195912350434;1199.6041306369052;946.1106559833735;952.2001518724305;963.0706368354571;1032.8450732390202;1258.8363512743285;6280.2777680566405;6613.503987200979;6950.061741664912;6951.443884489228;6954.65226738661;673.5992084709688;682.9760958366434;697.292248367907;706.0926709178681;711.7259854955879;5421.078416669176;5487.094629386186;5523.309586301712;5524.751386187631;5527.309086364205;8358.749237522885;8385.413021088587;8474.576271186415;8551.273141782895;8618.698345558001;8383.329333653293;8397.6221070052;8514;8519.062903080656;8527.275181609508;6653.101831252816;6693.899591506131;6740.528163028541;6751.5611485254285;6791.456683465311;6848.383645471931;6900.689468974008;6902.24075351721;6902.413294869792;6916.100906882274;7718.112417072109;7793.571353575608;7804.219578042151;7915.525068495908;7936.920630793618;7834.608269586612;7961.562114083781;7975.5613441261285;7986.720464783704;8133.715319963773;6651.090034255406;6658.3674550917585;6720.462363011045;6728;6741.460683145435;7156.463265255231;7248.637568121468;7298.63506824646;7299.343059124704;7304.123505179413;6782.152230971129;6860.5540639858245;6935.375816176568;6961.303869613201;6965.059716938148;6727.966360168168;6729.427998620172;6779.186497620317;6840.179178498612;6894.551854129466;5749.770009199752;5942.168096466412;6403.423691867754;6766.255711871591;6823.147106611674;5951.583389162717;6218.409251121137;6223.408776166257;6236.719347629459;6248.843778905563;6061.121137434959;6140.662263575547;6151.446369826737;6169.383061693974;6178 18:58:08 INFO - 2015-11-14 18:58:08,581 DEBUG : BROWSER_OUTPUT: |4;prototype.html;306.59682517489506;309.95195744659577;310.4985448500672;326.404312130362;329.74609550646016;5943.732532036058;6019.428154325337;6076.848078798027;6103.542234332421;6116.143739876421;5849.356570777211;6015.6089854159445;6030.09548567714;6038.275406951161;6043.909341359872;4659.860204193879;4666.929996050045;4668.229742092551;4673.43918729752;4676.78954447049;4425.690201685883;4496.685232033759;4531.43357080365;4604.861854144364;4657.743824089674;4539.931901021488;4541.409616749818;4556.612687921531;4557.043020965584;4580.358749775034;4560.475545312282;4561.498235194126;4610.354550362952;4627.768611569408;4630.4443466784205;4056.6146216109423;4058.3303754880408;4058.8782336529953;4062.0454193264854;4069.9389509157386;5661.745221465044;5715.685637289989;5756.338021127582;5757.07886738124;5760.366359700472;5402.702851343174;5403.243545903577;5417.83746487606;5426.131818908955;5426.403095659474;6132.141500189977;6425.710843012076;6432.06735023419;6442.581232219891;6448.838779030515;4397.164538737662;4407.669424793154;4506.031203291275;4511;4532.048269863332;6577.6711164441585;6698.866022679568;6707.597544147318;6708.161479815072;6713.664316784141;4638.420197475316;4646.721196728207;4647.814087436533;4651.046535460223;4653.86038418848;4554.63562914966;4699.78850951708;4713.670043097019;4717.575418212309;4724.787384567703;5417.214503896992;5425.647332923348;5427.43011983744;5430.8913821723345;5432.782688692487;6496.415322620892;6536.705848236841;6537.640429776313;6542.214934207926;6542.967285163544;1647.2751989124747;1669.4157045034383;1670.089801058426;1670.8830381873152;1671.8244584318716;1088.080571916745;1097.0346095436125;1108.3848464102339;1130.231442619027;1152.072581571826;6277.246730392382;6297.685115744194;6297.897867873104;6302.684865756693;6305.558610897285;6630.403263706289;6656.900146497806;6666.266710661824;6668.466522678174;6678.265390807007;6236.064590311399;6271.811845644638;6278.529110316745;6285.9057114143325;6291.245050593958;3630.3465376232;3661.377565813818;3668.0829792551863;3668.871589494355;3670.137517683342;6961.129858767654;7038.331358521034;7065.6113913735235;7067.293270672892;7069.8939515907305;6815.054714160106;6883.139607549057;6920.100386949664;6927.411170050501;6928.896066559006;6948.33990770876;6953.339432753982;6953.79138625842;6954.095967524189;6959.269276725972;6421.454176395058;6587.571807832475;6639.601623902581;6720.495962802712;6739.359760822714;6627.403533681992;6682.365175308338;6685.8997115044285;6687.799366019027;6692.765753198614;6994.300569942965;7032.859342813217;7035.33164349386;7036.366726994595;7044.15470143586;4376.299792033259;4492.483364413134;4532.0935812838225;4536.070105628404;4545.886352841206;6631.270560238467;6675.332466753286;6685.431738302299;6695.12963314766;6696.464282857262;6483.708233129615;6500.5449618526245;6505.8698826024165;6507.967460162668;6515.250746164063;6354.682265886595;6482.837929051811;6493.603875166862;6525.967370163309;6557.409833114852;6427.196600424947;6427.6786160690845;6428;6436.259830119596;6442.484601231984;6567.408933196035;6574.304535140569;6576.079348891255;6577.079208910852;6581.572197807127;6235.438810507076;6388.616682999035;6404.263509696445;6408.679566021773;6419.101325814297 18:58:08 INFO - 2015-11-14 18:58:08,584 DEBUG : BROWSER_OUTPUT: |5;yui.html;747.133325342602;835.4360806455642;841.545565394687;846.3313981954254;874.5889431966973;12640;12782.3608819559;12828.037897157727;12854.22874627522;12894.097413181082;12909.677258068554;13260.602181934533;13282.867171328307;13298.268595227259;13308.933455332734;663.7179198840497;675.2403546010738;810.7081450677751;818.1327792539927;818.8362327534487;793.9995605537036;813.4915677701437;813.7070654564352;816.9142240064797;816.9223923727236;695.7808290388537;839.5760141128721;859.9699010534632;863.568215892054;863.9308855291562;687.3573209049555;841.2008591837779;847.1697736218479;847.2120927537388;847.559269180026;609.716481835944;615.9753609855601;626.0702856258453;626.0796628955428;626.7680958045506;12874.420651070724;12985.610431687064;12989.675258118623;12991;13026;11873.465694043789;13053.15154514963;13070.477180912847;13380;13403.798943015863;9919.702408927744;9940.304178707493;10177.18582513397;10250.38497690141;10311.43287119208;3241.8703251869897;3272.1165285373054;3361.9327613447595;3429.9485507717404;3445.8621655133766;41469.58530414687;42476.3628545569;47033.29450058252;47207;47517;7336.229695881855;7448.217937116633;7546;7618.8095297618;7647.005889234475;11569.363684997406;11612.071034317234;11613.477393517313;11644.941775291069;11668.474918628683;6876.346747059021;6951.374376306157;6977.825554361181;6981.162260528769;7085.504014719023;4346.261135606955;4448.933266001012;4531.77341132942;4544.636429085731;4657.673962822638;2690.421559364746;2707.1878436468983;2710.105665130502;2714.3078514978556;2714.6063820746276;424.73241857629495;436.11033491677256;441.5981456874229;444.5554445554446;446.15453715210145;637.2384999925138;677.5392732941549;677.8644271145691;692.1417442371423;698.7833771530842;8306;9816.558254878404;9923.503824808731;9947.452890091114;10053.69838904834;523.5680563535099;620.4632992461488;668.5320275806857;687.5359132585585;709.4643544124257;4217.810198541073;4254.808533615995;4264.360345948133;4375.671824613167;4391.494978077562;49836.25245621319;50190;50581;50616;50737.492625073275;44750.55249447529;44806.55193448024;45491.31763023557;45525.08949820985;52992.20511692328;46178.53821461809;48494.27258591124;48896.755516222904;48937.75531122321;49018.754906225244;8430.873536896828;8655.913440865763;8656.48061116335;8673.956630216808;8801.91198088011;34937;35119.47320790139;35857.82071089628;35866.46200306945;36015.63984360123;42605.147897041265;44497.777511113534;45136.09727805491;45535.31697024481;45933.77033114813;10744.355338679705;10864.782704346027;10944;11189.72025699364;11237.101031917591;10999.395033273247;11174.832377514182;11250.549978001116;11387.373694446886;11871.643850684493;10456.947715261374;10730.409827459252;11185.66443006711;11689;11837.82243266369;10975.560977560808;10983.780324393627;11080.168987326144;11301.321920684784;11466.71333216643;10873.891261087289;11032.669019929415;11050.240579580444;11111.777764444827;11252.66242012741;9663.323567350219;9716.659916902874;9760.365576237522;9903.851442228228;9932.155766759906;8952.552372381486;9047.864282035644;9274.721758347261;9379.202767764817;9411.95294023553 18:58:08 INFO - 2015-11-14 18:58:08,584 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:58:08 INFO - 2015-11-14 18:58:08,584 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:58:08 INFO - 2015-11-14 18:58:08,585 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1007 18:58:08 INFO - 2015-11-14 18:58:08,585 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:58:08 INFO - 2015-11-14 18:58:08,585 DEBUG : BROWSER_OUTPUT: __startTimestamp1447556288569__endTimestamp 18:58:08 INFO - 2015-11-14 18:58:08,585 DEBUG : BROWSER_OUTPUT: 18:58:08 INFO - 2015-11-14 18:58:08,585 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:58:08 INFO - 2015-11-14 18:58:08,585 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:58:08 INFO - 2015-11-14 18:58:08,586 DEBUG : BROWSER_OUTPUT: 18:58:08 INFO - 2015-11-14 18:58:08,586 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5334.72 Median:5544.97 stddev:598.80 (10.8%) stddev-sans-first:575.09 18:58:08 INFO - 2015-11-14 18:58:08,586 DEBUG : BROWSER_OUTPUT: Values: 3129.1 3201.4 3237.8 3241.9 3273.8 5086.8 5246.6 5376.9 5378.1 5383.9 5220.6 5264.2 5273.6 5278.0 5343.6 4737.7 4877.7 4910.9 4919.7 5037.5 4710.1 4955.6 4979.9 5008.8 5084.8 4606.0 4711.4 4728.4 4731.8 4817.2 4842.6 4846.2 4871.9 4889.8 4893.0 4681.7 4844.5 4851.7 4857.1 4886.0 5065.9 5161.9 5172.7 5181.7 5210.6 5800.2 5854.7 5866.1 5867.8 5872.6 5874.8 5877.3 5881.0 5891.5 5898.4 5217.9 5313.8 5314.1 5380.4 5426.5 5882.9 5884.5 5885.8 5904.8 5949.0 5474.8 5742.0 5754.6 5776.5 5777.8 5615.5 5729.8 5735.2 5743.2 5769.3 5648.2 5649.2 5652.3 5656.1 5668.1 5656.2 5661.5 5674.1 5681.9 5795.5 4387.6 4442.4 4448.8 4460.4 4478.4 3966.9 3985.2 3987.7 4012.0 4018.9 5342.6 5530.4 5534.0 5538.3 5544.7 5636.1 5709.9 5763.6 5785.7 5821.9 5411.8 5464.2 5466.3 5478.8 5498.3 4888.5 4971.1 4972.6 4977.5 5017.2 5881.6 5925.1 5928.6 5942.3 5980.5 5770.4 5816.9 5818.9 5821.5 5822.1 5816.7 5942.1 6018.6 6030.1 6031.7 5692.6 5754.7 5758.3 5759.0 5802.0 5688.7 5691.5 5692.9 5695.9 5698.4 5438.7 5512.4 5545.0 5551.8 5552.5 5648.5 5678.7 5680.5 5681.6 5687.5 5570.5 5572.6 5574.0 5578.2 5584.9 5363.9 5420.6 5514.9 5515.7 5682.1 5547.1 5557.0 5560.0 5581.8 5588.2 18:58:08 INFO - 2015-11-14 18:58:08,586 DEBUG : BROWSER_OUTPUT: 18:58:08 INFO - 2015-11-14 18:58:08,586 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44648.91 Median:31328.11 stddev:70944.80 (226.5%) stddev-sans-first:71066.57 18:58:08 INFO - 2015-11-14 18:58:08,588 DEBUG : BROWSER_OUTPUT: Values: 556.3 575.4 584.6 593.1 594.5 31975.0 39406.6 40289.4 40317.0 40350.0 42478.2 42877.1 42979.0 43129.0 43242.6 7668.3 7811.5 8807.3 8984.9 8985.8 10404.2 10687.3 10697.1 10700.4 10704.3 10423.9 10507.8 10515.9 10517.9 10526.5 7755.1 7919.9 10469.1 10525.1 10842.9 10318.3 10480.8 10506.1 10511.3 10514.5 39922.4 40404.0 40413.8 40489.8 40494.8 3036.8 3076.3 3248.5 3548.3 3924.9 29111.6 29500.1 29726.9 29736.6 29804.3 3262.9 3304.0 3381.2 3383.6 3411.2 282576.0 283193.6 283363.0 283998.0 285258.0 55712.0 56048.0 56491.0 58411.7 58667.0 60554.0 60630.7 60756.7 60811.7 60855.0 16125.3 16319.8 16352.3 16369.9 16370.6 12340.7 12383.8 12458.6 12480.8 12489.3 19377.5 19586.8 19620.9 19676.9 19779.3 7466.0 7525.4 7531.7 7581.3 7661.9 851.6 906.2 1024.9 1028.3 1040.1 28086.3 28478.4 28577.0 28671.6 28828.7 978.5 995.1 1003.5 1005.5 1109.5 14159.6 14212.9 14217.9 14369.5 14502.3 252269.0 255945.0 256472.0 256917.0 257264.0 49209.0 49336.5 49428.8 49477.3 49545.3 1269.9 1286.4 1294.4 1296.0 1306.2 26796.9 27534.4 28009.6 28014.0 28059.7 44392.1 45008.5 49843.3 51219.7 51268.5 274679.0 276652.0 278515.0 279046.0 279131.0 27847.6 28342.4 30964.5 30971.8 31304.5 43830.6 43931.0 43933.8 44024.6 44634.6 33248.0 35493.5 35563.0 35673.0 36056.3 35030.8 35613.1 36074.0 36142.6 36351.5 34708.7 35281.8 35628.8 35877.3 36199.8 31351.7 32221.9 32621.0 32791.3 32955.3 23809.5 23883.6 23961.8 24021.0 24184.0 18:58:08 INFO - 2015-11-14 18:58:08,588 DEBUG : BROWSER_OUTPUT: 18:58:08 INFO - 2015-11-14 18:58:08,588 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26278.66 Median:234202.40 stddev:82706.43 (35.3%) stddev-sans-first:82915.52 18:58:08 INFO - 2015-11-14 18:58:08,589 DEBUG : BROWSER_OUTPUT: Values: 346.6 347.5 349.1 350.7 351.5 13987.2 14375.4 16757.7 17363.9 18661.0 16165.1 16564.5 17044.7 17337.5 17373.9 5215.4 5340.4 5344.5 5345.5 5350.3 3797.1 3893.5 5363.8 5790.4 5991.3 5878.2 5879.6 5914.8 5917.4 5944.3 5745.1 5847.0 5861.8 5863.3 5868.1 5126.8 5133.4 5139.4 5154.8 5164.1 13548.3 13759.8 13989.1 14047.4 14065.2 1768.4 1837.5 1857.0 1860.1 1869.7 9940.6 10089.5 10104.7 10420.1 10446.0 1657.5 1676.8 1716.2 1727.6 1740.9 60695.0 61249.7 62115.0 62868.1 63435.7 7034.8 7063.6 7081.4 7116.5 7125.1 8534.3 8547.8 8553.2 8561.4 8561.6 5762.1 5826.6 5844.0 5875.5 5885.4 6079.2 6112.9 6119.4 6126.2 6146.5 3271.9 3299.1 3311.5 3332.6 3334.3 1118.1 1146.9 1150.5 1151.5 1174.4 444.8 462.1 467.8 483.5 500.1 10228.9 11203.5 11712.0 11830.3 12116.3 447.6 473.2 474.0 474.6 496.7 6475.2 6704.1 6726.8 6796.4 6813.4 467937.0 471230.0 500936.0 537789.0 539165.0 70475.6 75756.2 75934.0 77665.6 78848.2 525.6 535.7 535.9 537.2 537.9 11023.2 11282.8 11319.2 11457.1 11573.4 33537.7 33826.8 34526.3 34774.1 35980.6 46585.3 47302.1 48486.3 48554.8 49370.3 6639.0 6690.6 6971.8 6991.3 6992.2 12392.0 12687.5 12828.4 12842.4 12909.7 10910.3 11091.0 11120.8 11128.6 11356.7 10845.7 10855.2 10901.1 10959.4 11057.8 11086.6 11219.2 11282.7 11384.1 11397.5 6837.2 6897.3 6960.0 6979.7 6981.1 10879.7 10883.9 11065.6 11360.7 11450.8 18:58:08 INFO - 2015-11-14 18:58:08,589 DEBUG : BROWSER_OUTPUT: 18:58:08 INFO - 2015-11-14 18:58:08,590 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5142.02 Median:6676.13 stddev:2639.52 (39.5%) stddev-sans-first:2631.47 18:58:08 INFO - 2015-11-14 18:58:08,590 DEBUG : BROWSER_OUTPUT: Values: 1342.4 1675.7 1729.1 1732.1 1748.9 6622.6 7159.1 7382.0 7392.7 7416.1 7261.5 7356.9 7357.6 7359.4 7385.3 1916.9 1951.4 2165.9 2207.8 2226.9 2251.0 2252.6 2254.1 2254.8 2259.6 2026.6 2085.0 2085.8 2087.5 2088.6 1852.1 1890.7 2064.6 2083.7 2100.1 2208.4 2222.1 2236.9 2249.5 2251.0 7362.2 7468.7 7481.4 7482.0 7489.8 4396.1 4490.3 4497.5 4500.4 4505.2 2853.2 2909.3 2910.3 2939.2 2959.6 830.7 861.0 861.9 864.7 911.3 9861.5 9867.3 9870.5 9880.7 9888.5 3971.6 4018.6 4066.6 4068.0 4090.3 8454.2 8548.2 8550.0 8556.4 8560.4 4473.9 4520.3 4520.4 4527.4 4529.0 4129.3 4141.0 4141.6 4143.6 4150.1 3573.2 3604.9 3614.4 3633.6 3638.7 1156.6 1182.6 1183.1 1183.3 1199.6 946.1 952.2 963.1 1032.8 1258.8 6280.3 6613.5 6950.1 6951.4 6954.7 673.6 683.0 697.3 706.1 711.7 5421.1 5487.1 5523.3 5524.8 5527.3 8358.7 8385.4 8474.6 8551.3 8618.7 8383.3 8397.6 8514.0 8519.1 8527.3 6653.1 6693.9 6740.5 6751.6 6791.5 6848.4 6900.7 6902.2 6902.4 6916.1 7718.1 7793.6 7804.2 7915.5 7936.9 7834.6 7961.6 7975.6 7986.7 8133.7 6651.1 6658.4 6720.5 6728.0 6741.5 7156.5 7248.6 7298.6 7299.3 7304.1 6782.2 6860.6 6935.4 6961.3 6965.1 6728.0 6729.4 6779.2 6840.2 6894.6 5749.8 5942.2 6403.4 6766.3 6823.1 5951.6 6218.4 6223.4 6236.7 6248.8 6061.1 6140.7 6151.4 6169.4 6178.0 18:58:08 INFO - 2015-11-14 18:58:08,590 DEBUG : BROWSER_OUTPUT: 18:58:08 INFO - 2015-11-14 18:58:08,590 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5421.51 Median:6183.79 stddev:1644.77 (26.6%) stddev-sans-first:1603.95 18:58:08 INFO - 2015-11-14 18:58:08,590 DEBUG : BROWSER_OUTPUT: Values: 306.6 310.0 310.5 326.4 329.7 5943.7 6019.4 6076.8 6103.5 6116.1 5849.4 6015.6 6030.1 6038.3 6043.9 4659.9 4666.9 4668.2 4673.4 4676.8 4425.7 4496.7 4531.4 4604.9 4657.7 4539.9 4541.4 4556.6 4557.0 4580.4 4560.5 4561.5 4610.4 4627.8 4630.4 4056.6 4058.3 4058.9 4062.0 4069.9 5661.7 5715.7 5756.3 5757.1 5760.4 5402.7 5403.2 5417.8 5426.1 5426.4 6132.1 6425.7 6432.1 6442.6 6448.8 4397.2 4407.7 4506.0 4511.0 4532.0 6577.7 6698.9 6707.6 6708.2 6713.7 4638.4 4646.7 4647.8 4651.0 4653.9 4554.6 4699.8 4713.7 4717.6 4724.8 5417.2 5425.6 5427.4 5430.9 5432.8 6496.4 6536.7 6537.6 6542.2 6543.0 1647.3 1669.4 1670.1 1670.9 1671.8 1088.1 1097.0 1108.4 1130.2 1152.1 6277.2 6297.7 6297.9 6302.7 6305.6 6630.4 6656.9 6666.3 6668.5 6678.3 6236.1 6271.8 6278.5 6285.9 6291.2 3630.3 3661.4 3668.1 3668.9 3670.1 6961.1 7038.3 7065.6 7067.3 7069.9 6815.1 6883.1 6920.1 6927.4 6928.9 6948.3 6953.3 6953.8 6954.1 6959.3 6421.5 6587.6 6639.6 6720.5 6739.4 6627.4 6682.4 6685.9 6687.8 6692.8 6994.3 7032.9 7035.3 7036.4 7044.2 4376.3 4492.5 4532.1 4536.1 4545.9 6631.3 6675.3 6685.4 6695.1 6696.5 6483.7 6500.5 6505.9 6508.0 6515.3 6354.7 6482.8 6493.6 6526.0 6557.4 6427.2 6427.7 6428.0 6436.3 6442.5 6567.4 6574.3 6576.1 6577.1 6581.6 6235.4 6388.6 6404.3 6408.7 6419.1 18:58:08 INFO - 2015-11-14 18:58:08,590 DEBUG : BROWSER_OUTPUT: 18:58:08 INFO - 2015-11-14 18:58:08,591 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13147.43 Median:45508.20 stddev:15139.62 (33.3%) stddev-sans-first:15153.45 18:58:08 INFO - 2015-11-14 18:58:08,592 DEBUG : BROWSER_OUTPUT: Values: 747.1 835.4 841.5 846.3 874.6 12640.0 12782.4 12828.0 12854.2 12894.1 12909.7 13260.6 13282.9 13298.3 13308.9 663.7 675.2 810.7 818.1 818.8 794.0 813.5 813.7 816.9 816.9 695.8 839.6 860.0 863.6 863.9 687.4 841.2 847.2 847.2 847.6 609.7 616.0 626.1 626.1 626.8 12874.4 12985.6 12989.7 12991.0 13026.0 11873.5 13053.2 13070.5 13380.0 13403.8 9919.7 9940.3 10177.2 10250.4 10311.4 3241.9 3272.1 3361.9 3429.9 3445.9 41469.6 42476.4 47033.3 47207.0 47517.0 7336.2 7448.2 7546.0 7618.8 7647.0 11569.4 11612.1 11613.5 11644.9 11668.5 6876.3 6951.4 6977.8 6981.2 7085.5 4346.3 4448.9 4531.8 4544.6 4657.7 2690.4 2707.2 2710.1 2714.3 2714.6 424.7 436.1 441.6 444.6 446.2 637.2 677.5 677.9 692.1 698.8 8306.0 9816.6 9923.5 9947.5 10053.7 523.6 620.5 668.5 687.5 709.5 4217.8 4254.8 4264.4 4375.7 4391.5 49836.3 50190.0 50581.0 50616.0 50737.5 44750.6 44806.6 45491.3 45525.1 52992.2 46178.5 48494.3 48896.8 48937.8 49018.8 8430.9 8655.9 8656.5 8674.0 8801.9 34937.0 35119.5 35857.8 35866.5 36015.6 42605.1 44497.8 45136.1 45535.3 45933.8 10744.4 10864.8 10944.0 11189.7 11237.1 10999.4 11174.8 11250.5 11387.4 11871.6 10456.9 10730.4 11185.7 11689.0 11837.8 10975.6 10983.8 11080.2 11301.3 11466.7 10873.9 11032.7 11050.2 11111.8 11252.7 9663.3 9716.7 9760.4 9903.9 9932.2 8952.6 9047.9 9274.7 9379.2 9412.0 18:58:08 INFO - 2015-11-14 18:58:08,592 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:58:08 INFO - 2015-11-14 18:58:08,592 DEBUG : BROWSER_OUTPUT: 18:58:09 INFO - 2015-11-14 18:58:09,285 INFO : Browser exited with error code: 0 18:58:09 INFO - 2015-11-14 18:58:09,304 INFO : Completed test dromaeo_css (00:18:33) 18:58:09 INFO - 2015-11-14 18:58:09,304 INFO : Starting test kraken 18:58:09 INFO - 2015-11-14 18:58:09,304 DEBUG : operating with platform_type : linux_ 18:58:09 INFO - 2015-11-14 18:58:09,304 INFO : Initialising browser for kraken test... 18:58:09 INFO - 2015-11-14 18:58:09,310 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpktBhte/profile http://localhost:47241/getInfo.html 18:58:13 INFO - 2015-11-14 18:58:13,129 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:58:13 INFO - 2015-11-14 18:58:13,129 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:58:13 INFO - 2015-11-14 18:58:13,129 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:58:13 INFO - 2015-11-14 18:58:13,129 DEBUG : BROWSER_OUTPUT: __metrics 18:58:13 INFO - 2015-11-14 18:58:13,291 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:58:14 INFO - 2015-11-14 18:58:14,479 INFO : Browser initialized. 18:58:14 INFO - 2015-11-14 18:58:14,479 INFO : Running cycle 1/1 for kraken test... 18:58:14 INFO - 2015-11-14 18:58:14,480 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpktBhte/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:58:26 INFO - 2015-11-14 18:58:26,263 DEBUG : BROWSER_OUTPUT: RSS: Main: 139436032 18:58:26 INFO - 2015-11-14 18:58:26,264 DEBUG : BROWSER_OUTPUT: 18:58:28 INFO - 2015-11-14 18:58:28,777 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47241/tests/kraken/driver.html?testName=audio-beat-detection) 18:58:29 INFO - 2015-11-14 18:58:29,358 DEBUG : BROWSER_OUTPUT: RSS: Main: 176668672 18:58:29 INFO - 2015-11-14 18:58:29,358 DEBUG : BROWSER_OUTPUT: 18:58:31 INFO - 2015-11-14 18:58:31,942 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47241/tests/kraken/driver.html?testName=audio-dft) 18:58:32 INFO - 2015-11-14 18:58:32,516 DEBUG : BROWSER_OUTPUT: RSS: Main: 165863424 18:58:32 INFO - 2015-11-14 18:58:32,516 DEBUG : BROWSER_OUTPUT: 18:58:35 INFO - 2015-11-14 18:58:35,457 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47241/tests/kraken/driver.html?testName=audio-fft) 18:58:36 INFO - 2015-11-14 18:58:36,018 DEBUG : BROWSER_OUTPUT: RSS: Main: 150474752 18:58:36 INFO - 2015-11-14 18:58:36,018 DEBUG : BROWSER_OUTPUT: 18:58:37 INFO - 2015-11-14 18:58:37,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47241/tests/kraken/driver.html?testName=audio-oscillator) 18:58:38 INFO - 2015-11-14 18:58:38,560 DEBUG : BROWSER_OUTPUT: RSS: Main: 154886144 18:58:38 INFO - 2015-11-14 18:58:38,561 DEBUG : BROWSER_OUTPUT: 18:58:40 INFO - 2015-11-14 18:58:40,720 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:58:41 INFO - 2015-11-14 18:58:41,281 DEBUG : BROWSER_OUTPUT: RSS: Main: 155353088 18:58:41 INFO - 2015-11-14 18:58:41,281 DEBUG : BROWSER_OUTPUT: 18:58:44 INFO - 2015-11-14 18:58:44,185 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47241/tests/kraken/driver.html?testName=imaging-darkroom) 18:58:44 INFO - 2015-11-14 18:58:44,754 DEBUG : BROWSER_OUTPUT: RSS: Main: 155926528 18:58:44 INFO - 2015-11-14 18:58:44,754 DEBUG : BROWSER_OUTPUT: 18:58:48 INFO - 2015-11-14 18:58:48,122 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47241/tests/kraken/driver.html?testName=imaging-desaturate) 18:58:48 INFO - 2015-11-14 18:58:48,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 155865088 18:58:48 INFO - 2015-11-14 18:58:48,703 DEBUG : BROWSER_OUTPUT: 18:58:51 INFO - 2015-11-14 18:58:51,468 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47241/tests/kraken/driver.html?testName=json-parse-financial) 18:58:52 INFO - 2015-11-14 18:58:52,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 155840512 18:58:52 INFO - 2015-11-14 18:58:52,042 DEBUG : BROWSER_OUTPUT: 18:58:53 INFO - 2015-11-14 18:58:53,595 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:58:54 INFO - 2015-11-14 18:58:54,157 DEBUG : BROWSER_OUTPUT: RSS: Main: 164634624 18:58:54 INFO - 2015-11-14 18:58:54,157 DEBUG : BROWSER_OUTPUT: 18:58:55 INFO - 2015-11-14 18:58:55,979 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47241/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:58:56 INFO - 2015-11-14 18:58:56,582 DEBUG : BROWSER_OUTPUT: RSS: Main: 163426304 18:58:56 INFO - 2015-11-14 18:58:56,582 DEBUG : BROWSER_OUTPUT: 18:58:58 INFO - 2015-11-14 18:58:58,613 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:58:59 INFO - 2015-11-14 18:58:59,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 167899136 18:58:59 INFO - 2015-11-14 18:58:59,187 DEBUG : BROWSER_OUTPUT: 18:59:01 INFO - 2015-11-14 18:59:01,586 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:59:02 INFO - 2015-11-14 18:59:02,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 177782784 18:59:02 INFO - 2015-11-14 18:59:02,168 DEBUG : BROWSER_OUTPUT: 18:59:04 INFO - 2015-11-14 18:59:04,715 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:59:05 INFO - 2015-11-14 18:59:05,288 DEBUG : BROWSER_OUTPUT: RSS: Main: 176492544 18:59:05 INFO - 2015-11-14 18:59:05,288 DEBUG : BROWSER_OUTPUT: 18:59:06 INFO - 2015-11-14 18:59:06,943 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47241/tests/kraken/driver.html?testName=ai-astar) 18:59:07 INFO - 2015-11-14 18:59:07,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 235991040 18:59:07 INFO - 2015-11-14 18:59:07,201 DEBUG : BROWSER_OUTPUT: 18:59:07 INFO - 2015-11-14 18:59:07,201 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:59:07 INFO - 2015-11-14 18:59:07,201 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:59:07 INFO - 2015-11-14 18:59:07,201 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:59:07 INFO - 2015-11-14 18:59:07,201 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:59:07 INFO - 2015-11-14 18:59:07,201 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;113;105;111;110;111;101;110;102;111 18:59:07 INFO - 2015-11-14 18:59:07,202 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;131;147;162;126;149;149;125;171;125 18:59:07 INFO - 2015-11-14 18:59:07,202 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;161;162;161;161;161;162;162;160 18:59:07 INFO - 2015-11-14 18:59:07,202 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;73;95;71;72;73;94;94;73 18:59:07 INFO - 2015-11-14 18:59:07,202 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;135;91;91;91;137;91;92;133 18:59:07 INFO - 2015-11-14 18:59:07,202 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;110;109;109;110;110;110 18:59:07 INFO - 2015-11-14 18:59:07,202 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;144;145;145;145;147;145;145;145;146 18:59:07 INFO - 2015-11-14 18:59:07,202 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;95;96;96;95;96;96;95 18:59:07 INFO - 2015-11-14 18:59:07,203 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;58;57;57;57;58;56;68;54;55 18:59:07 INFO - 2015-11-14 18:59:07,203 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;70;69;69;69;70;69;69;69 18:59:07 INFO - 2015-11-14 18:59:07,203 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;85;85;84;85;85;84;84;87;86 18:59:07 INFO - 2015-11-14 18:59:07,203 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;113;128;116;117;120;120;116;124;132;125 18:59:07 INFO - 2015-11-14 18:59:07,203 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;155;147;149;147;152;150;147;148;142 18:59:07 INFO - 2015-11-14 18:59:07,203 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;66;70;70;65;65;65;66;66;66 18:59:07 INFO - 2015-11-14 18:59:07,203 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:59:07 INFO - 2015-11-14 18:59:07,204 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:59:07 INFO - 2015-11-14 18:59:07,204 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,911 18:59:07 INFO - 2015-11-14 18:59:07,204 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:59:07 INFO - 2015-11-14 18:59:07,204 DEBUG : BROWSER_OUTPUT: __startTimestamp1447556347196__endTimestamp 18:59:07 INFO - 2015-11-14 18:59:07,204 DEBUG : BROWSER_OUTPUT: 18:59:07 INFO - 2015-11-14 18:59:07,204 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:59:07 INFO - 2015-11-14 18:59:07,206 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:59:07 INFO - 2015-11-14 18:59:07,206 DEBUG : BROWSER_OUTPUT: 18:59:07 INFO - 2015-11-14 18:59:07,206 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.30 Median:110.50 stddev:4.14 (3.7%) stddev-sans-first:4.38 18:59:07 INFO - 2015-11-14 18:59:07,206 DEBUG : BROWSER_OUTPUT: Values: 109.0 113.0 105.0 111.0 110.0 111.0 101.0 110.0 102.0 111.0 18:59:07 INFO - 2015-11-14 18:59:07,206 DEBUG : BROWSER_OUTPUT: 18:59:07 INFO - 2015-11-14 18:59:07,206 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.50 Median:149.00 stddev:16.19 (10.9%) stddev-sans-first:17.01 18:59:07 INFO - 2015-11-14 18:59:07,207 DEBUG : BROWSER_OUTPUT: Values: 150.0 131.0 147.0 162.0 126.0 149.0 149.0 125.0 171.0 125.0 18:59:07 INFO - 2015-11-14 18:59:07,207 DEBUG : BROWSER_OUTPUT: 18:59:07 INFO - 2015-11-14 18:59:07,207 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 18:59:07 INFO - 2015-11-14 18:59:07,207 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 161.0 162.0 161.0 161.0 161.0 162.0 162.0 160.0 18:59:07 INFO - 2015-11-14 18:59:07,207 DEBUG : BROWSER_OUTPUT: 18:59:07 INFO - 2015-11-14 18:59:07,207 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.90 Median:73.00 stddev:10.67 (14.6%) stddev-sans-first:11.02 18:59:07 INFO - 2015-11-14 18:59:07,208 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 73.0 95.0 71.0 72.0 73.0 94.0 94.0 73.0 18:59:07 INFO - 2015-11-14 18:59:07,208 DEBUG : BROWSER_OUTPUT: 18:59:07 INFO - 2015-11-14 18:59:07,208 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.20 Median:91.00 stddev:21.28 (23.4%) stddev-sans-first:21.94 18:59:07 INFO - 2015-11-14 18:59:07,208 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 135.0 91.0 91.0 91.0 137.0 91.0 92.0 133.0 18:59:07 INFO - 2015-11-14 18:59:07,208 DEBUG : BROWSER_OUTPUT: 18:59:07 INFO - 2015-11-14 18:59:07,208 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 18:59:07 INFO - 2015-11-14 18:59:07,209 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 110.0 109.0 109.0 110.0 110.0 110.0 18:59:07 INFO - 2015-11-14 18:59:07,209 DEBUG : BROWSER_OUTPUT: 18:59:07 INFO - 2015-11-14 18:59:07,209 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 18:59:07 INFO - 2015-11-14 18:59:07,209 DEBUG : BROWSER_OUTPUT: Values: 145.0 144.0 145.0 145.0 145.0 147.0 145.0 145.0 145.0 146.0 18:59:07 INFO - 2015-11-14 18:59:07,209 DEBUG : BROWSER_OUTPUT: 18:59:07 INFO - 2015-11-14 18:59:07,209 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 18:59:07 INFO - 2015-11-14 18:59:07,209 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 95.0 18:59:07 INFO - 2015-11-14 18:59:07,209 DEBUG : BROWSER_OUTPUT: 18:59:07 INFO - 2015-11-14 18:59:07,209 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.00 stddev:3.83 (6.7%) stddev-sans-first:4.06 18:59:07 INFO - 2015-11-14 18:59:07,209 DEBUG : BROWSER_OUTPUT: Values: 57.0 58.0 57.0 57.0 57.0 58.0 56.0 68.0 54.0 55.0 18:59:07 INFO - 2015-11-14 18:59:07,210 DEBUG : BROWSER_OUTPUT: 18:59:07 INFO - 2015-11-14 18:59:07,210 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 18:59:07 INFO - 2015-11-14 18:59:07,210 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 70.0 69.0 69.0 69.0 70.0 69.0 69.0 69.0 18:59:07 INFO - 2015-11-14 18:59:07,210 DEBUG : BROWSER_OUTPUT: 18:59:07 INFO - 2015-11-14 18:59:07,210 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.00 stddev:1.14 (1.3%) stddev-sans-first:1.00 18:59:07 INFO - 2015-11-14 18:59:07,210 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 85.0 84.0 85.0 85.0 84.0 84.0 87.0 86.0 18:59:07 INFO - 2015-11-14 18:59:07,210 DEBUG : BROWSER_OUTPUT: 18:59:07 INFO - 2015-11-14 18:59:07,210 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.10 Median:122.00 stddev:6.03 (4.9%) stddev-sans-first:5.63 18:59:07 INFO - 2015-11-14 18:59:07,210 DEBUG : BROWSER_OUTPUT: Values: 113.0 128.0 116.0 117.0 120.0 120.0 116.0 124.0 132.0 125.0 18:59:07 INFO - 2015-11-14 18:59:07,211 DEBUG : BROWSER_OUTPUT: 18:59:07 INFO - 2015-11-14 18:59:07,211 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.50 Median:148.50 stddev:4.79 (3.2%) stddev-sans-first:3.64 18:59:07 INFO - 2015-11-14 18:59:07,211 DEBUG : BROWSER_OUTPUT: Values: 138.0 155.0 147.0 149.0 147.0 152.0 150.0 147.0 148.0 142.0 18:59:07 INFO - 2015-11-14 18:59:07,211 DEBUG : BROWSER_OUTPUT: 18:59:07 INFO - 2015-11-14 18:59:07,212 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.00 stddev:1.90 (2.9%) stddev-sans-first:2.01 18:59:07 INFO - 2015-11-14 18:59:07,212 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 70.0 70.0 65.0 65.0 65.0 66.0 66.0 66.0 18:59:07 INFO - 2015-11-14 18:59:07,212 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:59:07 INFO - 2015-11-14 18:59:07,212 DEBUG : BROWSER_OUTPUT: 18:59:08 INFO - 2015-11-14 18:59:08,073 INFO : Browser exited with error code: 0 18:59:08 INFO - 2015-11-14 18:59:08,125 INFO : Completed test kraken (00:00:58) 18:59:08 INFO - 2015-11-14 18:59:08,125 INFO : Starting test v8_7 18:59:08 INFO - 2015-11-14 18:59:08,125 DEBUG : operating with platform_type : linux_ 18:59:08 INFO - 2015-11-14 18:59:08,125 INFO : Initialising browser for v8_7 test... 18:59:08 INFO - 2015-11-14 18:59:08,131 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcf18zF/profile http://localhost:47241/getInfo.html 18:59:11 INFO - 2015-11-14 18:59:11,963 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:59:11 INFO - 2015-11-14 18:59:11,963 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:59:11 INFO - 2015-11-14 18:59:11,963 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:59:11 INFO - 2015-11-14 18:59:11,963 DEBUG : BROWSER_OUTPUT: __metrics 18:59:12 INFO - 2015-11-14 18:59:12,068 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:59:13 INFO - 2015-11-14 18:59:13,400 INFO : Browser initialized. 18:59:13 INFO - 2015-11-14 18:59:13,401 INFO : Running cycle 1/1 for v8_7 test... 18:59:13 INFO - 2015-11-14 18:59:13,401 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcf18zF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:59:25 INFO - 2015-11-14 18:59:25,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 141250560 18:59:25 INFO - 2015-11-14 18:59:25,198 DEBUG : BROWSER_OUTPUT: 18:59:46 INFO - 2015-11-14 18:59:46,658 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47241/tests/v8_7/run.html (next: http://localhost:47241/tests/v8_7/run.html) 18:59:46 INFO - 2015-11-14 18:59:46,908 DEBUG : BROWSER_OUTPUT: RSS: Main: 584699904 18:59:46 INFO - 2015-11-14 18:59:46,908 DEBUG : BROWSER_OUTPUT: 18:59:46 INFO - 2015-11-14 18:59:46,908 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:59:46 INFO - 2015-11-14 18:59:46,908 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:59:46 INFO - 2015-11-14 18:59:46,909 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:59:46 INFO - 2015-11-14 18:59:46,909 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:59:46 INFO - 2015-11-14 18:59:46,909 DEBUG : BROWSER_OUTPUT: |0;Richards;170.53206002728513 18:59:46 INFO - 2015-11-14 18:59:46,909 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;198.96538002387584 18:59:46 INFO - 2015-11-14 18:59:46,909 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.9593937660852 18:59:46 INFO - 2015-11-14 18:59:46,909 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5060.606060606061 18:59:46 INFO - 2015-11-14 18:59:46,910 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1972.3865877712033 18:59:46 INFO - 2015-11-14 18:59:46,910 DEBUG : BROWSER_OUTPUT: |5;Earley;773.9938080495356 18:59:46 INFO - 2015-11-14 18:59:46,910 DEBUG : BROWSER_OUTPUT: |6;Boyer;12048.192771084337 18:59:46 INFO - 2015-11-14 18:59:46,910 DEBUG : BROWSER_OUTPUT: |7;RegExp;25675 18:59:46 INFO - 2015-11-14 18:59:46,910 DEBUG : BROWSER_OUTPUT: |8;Splay;663.1369953673064 18:59:46 INFO - 2015-11-14 18:59:46,911 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 18:59:46 INFO - 2015-11-14 18:59:46,911 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:59:46 INFO - 2015-11-14 18:59:46,911 DEBUG : BROWSER_OUTPUT: __startTimestamp1447556386906__endTimestamp 18:59:46 INFO - 2015-11-14 18:59:46,911 DEBUG : BROWSER_OUTPUT: 18:59:46 INFO - 2015-11-14 18:59:46,911 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:59:46 INFO - 2015-11-14 18:59:46,912 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:59:46 INFO - 2015-11-14 18:59:46,912 DEBUG : BROWSER_OUTPUT: 18:59:46 INFO - 2015-11-14 18:59:46,912 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:170.53 Median:170.53 stddev:0.00 (0.0%) 18:59:46 INFO - 2015-11-14 18:59:46,912 DEBUG : BROWSER_OUTPUT: Values: 170.5 18:59:46 INFO - 2015-11-14 18:59:46,912 DEBUG : BROWSER_OUTPUT: 18:59:46 INFO - 2015-11-14 18:59:46,913 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:198.97 Median:198.97 stddev:0.00 (0.0%) 18:59:46 INFO - 2015-11-14 18:59:46,913 DEBUG : BROWSER_OUTPUT: Values: 199.0 18:59:46 INFO - 2015-11-14 18:59:46,913 DEBUG : BROWSER_OUTPUT: 18:59:46 INFO - 2015-11-14 18:59:46,913 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.96 Median:285.96 stddev:0.00 (0.0%) 18:59:46 INFO - 2015-11-14 18:59:46,913 DEBUG : BROWSER_OUTPUT: Values: 286.0 18:59:46 INFO - 2015-11-14 18:59:46,913 DEBUG : BROWSER_OUTPUT: 18:59:46 INFO - 2015-11-14 18:59:46,913 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5060.61 Median:5060.61 stddev:0.00 (0.0%) 18:59:46 INFO - 2015-11-14 18:59:46,914 DEBUG : BROWSER_OUTPUT: Values: 5060.6 18:59:46 INFO - 2015-11-14 18:59:46,914 DEBUG : BROWSER_OUTPUT: 18:59:46 INFO - 2015-11-14 18:59:46,914 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1972.39 Median:1972.39 stddev:0.00 (0.0%) 18:59:46 INFO - 2015-11-14 18:59:46,914 DEBUG : BROWSER_OUTPUT: Values: 1972.4 18:59:46 INFO - 2015-11-14 18:59:46,914 DEBUG : BROWSER_OUTPUT: 18:59:46 INFO - 2015-11-14 18:59:46,914 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:773.99 Median:773.99 stddev:0.00 (0.0%) 18:59:46 INFO - 2015-11-14 18:59:46,914 DEBUG : BROWSER_OUTPUT: Values: 774.0 18:59:46 INFO - 2015-11-14 18:59:46,915 DEBUG : BROWSER_OUTPUT: 18:59:46 INFO - 2015-11-14 18:59:46,915 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12048.19 Median:12048.19 stddev:0.00 (0.0%) 18:59:46 INFO - 2015-11-14 18:59:46,915 DEBUG : BROWSER_OUTPUT: Values: 12048.2 18:59:46 INFO - 2015-11-14 18:59:46,915 DEBUG : BROWSER_OUTPUT: 18:59:46 INFO - 2015-11-14 18:59:46,915 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25675.00 Median:25675.00 stddev:0.00 (0.0%) 18:59:46 INFO - 2015-11-14 18:59:46,915 DEBUG : BROWSER_OUTPUT: Values: 25675.0 18:59:46 INFO - 2015-11-14 18:59:46,915 DEBUG : BROWSER_OUTPUT: 18:59:46 INFO - 2015-11-14 18:59:46,915 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:663.14 Median:663.14 stddev:0.00 (0.0%) 18:59:46 INFO - 2015-11-14 18:59:46,916 DEBUG : BROWSER_OUTPUT: Values: 663.1 18:59:46 INFO - 2015-11-14 18:59:46,916 DEBUG : BROWSER_OUTPUT: 18:59:46 INFO - 2015-11-14 18:59:46,916 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 18:59:46 INFO - 2015-11-14 18:59:46,916 DEBUG : BROWSER_OUTPUT: Values: 4830.9 18:59:46 INFO - 2015-11-14 18:59:46,916 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:59:46 INFO - 2015-11-14 18:59:46,916 DEBUG : BROWSER_OUTPUT: 18:59:47 INFO - 2015-11-14 18:59:47,773 INFO : Browser exited with error code: 0 18:59:47 INFO - 2015-11-14 18:59:47,788 INFO : Completed test v8_7 (00:00:39) 18:59:47 INFO - 2015-11-14 18:59:47,858 INFO : Completed test suite (00:20:11) 18:59:47 INFO - 2015-11-14 18:59:47,858 DEBUG : Working with test: dromaeo_css 18:59:47 INFO - 2015-11-14 18:59:47,859 DEBUG : Generating results file: dromaeo_css 18:59:47 INFO - 2015-11-14 18:59:47,860 DEBUG : Working with test: kraken 18:59:47 INFO - 2015-11-14 18:59:47,860 DEBUG : Generating results file: kraken 18:59:47 INFO - 2015-11-14 18:59:47,860 INFO : javascript benchmark 18:59:47 INFO - 2015-11-14 18:59:47,861 DEBUG : Working with test: v8_7 18:59:47 INFO - 2015-11-14 18:59:47,861 DEBUG : Generating results file: v8_7 18:59:47 INFO - 2015-11-14 18:59:47,861 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:59:47 INFO - 2015-11-14 18:59:47,925 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 18:59:47 INFO - 2015-11-14 18:59:47,925 DEBUG : process_Request line: dromaeo_css 6654.04 graph.html#tests=[[72,64,35]] 18:59:47 INFO - 2015-11-14 18:59:47,925 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:59:47 INFO - 2015-11-14 18:59:47,957 DEBUG : process_Request line: kraken 1493.30 graph.html#tests=[[232,64,35]] 18:59:47 INFO - 2015-11-14 18:59:47,957 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:59:48 INFO - 2015-11-14 18:59:48,096 DEBUG : process_Request line: v8_7 19601.11 graph.html#tests=[[230,64,35]] 18:59:48 INFO - 2015-11-14 18:59:48,098 INFO : javascript benchmark 18:59:48 INFO - 2015-11-14 18:59:48,102 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [346.55640779801854, 347.49613061061467, 349.0697291717573, 350.6651148153514, 351.51490942499345, 13987.230702311368, 14375.353109110089, 16757.748633770487, 17363.913180434098, 18660.973646449456, 16165.110918899456, 16564.503064908044, 17044.744328835048, 17337.47987560372, 17373.913130434332, 5215.426303106655, 5340.412554618989, 5344.545713614348, 5345.492178243061, 5350.250964864903, 3797.126660868002, 3893.4743809585766, 5363.758630861621, 5790.392008839074, 5991.340952495222, 5878.177055212273, 5879.617824841393, 5914.822555323347, 5917.408259174092, 5944.346121926585, 5745.109508026263, 5846.970765146169, 5861.824145275648, 5863.325717542494, 5868.061110222387, 5126.846194614168, 5133.409657889353, 5139.357580302462, 5154.793808247666, 5164.122099243138, 13548.322583870866, 13759.79360309596, 13989.090709103875, 14047.43810247589, 14065.226412547307, 1768.3899054826065, 1837.4579499047813, 1856.9721454178198, 1860.1257409017876, 1869.682154033804, 9940.552675129564, 10089.495525223709, 10104.747381315452, 10420.062194402464, 10446.0, 1657.5193193973732, 1676.8323167683134, 1716.2276975361137, 1727.5940154063785, 1740.8868423552556, 60695.0, 61249.693751531406, 62115.0, 62868.05697914535, 63435.68282158606, 7034.753783617549, 7063.611501367372, 7081.362677359062, 7116.5411090726275, 7125.1093613298335, 8534.27458666008, 8547.786305342415, 8553.230209281195, 8561.400701950804, 8561.571921403905, 5762.135679648002, 5826.592138550261, 5844.035734103911, 5875.500582450454, 5885.411458854081, 6079.209702738704, 6112.908306375408, 6119.357467465941, 6126.172966649535, 6146.508279337642, 3271.934561308808, 3299.0762586475826, 3311.536384906115, 3332.5667663204113, 3334.3498017886764, 1118.05524331941, 1146.8853114688463, 1150.5340337163295, 1151.4875880233217, 1174.3775798826637, 444.795394118709, 462.1404188209927, 467.7988464960032, 483.54063639542574, 500.12478163214377, 10228.897711022943, 11203.495842686936, 11712.0, 11830.349330786717, 12116.333601651993, 447.6133887898581, 473.2404490792298, 474.02824210369295, 474.6037059055658, 496.66971463976773, 6475.158229430238, 6704.061431399608, 6726.831829204211, 6796.35434633709, 6813.420859226922, 467937.0, 471230.0, 500936.0, 537789.0, 539165.0, 70475.64762176156, 75756.24243757602, 75934.0, 77665.6116719424, 78848.21151788524, 525.584788017462, 535.6518263128997, 535.9303290572201, 537.2049366936877, 537.9488948549881, 11023.228374013743, 11282.830757538479, 11319.151063670422, 11457.140714446616, 11573.421328933688, 33537.664623353456, 33826.830865846496, 34526.309473810885, 34774.13064673403, 35980.64019359773, 46585.301220481044, 47302.05395891994, 48486.272705910145, 48554.757226213645, 49370.259446107615, 6639.037339585637, 6690.565113267622, 6971.8257043572285, 6991.335823096798, 6992.1958974718555, 12392.0, 12687.492500299884, 12828.358582071045, 12842.422091006114, 12909.677258068623, 10910.290831095954, 11091.0, 11120.777584448104, 11128.610498632508, 11356.716082098013, 10845.674629761119, 10855.18586106061, 10901.127909767041, 10959.397233151934, 11057.83413248818, 11086.556537738401, 11219.158563107636, 11282.661520154408, 11384.14618903569, 11397.544098236309, 6837.213720422016, 6897.310268973062, 6960.0, 6979.651017449209, 6981.127359080115, 10879.728006799893, 10883.891161088288, 11065.612703555336, 11360.715982100513, 11450.82823757661], "dojo.html": [3129.123845323309, 3201.3597280543895, 3237.8057316561008, 3241.88653397131, 3273.819939903304, 5086.771095300711, 5246.632735708502, 5376.8924621507595, 5378.112611419116, 5383.865403364918, 5220.608454365919, 5264.236685680574, 5273.604479664022, 5277.973610131953, 5343.599230057742, 4737.73942433166, 4877.731724755137, 4910.852674419764, 4919.655624106314, 5037.5214354636255, 4710.105080034799, 4955.628327875405, 4979.875503112433, 5008.774605142778, 5084.77118529667, 4605.953940460586, 4711.387519622462, 4728.361671174382, 4731.787069581877, 4817.22924332107, 4842.612590992748, 4846.1761500544635, 4871.8782030449165, 4889.828855990058, 4892.9510704892855, 4681.7190968542, 4844.491328410537, 4851.708897466164, 4857.077155340474, 4885.975570122162, 5065.924011139836, 5161.896762064737, 5172.689638621695, 5181.689098654055, 5210.583153347723, 5800.24596802413, 5854.7072646367515, 5866.14940833581, 5867.823965281048, 5872.647641141545, 5874.765009399619, 5877.265341832271, 5881.029630111027, 5891.499222566087, 5898.439648233411, 5217.947820521784, 5313.787448502094, 5314.123169676998, 5380.381256155514, 5426.511613954763, 5882.852928676817, 5884.499817515473, 5885.793997210077, 5904.822855314347, 5949.0481522956115, 5474.753636086386, 5742.0, 5754.5971781975695, 5776.5089967352405, 5777.768889244383, 5615.466530679579, 5729.770809167587, 5735.1970724098655, 5743.195952566644, 5769.278840144982, 5648.15277708347, 5649.180868774005, 5652.265205523256, 5656.066748986454, 5668.121441176624, 5656.236408084856, 5661.547076233891, 5674.120511320752, 5681.914771278434, 5795.478406943395, 4387.605115539617, 4442.444694413199, 4448.799804008828, 4460.397846290774, 4478.440194975628, 3966.8809935701975, 3985.1830374773103, 3987.7009224308295, 4011.9799401002806, 4018.9397159042637, 5342.572594192456, 5530.446955304437, 5533.976214400349, 5538.307711536058, 5544.667319960815, 5636.134281996167, 5709.914351284734, 5763.625364351304, 5785.681787501728, 5821.912671309934, 5411.756470958816, 5464.23500709901, 5466.3440387153005, 5478.780848766084, 5498.285222921075, 4888.462269150391, 4971.080350135237, 4972.552470277692, 4977.477364876636, 5017.197248440232, 5881.617694849821, 5925.051991681396, 5928.555358348228, 5942.286925568959, 5980.491658209014, 5770.394108618535, 5816.94183058164, 5818.854528636818, 5821.505172060253, 5822.068469045102, 5816.680082595498, 5942.1383899335215, 6018.608790428783, 6030.065339872327, 6031.698415079316, 5692.5730570208225, 5754.6547207167705, 5758.2514273144225, 5759.049756790083, 5802.0426629605645, 5688.744006519633, 5691.516221121251, 5692.914606280826, 5695.914561281667, 5698.430156984268, 5438.673679579238, 5512.39363670004, 5544.972275138599, 5551.8056868011045, 5552.52803511706, 5648.519875810603, 5678.659280443187, 5680.488756011813, 5681.602287839977, 5687.516561092353, 5570.470805273492, 5572.60991730575, 5573.972130139324, 5578.191162281528, 5584.916226256691, 5363.946360536344, 5420.647657902381, 5514.889702206014, 5515.696636685021, 5682.147677848356, 5547.0570003098765, 5557.0, 5560.0, 5581.832545023493, 5588.245586845724], "mootools.html": [1342.369086529332, 1675.6983742926275, 1729.1181497436312, 1732.081996541833, 1748.903810290435, 6622.635755033477, 7159.14090309163, 7381.9630901845485, 7392.7042918283205, 7416.0729908761405, 7261.455390845681, 7356.926430735691, 7357.558546487215, 7359.374453171474, 7385.335319821215, 1916.865819392643, 1951.365806113019, 2165.9241926532573, 2207.8012978831944, 2226.944326391845, 2250.954980900381, 2252.605793986054, 2254.0532976149975, 2254.830887683422, 2259.559385919746, 2026.5946810637859, 2084.9791502085013, 2085.7914208579173, 2087.488565301503, 2088.571842772236, 1852.0832188066927, 1890.735297058406, 2064.6077245323418, 2083.6874468829647, 2100.096958307927, 2208.381653137108, 2222.1333679864865, 2236.8769717665523, 2249.49386388063, 2251.020805949417, 7362.233064064586, 7468.663910124003, 7481.438892083062, 7482.027336446227, 7489.812754681122, 4396.054848207618, 4490.3040028795585, 4497.460304763416, 4500.369948207253, 4505.166544189336, 2853.1583182961076, 2909.301767575788, 2910.2578842395055, 2939.235798692334, 2959.556066590007, 830.667732906836, 861.0184389795638, 861.8621020636668, 864.6843901975734, 911.2983003087586, 9861.457619830906, 9867.309288349818, 9870.50647467631, 9880.703578892644, 9888.456134912576, 3971.5631280559114, 4018.578049304839, 4066.552679205285, 4067.9796601016806, 4090.284200264942, 8454.196851299117, 8548.230659240699, 8549.957250213709, 8556.358273129415, 8560.400771945904, 4473.865784026484, 4520.299353600197, 4520.389747384127, 4527.388802511685, 4528.954710452919, 4129.2773764591075, 4141.047559061372, 4141.585841415895, 4143.56492568282, 4150.086980864205, 3573.1960308930284, 3604.873829415958, 3614.4216925291826, 3633.6184700606054, 3638.6725194732603, 1156.6298784389082, 1182.5979167083233, 1183.0535571542732, 1183.3195912350434, 1199.6041306369052, 946.1106559833735, 952.2001518724305, 963.0706368354571, 1032.8450732390202, 1258.8363512743285, 6280.2777680566405, 6613.503987200979, 6950.061741664912, 6951.443884489228, 6954.65226738661, 673.5992084709688, 682.9760958366434, 697.292248367907, 706.0926709178681, 711.7259854955879, 5421.078416669176, 5487.094629386186, 5523.309586301712, 5524.751386187631, 5527.309086364205, 8358.749237522885, 8385.413021088587, 8474.576271186415, 8551.273141782895, 8618.698345558001, 8383.329333653293, 8397.6221070052, 8514.0, 8519.062903080656, 8527.275181609508, 6653.101831252816, 6693.899591506131, 6740.528163028541, 6751.5611485254285, 6791.456683465311, 6848.383645471931, 6900.689468974008, 6902.24075351721, 6902.413294869792, 6916.100906882274, 7718.112417072109, 7793.571353575608, 7804.219578042151, 7915.525068495908, 7936.920630793618, 7834.608269586612, 7961.562114083781, 7975.5613441261285, 7986.720464783704, 8133.715319963773, 6651.090034255406, 6658.3674550917585, 6720.462363011045, 6728.0, 6741.460683145435, 7156.463265255231, 7248.637568121468, 7298.63506824646, 7299.343059124704, 7304.123505179413, 6782.152230971129, 6860.5540639858245, 6935.375816176568, 6961.303869613201, 6965.059716938148, 6727.966360168168, 6729.427998620172, 6779.186497620317, 6840.179178498612, 6894.551854129466, 5749.770009199752, 5942.168096466412, 6403.423691867754, 6766.255711871591, 6823.147106611674, 5951.583389162717, 6218.409251121137, 6223.408776166257, 6236.719347629459, 6248.843778905563, 6061.121137434959, 6140.662263575547, 6151.446369826737, 6169.383061693974, 6178.0], "ext.html": [556.283948304926, 575.3670961941865, 584.5966283264546, 593.0896074525601, 594.5154698920377, 31975.0, 39406.605933940686, 40289.39565906506, 40317.0, 40350.0, 42478.15043699124, 42877.14245715084, 42979.0, 43129.0, 43242.56757432425, 7668.271514206142, 7811.531308121503, 8807.339449541278, 8984.910150898506, 8985.820283594325, 10404.219683523728, 10687.251892367538, 10697.144228461744, 10700.357978521275, 10704.30422022566, 10423.947880260588, 10507.789844203111, 10515.894841051568, 10517.894821051807, 10526.526306316235, 7755.1469338372735, 7919.920800792033, 10469.110125639292, 10525.105366043896, 10842.891571084347, 10318.277720559563, 10480.790384192349, 10506.106980906632, 10511.316764410289, 10514.474276286155, 39922.40116398256, 40404.0, 40413.79793101016, 40489.79755101235, 40494.79752601247, 3036.7818822504687, 3076.3078307380883, 3248.4964830451318, 3548.3435564420665, 3924.926500430607, 29111.56332655012, 29500.11499655014, 29726.85136574325, 29736.55395169074, 29804.254893627614, 3262.934741305184, 3303.9834800825843, 3381.205416727067, 3383.610884748261, 3411.181316484026, 282576.0, 283193.5840320806, 283363.0, 283998.0, 285258.0, 55712.0, 56048.0, 56491.0, 58411.707941460874, 58667.0, 60554.0, 60630.696846515486, 60756.696216518634, 60811.69594152001, 60855.0, 16125.274362653709, 16319.755203671955, 16352.264148113363, 16369.91815040941, 16370.590735231715, 12340.691482712824, 12383.814242786366, 12458.563950261698, 12480.81278780819, 12489.25064496115, 19377.515562110777, 19586.804131958783, 19620.90189549043, 19676.90161549183, 19779.307724229584, 7466.0, 7525.36034437079, 7531.661075251627, 7581.3176814087, 7661.923380766121, 851.6337974670951, 906.207068814787, 1024.9231307651955, 1028.3007554862616, 1040.0691381213771, 28086.33179847911, 28478.430431391254, 28577.0, 28671.56992645112, 28828.71171288302, 978.5449765858909, 995.0795514149382, 1003.5433877585826, 1005.4570531912832, 1109.5062697099713, 14159.64600884986, 14212.857871421153, 14217.92891035559, 14369.497067602793, 14502.274886255645, 252269.0, 255945.0, 256472.0, 256917.0, 257264.0, 49209.0, 49336.50663493319, 49428.752856235486, 49477.257841132414, 49545.25682114771, 1269.9428525716364, 1286.4468278640088, 1294.4045738960183, 1295.9740805184033, 1306.235852026575, 26796.866015669795, 27534.449311013268, 28009.57985630258, 28014.0, 28059.71940280571, 44392.11215775731, 45008.549914501746, 49843.25235121549, 51219.74390128175, 51268.487315127866, 274679.0, 276652.0, 278515.0, 279046.0, 279131.0, 27847.58228626532, 28342.43315133727, 30964.53553196749, 30971.845140774152, 31304.530432043994, 43830.56169438393, 43931.0, 43933.78033109814, 44024.55975440333, 44634.55365446434, 33248.0, 35493.467597986564, 35563.0, 35673.00247271315, 36056.27887442289, 35030.824845875606, 35613.109672257364, 36074.0, 36142.63857361498, 36351.45472817857, 34708.65291347054, 35281.82359088188, 35628.82185589056, 35877.28245435024, 36199.81900090483, 31351.686483134876, 32221.866943783887, 32621.0, 32791.34417311688, 32955.34089318152, 23809.523809523365, 23883.641745373487, 23961.760382395954, 24021.0, 24184.0], "prototype.html": [306.59682517489506, 309.95195744659577, 310.4985448500672, 326.404312130362, 329.74609550646016, 5943.732532036058, 6019.428154325337, 6076.848078798027, 6103.542234332421, 6116.143739876421, 5849.356570777211, 6015.6089854159445, 6030.09548567714, 6038.275406951161, 6043.909341359872, 4659.860204193879, 4666.929996050045, 4668.229742092551, 4673.43918729752, 4676.78954447049, 4425.690201685883, 4496.685232033759, 4531.43357080365, 4604.861854144364, 4657.743824089674, 4539.931901021488, 4541.409616749818, 4556.612687921531, 4557.043020965584, 4580.358749775034, 4560.475545312282, 4561.498235194126, 4610.354550362952, 4627.768611569408, 4630.4443466784205, 4056.6146216109423, 4058.3303754880408, 4058.8782336529953, 4062.0454193264854, 4069.9389509157386, 5661.745221465044, 5715.685637289989, 5756.338021127582, 5757.07886738124, 5760.366359700472, 5402.702851343174, 5403.243545903577, 5417.83746487606, 5426.131818908955, 5426.403095659474, 6132.141500189977, 6425.710843012076, 6432.06735023419, 6442.581232219891, 6448.838779030515, 4397.164538737662, 4407.669424793154, 4506.031203291275, 4511.0, 4532.048269863332, 6577.6711164441585, 6698.866022679568, 6707.597544147318, 6708.161479815072, 6713.664316784141, 4638.420197475316, 4646.721196728207, 4647.814087436533, 4651.046535460223, 4653.86038418848, 4554.63562914966, 4699.78850951708, 4713.670043097019, 4717.575418212309, 4724.787384567703, 5417.214503896992, 5425.647332923348, 5427.43011983744, 5430.8913821723345, 5432.782688692487, 6496.415322620892, 6536.705848236841, 6537.640429776313, 6542.214934207926, 6542.967285163544, 1647.2751989124747, 1669.4157045034383, 1670.089801058426, 1670.8830381873152, 1671.8244584318716, 1088.080571916745, 1097.0346095436125, 1108.3848464102339, 1130.231442619027, 1152.072581571826, 6277.246730392382, 6297.685115744194, 6297.897867873104, 6302.684865756693, 6305.558610897285, 6630.403263706289, 6656.900146497806, 6666.266710661824, 6668.466522678174, 6678.265390807007, 6236.064590311399, 6271.811845644638, 6278.529110316745, 6285.9057114143325, 6291.245050593958, 3630.3465376232, 3661.377565813818, 3668.0829792551863, 3668.871589494355, 3670.137517683342, 6961.129858767654, 7038.331358521034, 7065.6113913735235, 7067.293270672892, 7069.8939515907305, 6815.054714160106, 6883.139607549057, 6920.100386949664, 6927.411170050501, 6928.896066559006, 6948.33990770876, 6953.339432753982, 6953.79138625842, 6954.095967524189, 6959.269276725972, 6421.454176395058, 6587.571807832475, 6639.601623902581, 6720.495962802712, 6739.359760822714, 6627.403533681992, 6682.365175308338, 6685.8997115044285, 6687.799366019027, 6692.765753198614, 6994.300569942965, 7032.859342813217, 7035.33164349386, 7036.366726994595, 7044.15470143586, 4376.299792033259, 4492.483364413134, 4532.0935812838225, 4536.070105628404, 4545.886352841206, 6631.270560238467, 6675.332466753286, 6685.431738302299, 6695.12963314766, 6696.464282857262, 6483.708233129615, 6500.5449618526245, 6505.8698826024165, 6507.967460162668, 6515.250746164063, 6354.682265886595, 6482.837929051811, 6493.603875166862, 6525.967370163309, 6557.409833114852, 6427.196600424947, 6427.6786160690845, 6428.0, 6436.259830119596, 6442.484601231984, 6567.408933196035, 6574.304535140569, 6576.079348891255, 6577.079208910852, 6581.572197807127, 6235.438810507076, 6388.616682999035, 6404.263509696445, 6408.679566021773, 6419.101325814297], "yui.html": [747.133325342602, 835.4360806455642, 841.545565394687, 846.3313981954254, 874.5889431966973, 12640.0, 12782.3608819559, 12828.037897157727, 12854.22874627522, 12894.097413181082, 12909.677258068554, 13260.602181934533, 13282.867171328307, 13298.268595227259, 13308.933455332734, 663.7179198840497, 675.2403546010738, 810.7081450677751, 818.1327792539927, 818.8362327534487, 793.9995605537036, 813.4915677701437, 813.7070654564352, 816.9142240064797, 816.9223923727236, 695.7808290388537, 839.5760141128721, 859.9699010534632, 863.568215892054, 863.9308855291562, 687.3573209049555, 841.2008591837779, 847.1697736218479, 847.2120927537388, 847.559269180026, 609.716481835944, 615.9753609855601, 626.0702856258453, 626.0796628955428, 626.7680958045506, 12874.420651070724, 12985.610431687064, 12989.675258118623, 12991.0, 13026.0, 11873.465694043789, 13053.15154514963, 13070.477180912847, 13380.0, 13403.798943015863, 9919.702408927744, 9940.304178707493, 10177.18582513397, 10250.38497690141, 10311.43287119208, 3241.8703251869897, 3272.1165285373054, 3361.9327613447595, 3429.9485507717404, 3445.8621655133766, 41469.58530414687, 42476.3628545569, 47033.29450058252, 47207.0, 47517.0, 7336.229695881855, 7448.217937116633, 7546.0, 7618.8095297618, 7647.005889234475, 11569.363684997406, 11612.071034317234, 11613.477393517313, 11644.941775291069, 11668.474918628683, 6876.346747059021, 6951.374376306157, 6977.825554361181, 6981.162260528769, 7085.504014719023, 4346.261135606955, 4448.933266001012, 4531.77341132942, 4544.636429085731, 4657.673962822638, 2690.421559364746, 2707.1878436468983, 2710.105665130502, 2714.3078514978556, 2714.6063820746276, 424.73241857629495, 436.11033491677256, 441.5981456874229, 444.5554445554446, 446.15453715210145, 637.2384999925138, 677.5392732941549, 677.8644271145691, 692.1417442371423, 698.7833771530842, 8306.0, 9816.558254878404, 9923.503824808731, 9947.452890091114, 10053.69838904834, 523.5680563535099, 620.4632992461488, 668.5320275806857, 687.5359132585585, 709.4643544124257, 4217.810198541073, 4254.808533615995, 4264.360345948133, 4375.671824613167, 4391.494978077562, 49836.25245621319, 50190.0, 50581.0, 50616.0, 50737.492625073275, 44750.55249447529, 44806.55193448024, 45491.31763023557, 45525.08949820985, 52992.20511692328, 46178.53821461809, 48494.27258591124, 48896.755516222904, 48937.75531122321, 49018.754906225244, 8430.873536896828, 8655.913440865763, 8656.48061116335, 8673.956630216808, 8801.91198088011, 34937.0, 35119.47320790139, 35857.82071089628, 35866.46200306945, 36015.63984360123, 42605.147897041265, 44497.777511113534, 45136.09727805491, 45535.31697024481, 45933.77033114813, 10744.355338679705, 10864.782704346027, 10944.0, 11189.72025699364, 11237.101031917591, 10999.395033273247, 11174.832377514182, 11250.549978001116, 11387.373694446886, 11871.643850684493, 10456.947715261374, 10730.409827459252, 11185.66443006711, 11689.0, 11837.82243266369, 10975.560977560808, 10983.780324393627, 11080.168987326144, 11301.321920684784, 11466.71333216643, 10873.891261087289, 11032.669019929415, 11050.240579580444, 11111.777764444827, 11252.66242012741, 9663.323567350219, 9716.659916902874, 9760.365576237522, 9903.851442228228, 9932.155766759906, 8952.552372381486, 9047.864282035644, 9274.721758347261, 9379.202767764817, 9411.95294023553]}, "summary": {"lowerIsBetter": false, "suite": 6654.036620784093, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7166.719930297849, "unit": "ms", "value": 7166.719930297849}, "dojo.html": {"lowerIsBetter": false, "filtered": 5295.851078324917, "unit": "ms", "value": 5295.851078324917}, "mootools.html": {"lowerIsBetter": false, "filtered": 4196.015426653826, "unit": "ms", "value": 4196.015426653826}, "ext.html": {"lowerIsBetter": false, "filtered": 18483.636978799586, "unit": "ms", "value": 18483.636978799586}, "prototype.html": {"lowerIsBetter": false, "filtered": 4879.865783667834, "unit": "ms", "value": 4879.865783667834}, "yui.html": {"lowerIsBetter": false, "filtered": 6042.0411365604205, "unit": "ms", "value": 6042.0411365604205}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-001"}, "testrun": {"date": 1447555176, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151114173003", "branch": "Fx-Team", "revision": "5fb6f8b316ca76a5a4c47464900eaed2774d844f"}}, {"talos_counters": {}, "results": {"audio-dft": [160.0, 160.0, 161.0, 162.0, 161.0, 161.0, 161.0, 162.0, 162.0, 160.0], "ai-astar": [109.0, 113.0, 105.0, 111.0, 110.0, 111.0, 101.0, 110.0, 102.0, 111.0], "imaging-gaussian-blur": [110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0], "audio-beat-detection": [150.0, 131.0, 147.0, 162.0, 126.0, 149.0, 149.0, 125.0, 171.0, 125.0], "json-stringify-tinderbox": [69.0, 69.0, 70.0, 69.0, 69.0, 69.0, 70.0, 69.0, 69.0, 69.0], "stanford-crypto-pbkdf2": [138.0, 155.0, 147.0, 149.0, 147.0, 152.0, 150.0, 147.0, 148.0, 142.0], "json-parse-financial": [57.0, 58.0, 57.0, 57.0, 57.0, 58.0, 56.0, 68.0, 54.0, 55.0], "stanford-crypto-sha256-iterative": [67.0, 66.0, 70.0, 70.0, 65.0, 65.0, 65.0, 66.0, 66.0, 66.0], "audio-fft": [72.0, 72.0, 73.0, 95.0, 71.0, 72.0, 73.0, 94.0, 94.0, 73.0], "imaging-darkroom": [145.0, 144.0, 145.0, 145.0, 145.0, 147.0, 145.0, 145.0, 145.0, 146.0], "stanford-crypto-ccm": [113.0, 128.0, 116.0, 117.0, 120.0, 120.0, 116.0, 124.0, 132.0, 125.0], "audio-oscillator": [90.0, 91.0, 135.0, 91.0, 91.0, 91.0, 137.0, 91.0, 92.0, 133.0], "stanford-crypto-aes": [83.0, 85.0, 85.0, 84.0, 85.0, 85.0, 84.0, 84.0, 87.0, 86.0], "imaging-desaturate": [96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1493.3, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 78.9, "unit": "ms", "value": 78.9}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 147.5, "unit": "ms", "value": 147.5}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 143.5, "unit": "ms", "value": 143.5}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 121.1, "unit": "ms", "value": 121.1}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.2, "unit": "ms", "value": 145.2}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 57.7, "unit": "ms", "value": 57.7}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.2, "unit": "ms", "value": 104.2}, "ai-astar": {"lowerIsBetter": true, "filtered": 108.3, "unit": "ms", "value": 108.3}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.0, "unit": "ms", "value": 161.0}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 66.6, "unit": "ms", "value": 66.6}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.2, "unit": "ms", "value": 69.2}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.7, "unit": "ms", "value": 109.7}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 84.8, "unit": "ms", "value": 84.8}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.6, "unit": "ms", "value": 95.6}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-001"}, "testrun": {"date": 1447555176, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151114173003", "branch": "Fx-Team", "revision": "5fb6f8b316ca76a5a4c47464900eaed2774d844f"}}, {"talos_counters": {}, "results": {"DeltaBlue": [198.96538002387584], "Encrypt": [285.9593937660852], "NavierStokes": [4830.917874396136], "Decrypt": [5060.606060606061], "Splay": [663.1369953673064], "Richards": [170.53206002728513], "RegExp": [25675.0], "Earley": [773.9938080495356], "Boyer": [12048.192771084337], "RayTrace": [1972.3865877712033]}, "summary": {"lowerIsBetter": false, "suite": 19601.107851351466, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 332.30906799999985, "unit": "score", "value": 332.30906799999985}, "Encrypt": {"lowerIsBetter": false, "filtered": 930.8349569999998, "unit": "score", "value": 930.8349569999998}, "NavierStokes": {"lowerIsBetter": false, "filtered": 307.1879999999999, "unit": "score", "value": 307.1879999999999}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.59864071856286, "unit": "score", "value": 52.59864071856286}, "Splay": {"lowerIsBetter": false, "filtered": 122.88712674650702, "unit": "score", "value": 122.88712674650702}, "RegExp": {"lowerIsBetter": false, "filtered": 35.48140214216163, "unit": "score", "value": 35.48140214216163}, "Richards": {"lowerIsBetter": false, "filtered": 207.01092800000006, "unit": "score", "value": 207.01092800000006}, "Earley": {"lowerIsBetter": false, "filtered": 861.070196, "unit": "score", "value": 861.070196}, "Boyer": {"lowerIsBetter": false, "filtered": 55.31642899999996, "unit": "score", "value": 55.31642899999996}, "RayTrace": {"lowerIsBetter": false, "filtered": 375.1744229999998, "unit": "score", "value": 375.1744229999998}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-001"}, "testrun": {"date": 1447555176, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151114173003", "branch": "Fx-Team", "revision": "5fb6f8b316ca76a5a4c47464900eaed2774d844f"}}] 18:59:48 INFO - RETURN: dromaeo_css: 6654.04 18:59:48 INFO - RETURN: kraken: 1493.30 18:59:48 INFO - RETURN: v8_7: 19601.11 18:59:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19601.11"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1493.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6654.04"}}} 18:59:48 INFO - Return code: 0 18:59:48 INFO - # TBPL SUCCESS # 18:59:48 INFO - Running post-action listener: _resource_record_post_action 18:59:48 INFO - Running post-run listener: _resource_record_post_run 18:59:49 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 0; Write bytes: 495587328; Read time: 0; Write time: 415092 18:59:49 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 163897344; Read time: 0; Write time: 218984 18:59:49 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 331689984; Read time: 0; Write time: 196108 18:59:49 INFO - Running post-run listener: _upload_blobber_files 18:59:49 INFO - Blob upload gear active. 18:59:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:59:49 INFO - Copying logs to upload dir... 18:59:49 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1272.011553 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-11-14 18:59:48.523509) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-14 18:59:48.527427) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1447554967.110722-66501293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/LLvV23HGTOeFi9rqUixZag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009770 build_url: 'https://queue.taskcluster.net/v1/task/LLvV23HGTOeFi9rqUixZag/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.91 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-14 18:59:49.446642) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 18:59:49.447030) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1447554967.110722-66501293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 18:59:49.466541) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 18:59:49.469420) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 18:59:49.469753) ========= ========= Total master_lag: 1.09 =========