builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1448408797.62 results: success (0) buildid: 20151124143005 builduid: 5666dccb01e54bd49638a2011648eb05 revision: 468f04418267488631e9cce53f8b5138eb6d4698 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 15:46:37.616056) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 15:46:37.616633) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 15:46:37.617109) ========= 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=e10134013339c31d8d0c4708000001d6-1448408225.747718-395407925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006518 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 15:46:37.672368) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 15:46:37.672716) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 15:46:37.732604) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 15:46:37.732889) ========= 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=e10134013339c31d8d0c4708000001d6-1448408225.747718-395407925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.030397 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 15:46:37.787830) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 15:46:37.788150) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 15:46:37.788508) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 15:46:37.788840) ========= 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=e10134013339c31d8d0c4708000001d6-1448408225.747718-395407925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-24 15:46:37-- 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-24 15:46:38 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.263134 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 15:46:38.068063) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 15:46:38.068758) ========= 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=e10134013339c31d8d0c4708000001d6-1448408225.747718-395407925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.055077 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 15:46:38.137174) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 15:46:38.137646) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 468f04418267488631e9cce53f8b5138eb6d4698 --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/b2g-inbound --rev 468f04418267488631e9cce53f8b5138eb6d4698 --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=e10134013339c31d8d0c4708000001d6-1448408225.747718-395407925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-24 15:46:38,157 truncating revision to first 12 chars 2015-11-24 15:46:38,157 Setting DEBUG logging. 2015-11-24 15:46:38,157 attempt 1/10 2015-11-24 15:46:38,157 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/468f04418267?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 15:46:38,850 unpacking tar archive at: b2g-inbound-468f04418267/testing/mozharness/ program finished with exit code 0 elapsedTime=0.974956 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 15:46:39.127526) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 15:46:39.127954) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 15:46:39.138130) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 15:46:39.138458) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 15:46:39.138923) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-24 15:46:39.139284) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 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', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] 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=e10134013339c31d8d0c4708000001d6-1448408225.747718-395407925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:46:39 INFO - MultiFileLogger online at 20151124 15:46:39 in /builds/slave/test-pgo 15:46:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 15:46:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:46:39 INFO - {'append_to_log': False, 15:46:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:46:39 INFO - 'blob_upload_branch': 'B2G-Inbound', 15:46:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:46:39 INFO - 'branch': 'B2G-Inbound', 15:46:39 INFO - 'buildbot_json_path': 'buildprops.json', 15:46:39 INFO - 'config_files': ('talos/linux_config.py',), 15:46:39 INFO - 'default_actions': ('clobber', 15:46:39 INFO - 'read-buildbot-config', 15:46:39 INFO - 'download-and-extract', 15:46:39 INFO - 'populate-webroot', 15:46:39 INFO - 'create-virtualenv', 15:46:39 INFO - 'install', 15:46:39 INFO - 'run-tests'), 15:46:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:46:39 INFO - 'download_minidump_stackwalk': True, 15:46:39 INFO - 'download_symbols': 'ondemand', 15:46:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:46:39 INFO - 'tooltool.py': '/tools/tooltool.py', 15:46:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:46:39 INFO - '/tools/misc-python/virtualenv.py')}, 15:46:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:46:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:46:39 INFO - 'installer_path': 'installer.exe', 15:46:39 INFO - 'log_level': 'info', 15:46:39 INFO - 'log_name': 'talos', 15:46:39 INFO - 'log_to_console': True, 15:46:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:46:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:46:39 INFO - 'opt_config_files': (), 15:46:39 INFO - 'pip_index': False, 15:46:39 INFO - 'sps_profile': False, 15:46:39 INFO - 'sps_profile_interval': 0, 15:46:39 INFO - 'suite': 'dromaeojs', 15:46:39 INFO - 'system_bits': '64', 15:46:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:46:39 INFO - 'title': 'talos-linux64-ix-023', 15:46:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:46:39 INFO - 'use_talos_json': True, 15:46:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:46:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:46:39 INFO - 'work_dir': 'build'} 15:46:39 INFO - ##### 15:46:39 INFO - ##### Running clobber step. 15:46:39 INFO - ##### 15:46:39 INFO - Running pre-action listener: _resource_record_pre_action 15:46:39 INFO - Running main action method: clobber 15:46:39 INFO - rmtree: /builds/slave/test-pgo/build 15:46:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:46:45 INFO - Running post-action listener: _resource_record_post_action 15:46:45 INFO - ##### 15:46:45 INFO - ##### Running read-buildbot-config step. 15:46:45 INFO - ##### 15:46:45 INFO - Running pre-action listener: _resource_record_pre_action 15:46:45 INFO - Running main action method: read_buildbot_config 15:46:45 INFO - Using buildbot properties: 15:46:45 INFO - { 15:46:45 INFO - "properties": { 15:46:45 INFO - "buildnumber": 1002, 15:46:45 INFO - "product": "firefox", 15:46:45 INFO - "script_repo_revision": "production", 15:46:45 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 15:46:45 INFO - "repository": "", 15:46:45 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 15:46:45 INFO - "buildid": "20151124143005", 15:46:45 INFO - "slavename": "talos-linux64-ix-023", 15:46:45 INFO - "pgo_build": "True", 15:46:45 INFO - "basedir": "/builds/slave/test-pgo", 15:46:45 INFO - "project": "", 15:46:45 INFO - "platform": "ubuntu64_hw", 15:46:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:46:45 INFO - "slavebuilddir": "test", 15:46:45 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 15:46:45 INFO - "branch": "b2g-inbound", 15:46:45 INFO - "repo_path": "integration/b2g-inbound", 15:46:45 INFO - "stage_platform": "linux64-pgo", 15:46:45 INFO - "builduid": "5666dccb01e54bd49638a2011648eb05", 15:46:45 INFO - "revision": "468f04418267488631e9cce53f8b5138eb6d4698" 15:46:45 INFO - }, 15:46:45 INFO - "sourcestamp": { 15:46:45 INFO - "repository": "", 15:46:45 INFO - "hasPatch": false, 15:46:45 INFO - "project": "", 15:46:45 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 15:46:45 INFO - "changes": [ 15:46:45 INFO - { 15:46:45 INFO - "category": null, 15:46:45 INFO - "files": [ 15:46:45 INFO - { 15:46:45 INFO - "url": null, 15:46:45 INFO - "name": "https://queue.taskcluster.net/v1/task/hG33TXeuSX21_fUJNUEZzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 15:46:45 INFO - } 15:46:45 INFO - ], 15:46:45 INFO - "repository": "", 15:46:45 INFO - "rev": "468f04418267488631e9cce53f8b5138eb6d4698", 15:46:45 INFO - "who": "sendchange", 15:46:45 INFO - "when": 1448408776, 15:46:45 INFO - "number": 6702486, 15:46:45 INFO - "comments": "", 15:46:45 INFO - "project": "", 15:46:45 INFO - "at": "Tue 24 Nov 2015 15:46:16", 15:46:45 INFO - "branch": "b2g-inbound-linux64-pgo-talos", 15:46:45 INFO - "revlink": "", 15:46:45 INFO - "properties": [ 15:46:45 INFO - [ 15:46:45 INFO - "buildid", 15:46:45 INFO - "20151124143005", 15:46:45 INFO - "Change" 15:46:45 INFO - ], 15:46:45 INFO - [ 15:46:45 INFO - "builduid", 15:46:45 INFO - "5666dccb01e54bd49638a2011648eb05", 15:46:45 INFO - "Change" 15:46:45 INFO - ], 15:46:45 INFO - [ 15:46:45 INFO - "pgo_build", 15:46:45 INFO - "True", 15:46:45 INFO - "Change" 15:46:45 INFO - ] 15:46:45 INFO - ], 15:46:45 INFO - "revision": "468f04418267488631e9cce53f8b5138eb6d4698" 15:46:45 INFO - } 15:46:45 INFO - ], 15:46:45 INFO - "revision": "468f04418267488631e9cce53f8b5138eb6d4698" 15:46:45 INFO - } 15:46:45 INFO - } 15:46:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/hG33TXeuSX21_fUJNUEZzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 15:46:45 INFO - Running post-action listener: _resource_record_post_action 15:46:45 INFO - ##### 15:46:45 INFO - ##### Running download-and-extract step. 15:46:45 INFO - ##### 15:46:45 INFO - Running pre-action listener: _resource_record_pre_action 15:46:45 INFO - Running main action method: download_and_extract 15:46:45 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:45 INFO - https://queue.taskcluster.net/v1/task/hG33TXeuSX21_fUJNUEZzw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:46:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hG33TXeuSX21_fUJNUEZzw/artifacts/public/build/test_packages.json 15:46:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hG33TXeuSX21_fUJNUEZzw/artifacts/public/build/test_packages.json 15:46:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hG33TXeuSX21_fUJNUEZzw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:46:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hG33TXeuSX21_fUJNUEZzw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:46:45 INFO - Downloaded 1302 bytes. 15:46:45 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:46:45 INFO - Using the following test package requirements: 15:46:45 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:46:45 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:46:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:46:45 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:46:45 INFO - u'jsshell-linux-x86_64.zip'], 15:46:45 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:46:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:46:45 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:46:45 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:46:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:46:45 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:46:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:46:45 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:46:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:46:45 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:46:45 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:46:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:46:45 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:45 INFO - https://queue.taskcluster.net/v1/task/hG33TXeuSX21_fUJNUEZzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:46:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hG33TXeuSX21_fUJNUEZzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:46:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hG33TXeuSX21_fUJNUEZzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:46:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hG33TXeuSX21_fUJNUEZzw/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 15:46:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hG33TXeuSX21_fUJNUEZzw/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 15:46:47 INFO - Downloaded 22525846 bytes. 15:46:47 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 15:46:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:46:47 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 15:46:48 INFO - Return code: 0 15:46:48 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 15:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:48 INFO - https://queue.taskcluster.net/v1/task/hG33TXeuSX21_fUJNUEZzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:46:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hG33TXeuSX21_fUJNUEZzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:46:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hG33TXeuSX21_fUJNUEZzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:46:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hG33TXeuSX21_fUJNUEZzw/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 15:46:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hG33TXeuSX21_fUJNUEZzw/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 15:46:50 INFO - Downloaded 22525846 bytes. 15:46:50 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 15:46:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:46:50 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 15:46:51 INFO - Return code: 0 15:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:51 INFO - https://queue.taskcluster.net/v1/task/hG33TXeuSX21_fUJNUEZzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:46:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hG33TXeuSX21_fUJNUEZzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:46:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hG33TXeuSX21_fUJNUEZzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:46:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hG33TXeuSX21_fUJNUEZzw/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 15:46:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hG33TXeuSX21_fUJNUEZzw/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 15:46:53 INFO - Downloaded 11130997 bytes. 15:46:53 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 15:46:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:46:53 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 15:46:53 INFO - Return code: 0 15:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:53 INFO - https://queue.taskcluster.net/v1/task/hG33TXeuSX21_fUJNUEZzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:46:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hG33TXeuSX21_fUJNUEZzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:46:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hG33TXeuSX21_fUJNUEZzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:46:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hG33TXeuSX21_fUJNUEZzw/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 15:46:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hG33TXeuSX21_fUJNUEZzw/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 15:46:54 INFO - Downloaded 57553355 bytes. 15:46:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/hG33TXeuSX21_fUJNUEZzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:46:54 INFO - mkdir: /builds/slave/test-pgo/properties 15:46:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:46:54 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:46:54 INFO - Contents: 15:46:54 INFO - build_url:https://queue.taskcluster.net/v1/task/hG33TXeuSX21_fUJNUEZzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:46:54 INFO - Running post-action listener: _resource_record_post_action 15:46:54 INFO - Running post-action listener: set_extra_try_arguments 15:46:54 INFO - ##### 15:46:54 INFO - ##### Running populate-webroot step. 15:46:54 INFO - ##### 15:46:54 INFO - Running pre-action listener: _resource_record_pre_action 15:46:54 INFO - Running main action method: populate_webroot 15:46:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:46:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:46:54 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:46:54 INFO - '../fennec_ids.txt'], 15:46:54 INFO - 'tests': ['tcheck2']}, 15:46:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:46:54 INFO - '--tppagecycles', 15:46:54 INFO - '7'], 15:46:54 INFO - 'tests': ['tsvgm']}}, 15:46:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:46:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:46:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:46:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:46:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:46:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:46:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:46:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:46:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:46:54 INFO - 'talos_options': ['--e10s'], 15:46:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:46:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:46:54 INFO - 'tests': ['damp', 'tps']}, 15:46:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:46:54 INFO - 'talos_options': ['--e10s'], 15:46:54 INFO - 'tests': ['damp', 'tps']}, 15:46:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:46:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:46:54 INFO - 'other': {'tests': ['a11yr', 15:46:54 INFO - 'ts_paint', 15:46:54 INFO - 'tpaint', 15:46:54 INFO - 'sessionrestore', 15:46:54 INFO - 'sessionrestore_no_auto_restore']}, 15:46:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:46:54 INFO - 'tests': ['a11yr', 15:46:54 INFO - 'ts_paint', 15:46:54 INFO - 'tpaint', 15:46:54 INFO - 'sessionrestore', 15:46:54 INFO - 'sessionrestore_no_auto_restore']}, 15:46:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:46:54 INFO - 'tests': ['a11yr', 15:46:54 INFO - 'ts_paint', 15:46:54 INFO - 'tpaint', 15:46:54 INFO - 'sessionrestore', 15:46:54 INFO - 'sessionrestore_no_auto_restore']}, 15:46:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:46:54 INFO - 'tests': ['a11yr', 15:46:54 INFO - 'ts_paint', 15:46:54 INFO - 'tpaint', 15:46:54 INFO - 'sessionrestore', 15:46:54 INFO - 'sessionrestore_no_auto_restore']}, 15:46:54 INFO - 'other_l64': {'tests': ['a11yr', 15:46:54 INFO - 'ts_paint', 15:46:54 INFO - 'tpaint', 15:46:54 INFO - 'sessionrestore', 15:46:54 INFO - 'sessionrestore_no_auto_restore']}, 15:46:54 INFO - 'other_nol64': {'tests': ['a11yr', 15:46:54 INFO - 'ts_paint', 15:46:54 INFO - 'tpaint', 15:46:54 INFO - 'sessionrestore', 15:46:54 INFO - 'sessionrestore_no_auto_restore']}, 15:46:54 INFO - 'svgr': {'tests': ['tsvgx', 15:46:54 INFO - 'tsvgr_opacity', 15:46:54 INFO - 'tart', 15:46:54 INFO - 'tscrollx', 15:46:54 INFO - 'cart']}, 15:46:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:46:54 INFO - 'tests': ['tsvgx', 15:46:54 INFO - 'tsvgr_opacity', 15:46:54 INFO - 'tart', 15:46:54 INFO - 'tscrollx', 15:46:54 INFO - 'cart']}, 15:46:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:46:54 INFO - 'tests': ['tp5o']}, 15:46:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:46:54 INFO - 'talos_options': ['--e10s'], 15:46:54 INFO - 'tests': ['tp5o']}, 15:46:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:46:54 INFO - 'talos_options': ['--xperf_path', 15:46:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:46:54 INFO - 'tests': ['tp5n']}, 15:46:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:46:54 INFO - 'talos_options': ['--e10s', 15:46:54 INFO - '--xperf_path', 15:46:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:46:54 INFO - 'tests': ['tp5n']}}, 15:46:54 INFO - 'talos.zip': {'path': '', 15:46:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:46:54 INFO - Running post-action listener: _resource_record_post_action 15:46:54 INFO - ##### 15:46:54 INFO - ##### Running create-virtualenv step. 15:46:54 INFO - ##### 15:46:54 INFO - Running pre-action listener: _resource_record_pre_action 15:46:54 INFO - Running main action method: create_virtualenv 15:46:54 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:46:54 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 15:46:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:46:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:46:55 INFO - Using real prefix '/usr' 15:46:55 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:46:55 INFO - Installing distribute.............................................................................................................................................................................................done. 15:46:57 INFO - Installing pip.................done. 15:46:57 INFO - Return code: 0 15:46:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:46:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:46:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:57 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 0x7fd11c538c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23017c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2345d70>, '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 0x2346b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346fb0>, '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': 'e10134013339c31d8d0c4708000001d6-1448408225.747718-395407925', '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 15:46:57 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 15:46:57 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 15:46:57 INFO - Using env: {'DISPLAY': ':0', 15:46:57 INFO - 'HOME': '/home/cltbld', 15:46:57 INFO - 'LANG': 'en_US.UTF-8', 15:46:57 INFO - 'LANGUAGE': 'en_US:en', 15:46:57 INFO - 'LOGNAME': 'cltbld', 15:46:57 INFO - 'MAIL': '/var/mail/cltbld', 15:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:46:57 INFO - 'MOZ_NO_REMOTE': '1', 15:46:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:46:57 INFO - 'NO_EM_RESTART': '1', 15:46:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:46:57 INFO - 'PWD': '/builds/slave/test-pgo', 15:46:57 INFO - 'SHELL': '/bin/bash', 15:46:57 INFO - 'SHLVL': '1', 15:46:57 INFO - 'TERM': 'linux', 15:46:57 INFO - 'TMOUT': '86400', 15:46:57 INFO - 'USER': 'cltbld', 15:46:57 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448408225.747718-395407925', 15:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:46:57 INFO - '_': '/tools/buildbot/bin/python'} 15:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:46:58 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 15:46:58 INFO - Cleaning up... 15:46:58 INFO - Return code: 0 15:46:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:46:58 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')]} 15:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:58 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')]} 15:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:58 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 0x7fd11c538c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23017c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2345d70>, '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 0x2346b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346fb0>, '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': 'e10134013339c31d8d0c4708000001d6-1448408225.747718-395407925', '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 15:46:58 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 15:46:58 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 15:46:58 INFO - Using env: {'DISPLAY': ':0', 15:46:58 INFO - 'HOME': '/home/cltbld', 15:46:58 INFO - 'LANG': 'en_US.UTF-8', 15:46:58 INFO - 'LANGUAGE': 'en_US:en', 15:46:58 INFO - 'LOGNAME': 'cltbld', 15:46:58 INFO - 'MAIL': '/var/mail/cltbld', 15:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:46:58 INFO - 'MOZ_NO_REMOTE': '1', 15:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:46:58 INFO - 'NO_EM_RESTART': '1', 15:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:46:58 INFO - 'PWD': '/builds/slave/test-pgo', 15:46:58 INFO - 'SHELL': '/bin/bash', 15:46:58 INFO - 'SHLVL': '1', 15:46:58 INFO - 'TERM': 'linux', 15:46:58 INFO - 'TMOUT': '86400', 15:46:58 INFO - 'USER': 'cltbld', 15:46:58 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448408225.747718-395407925', 15:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:46:58 INFO - '_': '/tools/buildbot/bin/python'} 15:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:46:58 INFO - Downloading/unpacking psutil>=0.7.1 15:46:58 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 15:46:58 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 15:46:58 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 15:46:58 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 15:46:58 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 15:46:58 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 15:47:00 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 15:47:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:47:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:47:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:47:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:47:00 INFO - Installing collected packages: psutil 15:47:00 INFO - Running setup.py install for psutil 15:47:00 INFO - building 'psutil._psutil_linux' extension 15:47:00 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 15:47:01 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 15:47:01 INFO - building 'psutil._psutil_posix' extension 15:47:01 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 15:47:01 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 15:47:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:47:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:47:01 INFO - Successfully installed psutil 15:47:01 INFO - Cleaning up... 15:47:01 INFO - Return code: 0 15:47:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:47: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')]} 15:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47: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')]} 15:47:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd11c538c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23017c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2345d70>, '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 0x2346b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346fb0>, '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': 'e10134013339c31d8d0c4708000001d6-1448408225.747718-395407925', '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 15:47:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 15:47:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:47:01 INFO - Using env: {'DISPLAY': ':0', 15:47:01 INFO - 'HOME': '/home/cltbld', 15:47:01 INFO - 'LANG': 'en_US.UTF-8', 15:47:01 INFO - 'LANGUAGE': 'en_US:en', 15:47:01 INFO - 'LOGNAME': 'cltbld', 15:47:01 INFO - 'MAIL': '/var/mail/cltbld', 15:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:01 INFO - 'MOZ_NO_REMOTE': '1', 15:47:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:01 INFO - 'NO_EM_RESTART': '1', 15:47:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:01 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:01 INFO - 'SHELL': '/bin/bash', 15:47:01 INFO - 'SHLVL': '1', 15:47:01 INFO - 'TERM': 'linux', 15:47:01 INFO - 'TMOUT': '86400', 15:47:01 INFO - 'USER': 'cltbld', 15:47:01 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448408225.747718-395407925', 15:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:01 INFO - '_': '/tools/buildbot/bin/python'} 15:47:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:47:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:47:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:47:03 INFO - Installing collected packages: mozsystemmonitor 15:47:03 INFO - Running setup.py install for mozsystemmonitor 15:47:03 INFO - Successfully installed mozsystemmonitor 15:47:03 INFO - Cleaning up... 15:47:03 INFO - Return code: 0 15:47:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd11c538c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23017c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2345d70>, '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 0x2346b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346fb0>, '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': 'e10134013339c31d8d0c4708000001d6-1448408225.747718-395407925', '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 15:47:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 15:47:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:47:03 INFO - Using env: {'DISPLAY': ':0', 15:47:03 INFO - 'HOME': '/home/cltbld', 15:47:03 INFO - 'LANG': 'en_US.UTF-8', 15:47:03 INFO - 'LANGUAGE': 'en_US:en', 15:47:03 INFO - 'LOGNAME': 'cltbld', 15:47:03 INFO - 'MAIL': '/var/mail/cltbld', 15:47:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:03 INFO - 'MOZ_NO_REMOTE': '1', 15:47:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:03 INFO - 'NO_EM_RESTART': '1', 15:47:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:03 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:03 INFO - 'SHELL': '/bin/bash', 15:47:03 INFO - 'SHLVL': '1', 15:47:03 INFO - 'TERM': 'linux', 15:47:03 INFO - 'TMOUT': '86400', 15:47:03 INFO - 'USER': 'cltbld', 15:47:03 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448408225.747718-395407925', 15:47:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:03 INFO - '_': '/tools/buildbot/bin/python'} 15:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:03 INFO - Downloading/unpacking blobuploader==1.2.4 15:47:03 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 15:47:03 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 15:47:03 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 15:47:03 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 15:47:03 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 15:47:03 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 15:47:05 INFO - Downloading blobuploader-1.2.4.tar.gz 15:47:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:47:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:47:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:47:05 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 15:47:05 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 15:47:05 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 15:47:05 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 15:47:05 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 15:47:05 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 15:47:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:47:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:47:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47:06 INFO - Downloading docopt-0.6.1.tar.gz 15:47:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:47:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:47:06 INFO - Installing collected packages: blobuploader, requests, docopt 15:47:06 INFO - Running setup.py install for blobuploader 15:47:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:47:06 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:47:06 INFO - Running setup.py install for requests 15:47:06 INFO - Running setup.py install for docopt 15:47:06 INFO - Successfully installed blobuploader requests docopt 15:47:06 INFO - Cleaning up... 15:47:06 INFO - Return code: 0 15:47:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:47: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')]} 15:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47: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')]} 15:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:06 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 0x7fd11c538c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23017c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2345d70>, '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 0x2346b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346fb0>, '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': 'e10134013339c31d8d0c4708000001d6-1448408225.747718-395407925', '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 15:47:06 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 15:47:06 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 15:47:06 INFO - Using env: {'DISPLAY': ':0', 15:47:06 INFO - 'HOME': '/home/cltbld', 15:47:06 INFO - 'LANG': 'en_US.UTF-8', 15:47:06 INFO - 'LANGUAGE': 'en_US:en', 15:47:06 INFO - 'LOGNAME': 'cltbld', 15:47:06 INFO - 'MAIL': '/var/mail/cltbld', 15:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:06 INFO - 'MOZ_NO_REMOTE': '1', 15:47:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:06 INFO - 'NO_EM_RESTART': '1', 15:47:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:06 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:06 INFO - 'SHELL': '/bin/bash', 15:47:06 INFO - 'SHLVL': '1', 15:47:06 INFO - 'TERM': 'linux', 15:47:06 INFO - 'TMOUT': '86400', 15:47:06 INFO - 'USER': 'cltbld', 15:47:06 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448408225.747718-395407925', 15:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:06 INFO - '_': '/tools/buildbot/bin/python'} 15:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:47:07 INFO - Running setup.py (path:/tmp/pip-2HCsI3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:47:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:47:07 INFO - Running setup.py (path:/tmp/pip-pyIW_K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:47:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:47:07 INFO - Running setup.py (path:/tmp/pip-hJifZC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:47:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:47:07 INFO - Running setup.py (path:/tmp/pip-Ua7N7H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:47:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:47:07 INFO - Running setup.py (path:/tmp/pip-yyCGBL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:47:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:47:07 INFO - Running setup.py (path:/tmp/pip-Las8tb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:47:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:47:07 INFO - Running setup.py (path:/tmp/pip-5dMPB1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:47:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:47:07 INFO - Running setup.py (path:/tmp/pip-nmyIP4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:47:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:47:07 INFO - Running setup.py (path:/tmp/pip-XuCl8e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:47:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:47:07 INFO - Running setup.py (path:/tmp/pip-QfqydZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:47:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:47:07 INFO - Running setup.py (path:/tmp/pip-Pz89PY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:47:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:47:07 INFO - Running setup.py (path:/tmp/pip-hbL5S8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:47:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:47:08 INFO - Running setup.py (path:/tmp/pip-HOJlVv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:47:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:47:08 INFO - Running setup.py (path:/tmp/pip-ZKczyM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:47:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:47:08 INFO - Running setup.py (path:/tmp/pip-CcHH0o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:47:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:47:08 INFO - Running setup.py (path:/tmp/pip-ejccY3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:47:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:47:08 INFO - Running setup.py (path:/tmp/pip-L47rxH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:47:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:47:08 INFO - Running setup.py install for manifestparser 15:47:08 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:47:08 INFO - Running setup.py install for mozcrash 15:47:08 INFO - Running setup.py install for mozdebug 15:47:08 INFO - Running setup.py install for mozdevice 15:47:08 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:47:08 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:47:08 INFO - Running setup.py install for mozfile 15:47:08 INFO - Running setup.py install for mozhttpd 15:47:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:47:08 INFO - Running setup.py install for mozinfo 15:47:09 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:47:09 INFO - Running setup.py install for mozInstall 15:47:09 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:47:09 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:47:09 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:47:09 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:47:09 INFO - Running setup.py install for mozleak 15:47:09 INFO - Running setup.py install for mozlog 15:47:09 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:47:09 INFO - Running setup.py install for moznetwork 15:47:09 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:47:09 INFO - Running setup.py install for mozprocess 15:47:09 INFO - Running setup.py install for mozprofile 15:47:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:47:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:47:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:47:09 INFO - Running setup.py install for mozrunner 15:47:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:47:09 INFO - Running setup.py install for mozscreenshot 15:47:09 INFO - Running setup.py install for moztest 15:47:10 INFO - Running setup.py install for mozversion 15:47:10 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:47:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:47:10 INFO - Cleaning up... 15:47:10 INFO - Return code: 0 15:47:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:47: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')]} 15:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47: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')]} 15:47:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47: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', '-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 0x7fd11c538c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23017c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2345d70>, '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 0x2346b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346fb0>, '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': 'e10134013339c31d8d0c4708000001d6-1448408225.747718-395407925', '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 15:47:10 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 15:47:10 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 15:47:10 INFO - Using env: {'DISPLAY': ':0', 15:47:10 INFO - 'HOME': '/home/cltbld', 15:47:10 INFO - 'LANG': 'en_US.UTF-8', 15:47:10 INFO - 'LANGUAGE': 'en_US:en', 15:47:10 INFO - 'LOGNAME': 'cltbld', 15:47:10 INFO - 'MAIL': '/var/mail/cltbld', 15:47:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:10 INFO - 'MOZ_NO_REMOTE': '1', 15:47:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:10 INFO - 'NO_EM_RESTART': '1', 15:47:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:10 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:10 INFO - 'SHELL': '/bin/bash', 15:47:10 INFO - 'SHLVL': '1', 15:47:10 INFO - 'TERM': 'linux', 15:47:10 INFO - 'TMOUT': '86400', 15:47:10 INFO - 'USER': 'cltbld', 15:47:10 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448408225.747718-395407925', 15:47:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:10 INFO - '_': '/tools/buildbot/bin/python'} 15:47:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:47:10 INFO - Running setup.py (path:/tmp/pip-UnXfl3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:47:10 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)) 15:47:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:47:10 INFO - Running setup.py (path:/tmp/pip-OUfAQS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:47:10 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)) 15:47:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:47:10 INFO - Running setup.py (path:/tmp/pip-oEJ4Tx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:47:10 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)) 15:47:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:47:10 INFO - Running setup.py (path:/tmp/pip-iWvysp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:47:10 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)) 15:47:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:47:10 INFO - Running setup.py (path:/tmp/pip-wb8CYz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:47:10 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)) 15:47:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:47:10 INFO - Running setup.py (path:/tmp/pip-4tts3U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:47:10 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)) 15:47:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:47:10 INFO - Running setup.py (path:/tmp/pip-WKpJkn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:47:10 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)) 15:47:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:47:10 INFO - Running setup.py (path:/tmp/pip-wgfjEP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:47:10 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)) 15:47:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:47:10 INFO - Running setup.py (path:/tmp/pip-VlC6Ch-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:47:11 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)) 15:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:47:11 INFO - Running setup.py (path:/tmp/pip-u3Aken-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:47:11 INFO - Running setup.py (path:/tmp/pip-xHVGh5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:47:11 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)) 15:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:47:11 INFO - Running setup.py (path:/tmp/pip-vOTR6e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:47:11 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)) 15:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:47:11 INFO - Running setup.py (path:/tmp/pip-b5CP1_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:47:11 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)) 15:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:47:11 INFO - Running setup.py (path:/tmp/pip-d576np-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:47:11 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)) 15:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:47:11 INFO - Running setup.py (path:/tmp/pip-kS8M_k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:47:11 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)) 15:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:47:11 INFO - Running setup.py (path:/tmp/pip-xTXXCu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:47:11 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)) 15:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:47:11 INFO - Running setup.py (path:/tmp/pip-GOEtIz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:47:11 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)) 15:47:11 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)) 15:47:11 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)) 15:47:11 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)) 15:47:11 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)) 15:47:11 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)) 15:47:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47: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 15:47:13 INFO - Downloading blessings-1.5.1.tar.gz 15:47:13 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 15:47:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:47:13 INFO - Installing collected packages: blessings 15:47:13 INFO - Running setup.py install for blessings 15:47:13 INFO - Successfully installed blessings 15:47:13 INFO - Cleaning up... 15:47:13 INFO - Return code: 0 15:47:13 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:47:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:47:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:47:13 INFO - Reading from file tmpfile_stdout 15:47:13 INFO - Current package versions: 15:47:13 INFO - argparse == 1.2.1 15:47:13 INFO - blessings == 1.5.1 15:47:13 INFO - blobuploader == 1.2.4 15:47:13 INFO - docopt == 0.6.1 15:47:13 INFO - manifestparser == 1.1 15:47:13 INFO - mozInstall == 1.12 15:47:13 INFO - mozcrash == 0.16 15:47:13 INFO - mozdebug == 0.1 15:47:13 INFO - mozdevice == 0.47 15:47:13 INFO - mozfile == 1.2 15:47:13 INFO - mozhttpd == 0.7 15:47:13 INFO - mozinfo == 0.9 15:47:13 INFO - mozleak == 0.1 15:47:13 INFO - mozlog == 3.1 15:47:13 INFO - moznetwork == 0.27 15:47:13 INFO - mozprocess == 0.22 15:47:13 INFO - mozprofile == 0.27 15:47:13 INFO - mozrunner == 6.11 15:47:13 INFO - mozscreenshot == 0.1 15:47:13 INFO - mozsystemmonitor == 0.0 15:47:13 INFO - moztest == 0.7 15:47:13 INFO - mozversion == 1.4 15:47:13 INFO - psutil == 3.1.1 15:47:13 INFO - requests == 1.2.3 15:47:13 INFO - wsgiref == 0.1.2 15:47:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:47:13 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')]} 15:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:13 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')]} 15:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:13 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 0x7fd11c538c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224f6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23017c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2345d70>, '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 0x2346b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346fb0>, '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': 'e10134013339c31d8d0c4708000001d6-1448408225.747718-395407925', '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 15:47:13 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 15:47:13 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 15:47:13 INFO - Using env: {'DISPLAY': ':0', 15:47:13 INFO - 'HOME': '/home/cltbld', 15:47:13 INFO - 'LANG': 'en_US.UTF-8', 15:47:13 INFO - 'LANGUAGE': 'en_US:en', 15:47:13 INFO - 'LOGNAME': 'cltbld', 15:47:13 INFO - 'MAIL': '/var/mail/cltbld', 15:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:13 INFO - 'MOZ_NO_REMOTE': '1', 15:47:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:13 INFO - 'NO_EM_RESTART': '1', 15:47:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:13 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:13 INFO - 'SHELL': '/bin/bash', 15:47:13 INFO - 'SHLVL': '1', 15:47:13 INFO - 'TERM': 'linux', 15:47:13 INFO - 'TMOUT': '86400', 15:47:13 INFO - 'USER': 'cltbld', 15:47:13 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448408225.747718-395407925', 15:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:13 INFO - '_': '/tools/buildbot/bin/python'} 15:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:13 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)) 15:47:13 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)) 15:47:13 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)) 15:47:13 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)) 15:47:13 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)) 15:47:13 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)) 15:47:13 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)) 15:47:13 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)) 15:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 15:47:13 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)) 15:47:13 INFO - Cleaning up... 15:47:13 INFO - Return code: 0 15:47:13 INFO - Running post-action listener: _resource_record_post_action 15:47:13 INFO - Running post-action listener: _start_resource_monitoring 15:47:13 INFO - Starting resource monitoring. 15:47:13 INFO - ##### 15:47:13 INFO - ##### Running install step. 15:47:13 INFO - ##### 15:47:13 INFO - Running pre-action listener: _resource_record_pre_action 15:47:13 INFO - Running main action method: install 15:47:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:47:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:47:14 INFO - Reading from file tmpfile_stdout 15:47:14 INFO - Detecting whether we're running mozinstall >=1.0... 15:47:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:47:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:47:14 INFO - Reading from file tmpfile_stdout 15:47:14 INFO - Output received: 15:47:14 INFO - Usage: mozinstall [options] installer 15:47:14 INFO - Options: 15:47:14 INFO - -h, --help show this help message and exit 15:47:14 INFO - -d DEST, --destination=DEST 15:47:14 INFO - Directory to install application into. [default: 15:47:14 INFO - "/builds/slave/test-pgo"] 15:47:14 INFO - --app=APP Application being installed. [default: firefox] 15:47:14 INFO - mkdir: /builds/slave/test-pgo/build/application 15:47:14 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'] 15:47:14 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 15:47:28 INFO - Reading from file tmpfile_stdout 15:47:28 INFO - Output received: 15:47:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:47:28 INFO - Running post-action listener: _resource_record_post_action 15:47:28 INFO - ##### 15:47:28 INFO - ##### Running run-tests step. 15:47:28 INFO - ##### 15:47:28 INFO - Running pre-action listener: _resource_record_pre_action 15:47:28 INFO - Running main action method: run_tests 15:47:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:47:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:47:28 INFO - Python 2.7.3 15:47:28 INFO - Return code: 0 15:47:28 INFO - grabbing minidump binary from tooltool 15:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:28 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 0x2345d70>, '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 0x2346b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2346fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:47:28 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 15:47:28 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 15:47:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:47:28 INFO - Return code: 0 15:47:28 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:47:28 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:47:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:47:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:47:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:47:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hG33TXeuSX21_fUJNUEZzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 15:47:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/hG33TXeuSX21_fUJNUEZzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost 15:47:28 INFO - Using env: {'DISPLAY': ':0', 15:47:28 INFO - 'HOME': '/home/cltbld', 15:47:28 INFO - 'LANG': 'en_US.UTF-8', 15:47:28 INFO - 'LANGUAGE': 'en_US:en', 15:47:28 INFO - 'LOGNAME': 'cltbld', 15:47:28 INFO - 'MAIL': '/var/mail/cltbld', 15:47:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:47:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:28 INFO - 'MOZ_NO_REMOTE': '1', 15:47:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:47:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:28 INFO - 'NO_EM_RESTART': '1', 15:47:28 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:47:28 INFO - 'PWD': '/builds/slave/test-pgo', 15:47:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:47:28 INFO - 'SHELL': '/bin/bash', 15:47:28 INFO - 'SHLVL': '1', 15:47:28 INFO - 'TERM': 'linux', 15:47:28 INFO - 'TMOUT': '86400', 15:47:28 INFO - 'USER': 'cltbld', 15:47:28 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448408225.747718-395407925', 15:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:28 INFO - '_': '/tools/buildbot/bin/python'} 15:47:28 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hG33TXeuSX21_fUJNUEZzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] with output_timeout 3600 15:47:29 INFO - mozversion INFO | application_buildid: 20151124143005 15:47:29 INFO - mozversion INFO | application_changeset: 468f04418267488631e9cce53f8b5138eb6d4698 15:47:29 INFO - mozversion INFO | application_display_name: Nightly 15:47:29 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:47:29 INFO - mozversion INFO | application_name: Firefox 15:47:29 INFO - mozversion INFO | application_remotingname: firefox 15:47:29 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 15:47:29 INFO - mozversion INFO | application_vendor: Mozilla 15:47:29 INFO - mozversion INFO | application_version: 45.0a1 15:47:29 INFO - mozversion INFO | platform_buildid: 20151124143005 15:47:29 INFO - mozversion INFO | platform_changeset: 468f04418267488631e9cce53f8b5138eb6d4698 15:47:29 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 15:47:29 INFO - mozversion INFO | platform_version: 45.0a1 15:47:29 INFO - 2015-11-24 15:47:29,114 DEBUG : using testdate: 1448408849 15:47:29 INFO - 2015-11-24 15:47:29,115 DEBUG : actual date: 1448408849 15:47:29 INFO - 2015-11-24 15:47:29,123 INFO : starting webserver on 'localhost:54230' 15:47:29 INFO - 2015-11-24 15:47:29,123 INFO : Starting test suite talos-linux64-ix-023 15:47:29 INFO - 2015-11-24 15:47:29,124 INFO : Starting test dromaeo_css 15:47:29 INFO - 2015-11-24 15:47:29,124 DEBUG : operating with platform_type : linux_ 15:47:29 INFO - 2015-11-24 15:47:29,124 INFO : Initialising browser for dromaeo_css test... 15:47:29 INFO - 2015-11-24 15:47:29,135 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjji1dU/profile http://localhost:54230/getInfo.html 15:47:35 INFO - 2015-11-24 15:47:35,365 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:47:35 INFO - 2015-11-24 15:47:35,365 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:47:35 INFO - 2015-11-24 15:47:35,366 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:47:35 INFO - 2015-11-24 15:47:35,366 DEBUG : BROWSER_OUTPUT: __metrics 15:47:35 INFO - 2015-11-24 15:47:35,535 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:47:37 INFO - 2015-11-24 15:47:37,204 INFO : Browser initialized. 15:47:37 INFO - 2015-11-24 15:47:37,205 INFO : Running cycle 1/1 for dromaeo_css test... 15:47:37 INFO - 2015-11-24 15:47:37,205 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjji1dU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:47:49 INFO - 2015-11-24 15:47:49,009 DEBUG : BROWSER_OUTPUT: RSS: Main: 139943936 15:47:49 INFO - 2015-11-24 15:47:49,010 DEBUG : BROWSER_OUTPUT: 15:48:40 INFO - 2015-11-24 15:48:40,633 DEBUG : BROWSER_OUTPUT: 1448408920625 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] 15:50:49 INFO - 2015-11-24 15:50:49,713 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54230/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54230/tests/dromaeo/cssquery-ext.html) 15:50:50 INFO - 2015-11-24 15:50:50,951 DEBUG : BROWSER_OUTPUT: RSS: Main: 263163904 15:50:50 INFO - 2015-11-24 15:50:50,952 DEBUG : BROWSER_OUTPUT: 15:53:53 INFO - 2015-11-24 15:53:53,491 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54230/tests/dromaeo/cssquery-ext.html (next: http://localhost:54230/tests/dromaeo/cssquery-jquery.html) 15:53:54 INFO - 2015-11-24 15:53:54,060 DEBUG : BROWSER_OUTPUT: RSS: Main: 219176960 15:53:54 INFO - 2015-11-24 15:53:54,061 DEBUG : BROWSER_OUTPUT: 15:56:55 INFO - 2015-11-24 15:56:55,898 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54230/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54230/tests/dromaeo/cssquery-mootools.html) 15:56:56 INFO - 2015-11-24 15:56:56,467 DEBUG : BROWSER_OUTPUT: RSS: Main: 217649152 15:56:56 INFO - 2015-11-24 15:56:56,468 DEBUG : BROWSER_OUTPUT: 15:59:58 INFO - 2015-11-24 15:59:58,304 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54230/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54230/tests/dromaeo/cssquery-prototype.html) 15:59:58 INFO - 2015-11-24 15:59:58,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 197967872 15:59:58 INFO - 2015-11-24 15:59:58,877 DEBUG : BROWSER_OUTPUT: 16:03:01 INFO - 2015-11-24 16:03:01,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54230/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54230/tests/dromaeo/cssquery-yui.html) 16:03:01 INFO - 2015-11-24 16:03:01,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 204247040 16:03:01 INFO - 2015-11-24 16:03:01,920 DEBUG : BROWSER_OUTPUT: 16:06:04 INFO - 2015-11-24 16:06:04,444 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54230/tests/dromaeo/cssquery-yui.html (next: http://localhost:54230/tests/dromaeo/cssquery-dojo.html) 16:06:04 INFO - 2015-11-24 16:06:04,694 DEBUG : BROWSER_OUTPUT: RSS: Main: 237154304 16:06:04 INFO - 2015-11-24 16:06:04,694 DEBUG : BROWSER_OUTPUT: 16:06:04 INFO - 2015-11-24 16:06:04,694 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:06:04 INFO - 2015-11-24 16:06:04,694 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:06:04 INFO - 2015-11-24 16:06:04,694 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:06:04 INFO - 2015-11-24 16:06:04,694 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:06:04 INFO - 2015-11-24 16:06:04,698 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3161;3219.597550306212;3229.370272796804;3240.2547414094774;3242.85407156678;5380.730963451826;5382.730863456831;5485.862853428666;5510.393856675762;5552.694601796905;5416.485433883785;5426.240326354314;5475.808346707856;5498.4501549845;5553.888922221553;4895.21676531755;4915.041566894448;4924.039812236615;4928.852134435972;4953.925691114636;4871.537203965618;4983.177775667011;4993.7503124843615;5018.272350509174;5081.59347252219;4854.296127061556;4941.752912354404;4962.379702537183;4979.875503112415;5005.599552035828;4997.075541024886;4999.850004499871;5001.424836143854;5008.924866127011;5040.067587496325;4898.877528061791;4963.131451995922;4980.153373926441;4982.5017498250245;5043.974780126113;5181.559567436772;5253.921191182136;5325.866853328659;5344.973275133639;5374.193870919355;5942.940570594282;5945.286565612154;5945.613535120204;5947.553933454965;5947.9702601486715;5896.941030589682;5969.8806023879715;5977.282726072855;5996.13056106862;6021.217241758587;5508.6970216638065;5559.499645031926;5570.192322113352;5573.693446860461;5624.915626265569;6098.634081955097;6120.755169793248;6134.447899689049;6137.539684523678;6140.385961403824;5640.407757185519;5689.431056894277;5912.054071348563;5921.111833225051;5942.405759424109;5851.946649603027;5920.2895652521975;5967.5524335675;5971.731272092679;5982.7008649568215;5879.323877754027;5889.23439952812;5890.676012819336;5905.793297234576;5919.6744179070565;5887.4406931341455;5888.205092312569;5896.292444906639;5909.231799866076;5909.409059094142;4406.801693923717;4429.025614364835;4439.400680908101;4512.932306015412;4525.773711314421;4018.2767101921936;4024.8993775155855;4029.1135950090934;4031.0124019614796;4058.817353219112;5590.832275031756;5595.832125036255;5597.132444471114;5598.748056337475;5653.152027195953;5699.74351154199;5769.682667453247;5811.854703632443;5859.765609375662;5934.732937017845;5610.579206559524;5625.268715067097;5627.352854421794;5632.746526406321;5646.943530564724;5173.249878767558;5179.404368497671;5181.35233095863;5184.429712731597;5239.869003274873;5893.086571581412;6065;6071.696415179312;6188.0717892315615;6218.968905155536;5782.710864456844;5858.443447872445;5859.121131830259;5866.061430171152;5909.674967876636;6080.908786368296;6086.573939824169;6090.512758979359;6098.359672234352;6104.664243466652;5746.511546518593;5797.188393624811;5807.593468457337;5819.912701309399;5840.153177789111;5827.271591051119;5856.9121463178935;5857.58996870215;5875.823725288248;5877.353491115889;5724.255846739898;5728.770849166153;5734.397888221677;5743.282089738783;5752.165935939349;5714.9142762857755;5738.110592858114;5753.568482363756;5852.795152169653;5854.063349864001;5615.6630602164005;5679.488846003879;5679.545636348999;5722.284714410699;5734.3978882218435;5840.357560668238;5915.142304365929;5916.437938395846;5917.822465326047;5968.791092311922;5491.75287112073;5691.686957217393;5709.600327977168;5774.56690748204;5782.624129431573 16:06:04 INFO - 2015-11-24 16:06:04,699 DEBUG : BROWSER_OUTPUT: |1;ext.html;563.5491606714628;565.7482420322957;573.5125143627916;589.9705014749264;595.2262059322879;31035.379292414138;36248.81875590621;36952.260954780955;36999.81500092496;37016.81491592542;40922.29393619735;41514.79242603783;41646;41657.58342416575;41786.37320440188;7580.583067931261;7703.653335599884;8621.913780862189;8777.473351598892;8816;10436.791264174712;10704.625338113168;10707.678769636923;10717.089047430978;10719.464026798667;10336.793264134712;10447.947760261188;10456.111230545413;10464.738381540485;10484.423356715377;7741.22587741227;7935.563544005077;7940.364770818378;10231.897681023169;10418.739531511697;9817.263705222136;9878.60485580576;9923.503824808731;9942.304038717293;9947.353422027545;36651.4502282466;36748.26503469916;37017.81491092527;37200;37264.44103338452;2820.591014302935;3222.5327327537375;3272.378248132847;3360.83195840207;3543.486194501783;30388.54417183744;30557.929677406497;30857.382852342827;31037.22406939822;31588.842055789573;3795.7153213509096;3833.9041523962123;3882.70879684022;3899.317619416619;3973.3517754703007;263731;264006;264128;264652;264738;57878.7106064467;58404.7079764607;58420.415795841494;58425;58437.12344314839;52752.208716869274;53876;59925.400745992854;60053.399466005656;60393.396066039655;15745.68508629821;15958.441454549034;16022.19889005545;16043.518694439186;16059.357625694842;12109.091818113677;12128.575499857463;12158.817617735742;12171.208871423507;12234.632961011184;18659.44021679352;18896.52758681044;18940;19009.42971710851;19016.334428294944;7428.702851885864;7673.3477654398885;7736.922630773733;7742.574158421228;7839.451238413257;982.7346616413529;1009.5658866687395;1036.2176556699644;1079.3631757263095;1117.0114448712786;28357.574636380472;28456.715432845405;28880.133595992153;28957.42085158285;28975.275618109717;1015.8171529124828;1038.807820553185;1043.4991204222015;1104.3373975614727;1124.3254047571554;13378.866211337956;13393.799093013613;13434.865651343556;15043.473478428203;15238.807831400423;330318;335795;335848;336085;337425;51903;52013.7399313001;52140.478595213564;52244.73877630587;52280.73859630677;1288.4717265921115;1343.993280033613;1349.2511656030997;1353.0866665001085;1354.8848347890344;27609.44781104407;28546.57180142341;28867.711322886502;29049.419011620073;29179;45507;46887.29669055035;51350.22974655309;52517.47482525126;52631.73684131555;261514;262144;262657;263803;263870;27115.72884271132;27635.44729105447;29805.552916705834;30165.396692066475;30176.396472070875;41697.58302416937;41758.58241417547;42474.575254247065;42500.362494563225;45571.31643025291;34617.1345716349;34917.30165396627;34955;35049.8247508771;35600.28799424049;34633.826830865684;35005;35466;35973;36853.815730921175;32637.510437342982;35268;35804.82097589495;35862.64137358593;35911.461328079575;27849.582256265767;30195.09414717562;30668;30841;32972.67027329696;24172.153974610803;24357.39106522351;24821.255362339158;24866;25166 16:06:04 INFO - 2015-11-24 16:06:04,700 DEBUG : BROWSER_OUTPUT: |2;jquery.html;351.32720839592184;353.04853420033004;356.1719003317288;356.8251556737198;357.17314417124373;14089.859101408983;14470.131792092481;16115.194240287983;16485.423010194645;17249.05130217839;16216.432424865132;16240.187990600452;16253.593660158502;16267;16285.91857040716;4633.443986721598;4814.964782571747;4819.108464933998;4819.638527110464;4822.107910036637;3729.272791805599;3827.942580861289;4769.403824521934;4836.709797412166;5528.474794894499;5430.8913821723545;5452.2094296327;5497.725113744316;5513.50378465938;5521.641093328941;5055.823046193384;5172;5190;5198.220266959967;5199.194124910645;4797.928031079537;4899;4906.681065730716;5001.824936127218;5006.148954677714;14997.550073497703;15008;15026.323815428223;18555.536111597317;19107.23571057156;2023.2311721545718;2112.384026219943;2157.0832396231694;2173.5870184665023;2195.747489038749;9594.280428967786;10115.949420252851;10392.428416437093;11625;13492.12301200419;1816.7093265077656;1849.8427633651156;1864.0586503815487;1895.1282410091374;1999.1903279171959;43691.56308436907;43881.34177987333;48141.75929120367;54538.90922181574;63181;15385.384584616713;15656.295466704025;15713.921430392775;15718;15854.60363490922;24347.14784982517;24457.51084978326;24631.753682462946;24732.134375296777;24736.381590460383;8431.072582015973;8483.872741908875;8503.362247831314;8578.699745509002;8838.29293656506;7175.354218120394;7196.208417074117;7204.855902881913;7226.132864056347;7248.383887369632;7484.43866709988;7611.3530349920875;7756.379489640815;7766.37868970481;7775.883361749578;2657.5349313869997;2966.1398194523345;3006.864691088906;3007.3083190866223;3053.5114381698822;836.8242669039448;920.2453987729997;996.4121168510613;1045.954045954046;1066.3974854207347;15874.285657145225;16060.196990150445;16677;17032.148392580322;17060.402885898933;891.9687810926587;903.8553831386946;936.7236665183788;994.7363948553639;1038.4081073787868;9274.072592740671;9717.85423218638;9762.46306453152;9795.412275263507;9825.361351512129;373621;376930;420585;511628;513618;78055.21944780592;83366;84217;84462.15537844543;85358;1065.4566171252561;1076.860008198929;1079.63292480557;1089.3627228071666;1103.8896110388896;12692.301923394301;14998.775018374952;15181.848181518486;15242.085474871543;15366.46217382431;33417;33457.33085338328;33598.83200583982;35421.114472138404;36471;44964.325535117656;45540.31689524594;46218.30672539847;47458.52541474541;47568;8713.172248636369;9575.329726919048;9754.0733630305;9764.414135151914;9766.414015159113;17739.822601773816;17847.107644617976;18076.819231807513;18263.269469221083;18393.264269429073;14509.347079381665;14626.122432654074;14759.188244646648;15067.09597424158;15197.848021519643;13429.462821487032;14291.213983230606;14683.339249734001;14785.778213327023;14869.628259293604;14953.775693364825;15114.848851511784;15338.15640139803;15466.690666186838;15519.844801552292;9320.533973301171;9474.715758527254;9910.504474776088;9913.752156196153;9930.354526955725;10134.23993200498;10225.795484090426;12294.692632684255;14815.18516481604;15298.464553740565 16:06:04 INFO - 2015-11-24 16:06:04,702 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1330.1154732103153;1456.9635759106022;1500.0549653718153;1618.2636900210405;1738.6175041490876;6502.512311576633;7187.245339239383;7410.814729631762;7431.331180193782;7438.033055702765;7506.774796756093;7627.618619069038;7635.618219089051;7640.42696797741;7642.04474440695;1844.3729132095084;1869.4204796513056;2114.0803750368564;2205.5037616536233;2222.92219772308;2156.8382371322136;2174.70641463402;2176.031665908671;2177.6624623183434;2180.5965896309153;2105.7367829021373;2195.890205489727;2197.121151539389;2197.2748992832326;2199.0214354612203;1946.8734532255357;1954.2964532768192;2145.2062736787334;2172.5654869026257;2174.7716489768504;2117.110813458351;2165.7401111866675;2171.055590817999;2176.5864485747816;2178.8583742056717;7418.221086785918;7453.627318634047;7470.775876723707;7481.438892083062;7495.213002634754;4542.818287268538;4594.793234304464;4626.4910859805395;4638.698484598491;4641.791119399635;2882.754965827907;2964.43675701616;2987.507061334877;2995.9400811983637;2996.460637085324;908.1009800297724;931.9394239374419;942.8397172480695;954.4178051388648;961.5817119553017;10515.789684206273;10683.145348372189;10687.412192329419;10694.679159625224;10695.09091727204;4168.416421700904;4234.195502854448;4285.335772955197;4286.928267933017;4302.591253830881;9265.583048762823;9266.397684150508;9270;9292.53537323131;9295.209907157967;4713.128071306819;4717.787699553528;4727.125481785881;4752.500987396343;4756.7859446325;4262.595053469915;4295.22685916538;4308.504521980012;4308.719933204332;4313.762743049162;3513.4729790531114;3577.5885773136424;3594.227241143167;3598.3702852000797;3599.208174201671;1088.7931293054294;1107.3687997841314;1114.3481063577897;1127.8251870960014;1128.373752567333;1295.4086281345308;1295.6242689619905;1326.1843965960866;1337.725766217923;1352.2427440633278;7017.649117544102;7053.047838541834;7103.147622285359;7124.643767811589;7131.286871312931;404.54084613963363;406.37012630422726;410.86236110903184;415.7671703845856;428.63994244834487;5623.775048998076;5681.772729090872;5689.0328644130595;5694.487496125369;5697.6296540724725;8987.730368088967;9001.729948101567;9320.30097742672;9330.160285574331;9332.34673572857;9098.454092754457;9183.724488265363;9201.539923003957;9204.723858284262;9206.723798286062;7022.894656580155;7076.787696369117;7148.642567871586;7177.569345839266;7260.636968151572;7116.110486189226;7170.139583250043;7224.060872086595;7224.711011559479;7224.819379515554;7900.565468899265;8067.757967260992;8087.716929907425;8089.393295502743;8233.259006689426;8299.045609754956;8361.456505327134;8366.205210504992;8562.229399353839;8571.828563428571;6673.232578253563;6769.492288078315;6813.420859226823;6829.248782634006;6829.590224586541;7420.814479638052;7474.439417043634;7479.252074792477;7487.438442116754;7495.662695178621;5841.94158058431;6794.796156115324;6869.381755642016;6981.546199497219;7202.53183543068;6915.343042410963;6936.375726184668;6997.090378250795;7033.507654464139;7044.647767611701;6731.865362692621;6840.11078559804;6840.931590684029;6842.726290948306;6852.040714300102;6301.779437719658;6312.936870631235;6321.146645202839;6324.3991820776955;6331.841703957438;5992.250968628921;6292;6308.71610777507;6393.520485963664;6393.712282947372 16:06:04 INFO - 2015-11-24 16:06:04,703 DEBUG : BROWSER_OUTPUT: |4;prototype.html;309.860562746764;314.88506695056304;321.3749257693786;322.2089769615594;323.7220135904031;5923.815236952605;5959.255093113361;5983.700814959251;5985.4014598540125;5986.940130598693;5900.350961394243;5927.318358388776;5931.6441013539215;5933.258342707161;5953.315368732597;4352.956470435302;4389.473263208403;4423.579759922818;4481.753503557303;4531.977340113303;4502.347159661847;4509.1883460977015;4519.570640789119;4532.546745325474;4535.591796738293;4442.267025940732;4450.33245013249;4463.866084017484;4465.151621191963;4483.910321793563;4305.461817272841;4382.255016647162;4400.185965596375;4441.600255976945;4444.73331600105;3866.8066596670055;3866.8259928303296;3885.9805700971315;3901.1222474943193;3901.824417901173;5597.356304025048;5601.635893666939;5610.24261724666;5611.242482264883;5612.326520817487;5178.766955487012;5216.895662086737;5217.060929032773;5221.843344699665;5227.059129356714;6172.783952561684;6286.371362863722;6292.4966002719675;6299.055141728777;6300.495960323163;4265.786710664454;4266.616004559604;4267.658587313008;4268.701190916637;4270.14597080582;6501.869962600769;6548.508861835334;6553.935510314283;6554.1151944487365;6577.6711164441585;4238.597333253336;4291.442112525352;4293.806778694966;4295.656347492193;4336.219480493542;4378.8029538670835;4385.956140438619;4388.934165987513;4390.187815254124;4392.604665580113;5134.717590532557;5136.640435169577;5142.97428512855;5144.845654630367;5147.356580427447;6343.904841427382;6354.650494222769;6361;6364.936350636527;6366.808995730135;1510.1090356689606;1513.7199618070472;1521.680447106098;1522.1628104542458;1586.920653967297;987.7481242283171;1042.9478526073665;1053.5996321397972;1060.7242117049623;1063.1176123817213;5995.070764031495;6004.849878753066;6008;6023.48800351975;6030.246219222598;6461.450776684034;6462.38607332312;6467.644279564575;6473;6478.740850365933;5981.312149102909;5981.790637327673;5990.251218597676;5990.820275391745;6003;3349.1961929136833;3426.297608990151;3489.842957066938;3574.749767516249;3581.8567257309937;6766.221884483249;6792.320767923267;6799.762008329685;6800.6599670017295;6806.5235433520165;6722.630255336004;6738.225104112992;6749.0551322814845;6750.662466876636;6751.459883209332;6629.270780214172;6718.966405168041;6728.058071869942;6826.590404575742;6845.657717114124;6621.834454138685;6621.867562648624;6628.237752658313;6630.734770609121;6638.369354911276;6363.204599425072;6546.345365463416;6547.050677651809;6547.279799222177;6558.1802274715665;6819;6827.829304267433;6831.487638427038;6833.4191593715095;6834.453243740588;4412.382266482759;4450.399196108613;4453.910921781481;4455.131249406335;4477.843275485342;6595.406413422623;6600.966995164993;6602.735890564323;6607.372299631527;6617.073609694743;6263.906041409474;6420.390062944013;6427.646479443675;6430.742770289136;6432.003039528693;6401.711922963571;6405.19935008124;6407.327230640902;6412.551121421642;6413.8717225656155;6234.438900498977;6295.433410993032;6305.558610897193;6305.621662700252;6316.399942005502;6278.089676996901;6427.068075129174;6432.13166222554;6446.226452825504;6476.287608362982;6299.811005669837;6301.212348456443;6304.6847657617855;6309.779157729457;6311.211098612674 16:06:04 INFO - 2015-11-24 16:06:04,703 DEBUG : BROWSER_OUTPUT: |5;yui.html;738.4383908774148;780.5550836023467;844.7043534762834;858.3433673239971;870.4646642314974;13087.80368294474;13090.149140305886;13161.341932903364;13244.53644122456;13257.270850103241;12472.189307694993;12483.875161248385;12544.749105017894;12623.17949333295;12636.11547191697;677.962712050837;681.4582406986458;794.7059587952466;807.1887752808449;825.0553116681397;804.5856383962264;814.1614137438419;816.5468165168329;822.3708862720024;824.0153017144514;702.5047341624169;855.2644725536034;867.2108381372952;867.8741582470537;868.956552172392;697.0137255783061;841.7685136587456;854.3891117850767;855.0850589868812;856.546030603781;629.8897692903723;634.6414275934129;640.782134074417;640.8686219325027;641.0928536121382;12534.561290354884;12649;12649.241045537297;12830.743385132246;12860.421281042376;11677.532898684043;12305;12316.322602256872;12319.876801232052;12644.810327845089;9486.857697134548;9579.712608621683;9722.562484688206;9850.852237216448;10458.738531536696;3566.7681600695873;3580.6240344763687;3596.982015089934;3616.4213725803747;3627.3289441453417;43440;43995.34006989898;44232.3365149523;46816.765916170545;46940.29589556159;9664.806703866025;9746.75633109178;9825;9972.950135249277;10111.988801119829;17871.642567148585;17898.10509474547;17916.641667166583;17917.193726282087;17918.372856949944;7714.614269286513;7794.649240784178;7828.334591559667;7917.995398719395;7942.404319676048;4291.742495450283;4324.762138082436;4338.284183109815;4385.51759306476;4564.497905230422;3029.106413607991;3056.4040012197406;3058.403611295776;3059;3060.43381974331;536.1394961087476;556.4741319453159;568.5991376079854;569.0156030067923;569.5443645083999;554.9944500554943;606.0606060606043;669.9698513566901;689.8654762321299;711.6477343714894;8257.42198046131;8260.752177434686;8420.621072051772;8517.867313835764;8559.657613695383;520.4353276694753;609.8322961185621;693.6774399904069;701.1936273285762;705.6507029020668;4022.155347377025;4053.9391909121387;4061.3501839705505;4125.525564560114;4258.914821703611;56212.71893640587;56548.43451565514;56960;57135.714321428124;57139.71430142823;50904.49095509072;51693.22460163101;51958;51959;52329.738351308;45295.77352113284;45729;46136;46817.29774053392;47373.763131184125;8089.716859909875;8120.512769233865;8138.674453022049;8149.8370032600205;8315.542645154575;34348.65651343555;34374.82812585921;34539.30921381609;35508.82245588755;35903.461448077775;41353.37969930514;41523.58476415197;44391.668249952556;44917.550824491336;45103.77448112739;10173.542190601589;10458.581656733646;10654.360738355723;11264.324140551265;11698.122640801803;12007;12274.140810143204;12294.262344259372;12520.937395312965;12842;11214.439278035903;11561.421928903354;11562.88437115618;11632.88367116318;12015.879841201477;11339.603113890975;11529.596464124052;11646.475908583965;11796.410179491162;12113.394330283627;11175.329480231212;11487.483063262007;11563.5952741657;11609.129315301556;11660.18378713482;9793.85309220348;9905.851412228678;10023.899761002589;10057.446840423847;10339.0694837465;9046.683366082156;9098.454092754457;9343.71968840936;9364.719058428258;9858.694683474156 16:06:04 INFO - 2015-11-24 16:06:04,703 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:06:04 INFO - 2015-11-24 16:06:04,704 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:06:04 INFO - 2015-11-24 16:06:04,705 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,986 16:06:04 INFO - 2015-11-24 16:06:04,705 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:06:04 INFO - 2015-11-24 16:06:04,705 DEBUG : BROWSER_OUTPUT: __startTimestamp1448409964693__endTimestamp 16:06:04 INFO - 2015-11-24 16:06:04,705 DEBUG : BROWSER_OUTPUT: 16:06:04 INFO - 2015-11-24 16:06:04,705 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:06:04 INFO - 2015-11-24 16:06:04,705 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:06:04 INFO - 2015-11-24 16:06:04,705 DEBUG : BROWSER_OUTPUT: 16:06:04 INFO - 2015-11-24 16:06:04,705 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5475.89 Median:5699.74 stddev:630.39 (11.1%) stddev-sans-first:605.60 16:06:04 INFO - 2015-11-24 16:06:04,705 DEBUG : BROWSER_OUTPUT: Values: 3161.0 3219.6 3229.4 3240.3 3242.9 5380.7 5382.7 5485.9 5510.4 5552.7 5416.5 5426.2 5475.8 5498.5 5553.9 4895.2 4915.0 4924.0 4928.9 4953.9 4871.5 4983.2 4993.8 5018.3 5081.6 4854.3 4941.8 4962.4 4979.9 5005.6 4997.1 4999.9 5001.4 5008.9 5040.1 4898.9 4963.1 4980.2 4982.5 5044.0 5181.6 5253.9 5325.9 5345.0 5374.2 5942.9 5945.3 5945.6 5947.6 5948.0 5896.9 5969.9 5977.3 5996.1 6021.2 5508.7 5559.5 5570.2 5573.7 5624.9 6098.6 6120.8 6134.4 6137.5 6140.4 5640.4 5689.4 5912.1 5921.1 5942.4 5851.9 5920.3 5967.6 5971.7 5982.7 5879.3 5889.2 5890.7 5905.8 5919.7 5887.4 5888.2 5896.3 5909.2 5909.4 4406.8 4429.0 4439.4 4512.9 4525.8 4018.3 4024.9 4029.1 4031.0 4058.8 5590.8 5595.8 5597.1 5598.7 5653.2 5699.7 5769.7 5811.9 5859.8 5934.7 5610.6 5625.3 5627.4 5632.7 5646.9 5173.2 5179.4 5181.4 5184.4 5239.9 5893.1 6065.0 6071.7 6188.1 6219.0 5782.7 5858.4 5859.1 5866.1 5909.7 6080.9 6086.6 6090.5 6098.4 6104.7 5746.5 5797.2 5807.6 5819.9 5840.2 5827.3 5856.9 5857.6 5875.8 5877.4 5724.3 5728.8 5734.4 5743.3 5752.2 5714.9 5738.1 5753.6 5852.8 5854.1 5615.7 5679.5 5679.5 5722.3 5734.4 5840.4 5915.1 5916.4 5917.8 5968.8 5491.8 5691.7 5709.6 5774.6 5782.6 16:06:04 INFO - 2015-11-24 16:06:04,705 DEBUG : BROWSER_OUTPUT: 16:06:04 INFO - 2015-11-24 16:06:04,706 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45636.91 Median:181645.34 stddev:75588.60 (41.6%) stddev-sans-first:75724.89 16:06:04 INFO - 2015-11-24 16:06:04,706 DEBUG : BROWSER_OUTPUT: Values: 563.5 565.7 573.5 590.0 595.2 31035.4 36248.8 36952.3 36999.8 37016.8 40922.3 41514.8 41646.0 41657.6 41786.4 7580.6 7703.7 8621.9 8777.5 8816.0 10436.8 10704.6 10707.7 10717.1 10719.5 10336.8 10447.9 10456.1 10464.7 10484.4 7741.2 7935.6 7940.4 10231.9 10418.7 9817.3 9878.6 9923.5 9942.3 9947.4 36651.5 36748.3 37017.8 37200.0 37264.4 2820.6 3222.5 3272.4 3360.8 3543.5 30388.5 30557.9 30857.4 31037.2 31588.8 3795.7 3833.9 3882.7 3899.3 3973.4 263731.0 264006.0 264128.0 264652.0 264738.0 57878.7 58404.7 58420.4 58425.0 58437.1 52752.2 53876.0 59925.4 60053.4 60393.4 15745.7 15958.4 16022.2 16043.5 16059.4 12109.1 12128.6 12158.8 12171.2 12234.6 18659.4 18896.5 18940.0 19009.4 19016.3 7428.7 7673.3 7736.9 7742.6 7839.5 982.7 1009.6 1036.2 1079.4 1117.0 28357.6 28456.7 28880.1 28957.4 28975.3 1015.8 1038.8 1043.5 1104.3 1124.3 13378.9 13393.8 13434.9 15043.5 15238.8 330318.0 335795.0 335848.0 336085.0 337425.0 51903.0 52013.7 52140.5 52244.7 52280.7 1288.5 1344.0 1349.3 1353.1 1354.9 27609.4 28546.6 28867.7 29049.4 29179.0 45507.0 46887.3 51350.2 52517.5 52631.7 261514.0 262144.0 262657.0 263803.0 263870.0 27115.7 27635.4 29805.6 30165.4 30176.4 41697.6 41758.6 42474.6 42500.4 45571.3 34617.1 34917.3 34955.0 35049.8 35600.3 34633.8 35005.0 35466.0 35973.0 36853.8 32637.5 35268.0 35804.8 35862.6 35911.5 27849.6 30195.1 30668.0 30841.0 32972.7 24172.2 24357.4 24821.3 24866.0 25166.0 16:06:04 INFO - 2015-11-24 16:06:04,706 DEBUG : BROWSER_OUTPUT: 16:06:04 INFO - 2015-11-24 16:06:04,706 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26321.77 Median:352.19 stddev:72614.50 (20618.1%) stddev-sans-first:72792.02 16:06:04 INFO - 2015-11-24 16:06:04,706 DEBUG : BROWSER_OUTPUT: Values: 351.3 353.0 356.2 356.8 357.2 14089.9 14470.1 16115.2 16485.4 17249.1 16216.4 16240.2 16253.6 16267.0 16285.9 4633.4 4815.0 4819.1 4819.6 4822.1 3729.3 3827.9 4769.4 4836.7 5528.5 5430.9 5452.2 5497.7 5513.5 5521.6 5055.8 5172.0 5190.0 5198.2 5199.2 4797.9 4899.0 4906.7 5001.8 5006.1 14997.6 15008.0 15026.3 18555.5 19107.2 2023.2 2112.4 2157.1 2173.6 2195.7 9594.3 10115.9 10392.4 11625.0 13492.1 1816.7 1849.8 1864.1 1895.1 1999.2 43691.6 43881.3 48141.8 54538.9 63181.0 15385.4 15656.3 15713.9 15718.0 15854.6 24347.1 24457.5 24631.8 24732.1 24736.4 8431.1 8483.9 8503.4 8578.7 8838.3 7175.4 7196.2 7204.9 7226.1 7248.4 7484.4 7611.4 7756.4 7766.4 7775.9 2657.5 2966.1 3006.9 3007.3 3053.5 836.8 920.2 996.4 1046.0 1066.4 15874.3 16060.2 16677.0 17032.1 17060.4 892.0 903.9 936.7 994.7 1038.4 9274.1 9717.9 9762.5 9795.4 9825.4 373621.0 376930.0 420585.0 511628.0 513618.0 78055.2 83366.0 84217.0 84462.2 85358.0 1065.5 1076.9 1079.6 1089.4 1103.9 12692.3 14998.8 15181.8 15242.1 15366.5 33417.0 33457.3 33598.8 35421.1 36471.0 44964.3 45540.3 46218.3 47458.5 47568.0 8713.2 9575.3 9754.1 9764.4 9766.4 17739.8 17847.1 18076.8 18263.3 18393.3 14509.3 14626.1 14759.2 15067.1 15197.8 13429.5 14291.2 14683.3 14785.8 14869.6 14953.8 15114.8 15338.2 15466.7 15519.8 9320.5 9474.7 9910.5 9913.8 9930.4 10134.2 10225.8 12294.7 14815.2 15298.5 16:06:04 INFO - 2015-11-24 16:06:04,706 DEBUG : BROWSER_OUTPUT: 16:06:04 INFO - 2015-11-24 16:06:04,706 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5332.44 Median:6317.04 stddev:2820.60 (44.7%) stddev-sans-first:2812.47 16:06:04 INFO - 2015-11-24 16:06:04,707 DEBUG : BROWSER_OUTPUT: Values: 1330.1 1457.0 1500.1 1618.3 1738.6 6502.5 7187.2 7410.8 7431.3 7438.0 7506.8 7627.6 7635.6 7640.4 7642.0 1844.4 1869.4 2114.1 2205.5 2222.9 2156.8 2174.7 2176.0 2177.7 2180.6 2105.7 2195.9 2197.1 2197.3 2199.0 1946.9 1954.3 2145.2 2172.6 2174.8 2117.1 2165.7 2171.1 2176.6 2178.9 7418.2 7453.6 7470.8 7481.4 7495.2 4542.8 4594.8 4626.5 4638.7 4641.8 2882.8 2964.4 2987.5 2995.9 2996.5 908.1 931.9 942.8 954.4 961.6 10515.8 10683.1 10687.4 10694.7 10695.1 4168.4 4234.2 4285.3 4286.9 4302.6 9265.6 9266.4 9270.0 9292.5 9295.2 4713.1 4717.8 4727.1 4752.5 4756.8 4262.6 4295.2 4308.5 4308.7 4313.8 3513.5 3577.6 3594.2 3598.4 3599.2 1088.8 1107.4 1114.3 1127.8 1128.4 1295.4 1295.6 1326.2 1337.7 1352.2 7017.6 7053.0 7103.1 7124.6 7131.3 404.5 406.4 410.9 415.8 428.6 5623.8 5681.8 5689.0 5694.5 5697.6 8987.7 9001.7 9320.3 9330.2 9332.3 9098.5 9183.7 9201.5 9204.7 9206.7 7022.9 7076.8 7148.6 7177.6 7260.6 7116.1 7170.1 7224.1 7224.7 7224.8 7900.6 8067.8 8087.7 8089.4 8233.3 8299.0 8361.5 8366.2 8562.2 8571.8 6673.2 6769.5 6813.4 6829.2 6829.6 7420.8 7474.4 7479.3 7487.4 7495.7 5841.9 6794.8 6869.4 6981.5 7202.5 6915.3 6936.4 6997.1 7033.5 7044.6 6731.9 6840.1 6840.9 6842.7 6852.0 6301.8 6312.9 6321.1 6324.4 6331.8 5992.3 6292.0 6308.7 6393.5 6393.7 16:06:04 INFO - 2015-11-24 16:06:04,707 DEBUG : BROWSER_OUTPUT: 16:06:04 INFO - 2015-11-24 16:06:04,708 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5267.85 Median:5988.60 stddev:1631.21 (27.2%) stddev-sans-first:1592.77 16:06:04 INFO - 2015-11-24 16:06:04,708 DEBUG : BROWSER_OUTPUT: Values: 309.9 314.9 321.4 322.2 323.7 5923.8 5959.3 5983.7 5985.4 5986.9 5900.4 5927.3 5931.6 5933.3 5953.3 4353.0 4389.5 4423.6 4481.8 4532.0 4502.3 4509.2 4519.6 4532.5 4535.6 4442.3 4450.3 4463.9 4465.2 4483.9 4305.5 4382.3 4400.2 4441.6 4444.7 3866.8 3866.8 3886.0 3901.1 3901.8 5597.4 5601.6 5610.2 5611.2 5612.3 5178.8 5216.9 5217.1 5221.8 5227.1 6172.8 6286.4 6292.5 6299.1 6300.5 4265.8 4266.6 4267.7 4268.7 4270.1 6501.9 6548.5 6553.9 6554.1 6577.7 4238.6 4291.4 4293.8 4295.7 4336.2 4378.8 4386.0 4388.9 4390.2 4392.6 5134.7 5136.6 5143.0 5144.8 5147.4 6343.9 6354.7 6361.0 6364.9 6366.8 1510.1 1513.7 1521.7 1522.2 1586.9 987.7 1042.9 1053.6 1060.7 1063.1 5995.1 6004.8 6008.0 6023.5 6030.2 6461.5 6462.4 6467.6 6473.0 6478.7 5981.3 5981.8 5990.3 5990.8 6003.0 3349.2 3426.3 3489.8 3574.7 3581.9 6766.2 6792.3 6799.8 6800.7 6806.5 6722.6 6738.2 6749.1 6750.7 6751.5 6629.3 6719.0 6728.1 6826.6 6845.7 6621.8 6621.9 6628.2 6630.7 6638.4 6363.2 6546.3 6547.1 6547.3 6558.2 6819.0 6827.8 6831.5 6833.4 6834.5 4412.4 4450.4 4453.9 4455.1 4477.8 6595.4 6601.0 6602.7 6607.4 6617.1 6263.9 6420.4 6427.6 6430.7 6432.0 6401.7 6405.2 6407.3 6412.6 6413.9 6234.4 6295.4 6305.6 6305.6 6316.4 6278.1 6427.1 6432.1 6446.2 6476.3 6299.8 6301.2 6304.7 6309.8 6311.2 16:06:04 INFO - 2015-11-24 16:06:04,708 DEBUG : BROWSER_OUTPUT: 16:06:04 INFO - 2015-11-24 16:06:04,708 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13612.37 Median:46476.38 stddev:15683.96 (33.7%) stddev-sans-first:15698.16 16:06:04 INFO - 2015-11-24 16:06:04,708 DEBUG : BROWSER_OUTPUT: Values: 738.4 780.6 844.7 858.3 870.5 13087.8 13090.1 13161.3 13244.5 13257.3 12472.2 12483.9 12544.7 12623.2 12636.1 678.0 681.5 794.7 807.2 825.1 804.6 814.2 816.5 822.4 824.0 702.5 855.3 867.2 867.9 869.0 697.0 841.8 854.4 855.1 856.5 629.9 634.6 640.8 640.9 641.1 12534.6 12649.0 12649.2 12830.7 12860.4 11677.5 12305.0 12316.3 12319.9 12644.8 9486.9 9579.7 9722.6 9850.9 10458.7 3566.8 3580.6 3597.0 3616.4 3627.3 43440.0 43995.3 44232.3 46816.8 46940.3 9664.8 9746.8 9825.0 9973.0 10112.0 17871.6 17898.1 17916.6 17917.2 17918.4 7714.6 7794.6 7828.3 7918.0 7942.4 4291.7 4324.8 4338.3 4385.5 4564.5 3029.1 3056.4 3058.4 3059.0 3060.4 536.1 556.5 568.6 569.0 569.5 555.0 606.1 670.0 689.9 711.6 8257.4 8260.8 8420.6 8517.9 8559.7 520.4 609.8 693.7 701.2 705.7 4022.2 4053.9 4061.4 4125.5 4258.9 56212.7 56548.4 56960.0 57135.7 57139.7 50904.5 51693.2 51958.0 51959.0 52329.7 45295.8 45729.0 46136.0 46817.3 47373.8 8089.7 8120.5 8138.7 8149.8 8315.5 34348.7 34374.8 34539.3 35508.8 35903.5 41353.4 41523.6 44391.7 44917.6 45103.8 10173.5 10458.6 10654.4 11264.3 11698.1 12007.0 12274.1 12294.3 12520.9 12842.0 11214.4 11561.4 11562.9 11632.9 12015.9 11339.6 11529.6 11646.5 11796.4 12113.4 11175.3 11487.5 11563.6 11609.1 11660.2 9793.9 9905.9 10023.9 10057.4 10339.1 9046.7 9098.5 9343.7 9364.7 9858.7 16:06:04 INFO - 2015-11-24 16:06:04,708 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:06:04 INFO - 2015-11-24 16:06:04,708 DEBUG : BROWSER_OUTPUT: 16:06:05 INFO - 2015-11-24 16:06:05,373 INFO : Browser exited with error code: 0 16:06:05 INFO - 2015-11-24 16:06:05,392 INFO : Completed test dromaeo_css (00:18:36) 16:06:05 INFO - 2015-11-24 16:06:05,392 INFO : Starting test kraken 16:06:05 INFO - 2015-11-24 16:06:05,392 DEBUG : operating with platform_type : linux_ 16:06:05 INFO - 2015-11-24 16:06:05,392 INFO : Initialising browser for kraken test... 16:06:05 INFO - 2015-11-24 16:06:05,398 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmAghvL/profile http://localhost:54230/getInfo.html 16:06:09 INFO - 2015-11-24 16:06:09,254 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:06:09 INFO - 2015-11-24 16:06:09,255 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:06:09 INFO - 2015-11-24 16:06:09,255 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:06:09 INFO - 2015-11-24 16:06:09,255 DEBUG : BROWSER_OUTPUT: __metrics 16:06:09 INFO - 2015-11-24 16:06:09,383 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:06:10 INFO - 2015-11-24 16:06:10,667 INFO : Browser initialized. 16:06:10 INFO - 2015-11-24 16:06:10,667 INFO : Running cycle 1/1 for kraken test... 16:06:10 INFO - 2015-11-24 16:06:10,667 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmAghvL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:06:22 INFO - 2015-11-24 16:06:22,367 DEBUG : BROWSER_OUTPUT: RSS: Main: 139862016 16:06:22 INFO - 2015-11-24 16:06:22,367 DEBUG : BROWSER_OUTPUT: 16:06:24 INFO - 2015-11-24 16:06:24,826 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54230/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54230/tests/kraken/driver.html?testName=audio-beat-detection) 16:06:25 INFO - 2015-11-24 16:06:25,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 179347456 16:06:25 INFO - 2015-11-24 16:06:25,399 DEBUG : BROWSER_OUTPUT: 16:06:27 INFO - 2015-11-24 16:06:27,968 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54230/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54230/tests/kraken/driver.html?testName=audio-dft) 16:06:28 INFO - 2015-11-24 16:06:28,549 DEBUG : BROWSER_OUTPUT: RSS: Main: 168513536 16:06:28 INFO - 2015-11-24 16:06:28,549 DEBUG : BROWSER_OUTPUT: 16:06:31 INFO - 2015-11-24 16:06:31,393 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54230/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54230/tests/kraken/driver.html?testName=audio-fft) 16:06:31 INFO - 2015-11-24 16:06:31,954 DEBUG : BROWSER_OUTPUT: RSS: Main: 151924736 16:06:31 INFO - 2015-11-24 16:06:31,954 DEBUG : BROWSER_OUTPUT: 16:06:33 INFO - 2015-11-24 16:06:33,951 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54230/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54230/tests/kraken/driver.html?testName=audio-oscillator) 16:06:34 INFO - 2015-11-24 16:06:34,514 DEBUG : BROWSER_OUTPUT: RSS: Main: 152551424 16:06:34 INFO - 2015-11-24 16:06:34,514 DEBUG : BROWSER_OUTPUT: 16:06:36 INFO - 2015-11-24 16:06:36,692 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54230/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54230/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:06:37 INFO - 2015-11-24 16:06:37,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 156700672 16:06:37 INFO - 2015-11-24 16:06:37,253 DEBUG : BROWSER_OUTPUT: 16:06:40 INFO - 2015-11-24 16:06:40,172 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54230/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54230/tests/kraken/driver.html?testName=imaging-darkroom) 16:06:40 INFO - 2015-11-24 16:06:40,737 DEBUG : BROWSER_OUTPUT: RSS: Main: 155049984 16:06:40 INFO - 2015-11-24 16:06:40,738 DEBUG : BROWSER_OUTPUT: 16:06:44 INFO - 2015-11-24 16:06:44,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54230/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54230/tests/kraken/driver.html?testName=imaging-desaturate) 16:06:44 INFO - 2015-11-24 16:06:44,717 DEBUG : BROWSER_OUTPUT: RSS: Main: 156979200 16:06:44 INFO - 2015-11-24 16:06:44,717 DEBUG : BROWSER_OUTPUT: 16:06:47 INFO - 2015-11-24 16:06:47,479 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54230/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54230/tests/kraken/driver.html?testName=json-parse-financial) 16:06:48 INFO - 2015-11-24 16:06:48,047 DEBUG : BROWSER_OUTPUT: RSS: Main: 156856320 16:06:48 INFO - 2015-11-24 16:06:48,048 DEBUG : BROWSER_OUTPUT: 16:06:49 INFO - 2015-11-24 16:06:49,636 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54230/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54230/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:06:50 INFO - 2015-11-24 16:06:50,197 DEBUG : BROWSER_OUTPUT: RSS: Main: 168443904 16:06:50 INFO - 2015-11-24 16:06:50,197 DEBUG : BROWSER_OUTPUT: 16:06:52 INFO - 2015-11-24 16:06:52,007 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54230/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54230/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:06:52 INFO - 2015-11-24 16:06:52,613 DEBUG : BROWSER_OUTPUT: RSS: Main: 165482496 16:06:52 INFO - 2015-11-24 16:06:52,614 DEBUG : BROWSER_OUTPUT: 16:06:54 INFO - 2015-11-24 16:06:54,650 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54230/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54230/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:06:55 INFO - 2015-11-24 16:06:55,221 DEBUG : BROWSER_OUTPUT: RSS: Main: 175210496 16:06:55 INFO - 2015-11-24 16:06:55,222 DEBUG : BROWSER_OUTPUT: 16:06:57 INFO - 2015-11-24 16:06:57,818 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54230/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54230/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:06:58 INFO - 2015-11-24 16:06:58,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 178659328 16:06:58 INFO - 2015-11-24 16:06:58,400 DEBUG : BROWSER_OUTPUT: 16:07:00 INFO - 2015-11-24 16:07:00,939 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54230/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54230/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:07:01 INFO - 2015-11-24 16:07:01,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 175034368 16:07:01 INFO - 2015-11-24 16:07:01,505 DEBUG : BROWSER_OUTPUT: 16:07:03 INFO - 2015-11-24 16:07:03,174 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54230/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54230/tests/kraken/driver.html?testName=ai-astar) 16:07:03 INFO - 2015-11-24 16:07:03,424 DEBUG : BROWSER_OUTPUT: RSS: Main: 234475520 16:07:03 INFO - 2015-11-24 16:07:03,425 DEBUG : BROWSER_OUTPUT: 16:07:03 INFO - 2015-11-24 16:07:03,426 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:07:03 INFO - 2015-11-24 16:07:03,426 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:07:03 INFO - 2015-11-24 16:07:03,427 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:07:03 INFO - 2015-11-24 16:07:03,427 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:07:03 INFO - 2015-11-24 16:07:03,427 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;110;103;110;111;111;100;109;108;102 16:07:03 INFO - 2015-11-24 16:07:03,427 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;124;150;164;125;150;151;125;168;123 16:07:03 INFO - 2015-11-24 16:07:03,428 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;159;162;160;161;157;159;162;160;160 16:07:03 INFO - 2015-11-24 16:07:03,428 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;75;80;93;77;72;72;102;91;71 16:07:03 INFO - 2015-11-24 16:07:03,428 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;94;137;93;93;94;144;93;93;134 16:07:03 INFO - 2015-11-24 16:07:03,429 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;110;109;110;110;110;110 16:07:03 INFO - 2015-11-24 16:07:03,429 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;146;145;145;146;144;145;146;145 16:07:03 INFO - 2015-11-24 16:07:03,429 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;96;96;95;96;95;96;96 16:07:03 INFO - 2015-11-24 16:07:03,429 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;57;57;56;57;58;56;56;57;55 16:07:03 INFO - 2015-11-24 16:07:03,429 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;69;69;69;69;68;69;69 16:07:03 INFO - 2015-11-24 16:07:03,429 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;84;82;84;86;85;84;84;84 16:07:03 INFO - 2015-11-24 16:07:03,430 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;120;124;110;123;117;119;118;129;132 16:07:03 INFO - 2015-11-24 16:07:03,430 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;140;147;161;148;139;150;147;148;145 16:07:03 INFO - 2015-11-24 16:07:03,430 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;65;66;67;68;66;67;66;66;66 16:07:03 INFO - 2015-11-24 16:07:03,430 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:07:03 INFO - 2015-11-24 16:07:03,430 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:07:03 INFO - 2015-11-24 16:07:03,430 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,909 16:07:03 INFO - 2015-11-24 16:07:03,430 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:07:03 INFO - 2015-11-24 16:07:03,430 DEBUG : BROWSER_OUTPUT: __startTimestamp1448410023425__endTimestamp 16:07:03 INFO - 2015-11-24 16:07:03,431 DEBUG : BROWSER_OUTPUT: 16:07:03 INFO - 2015-11-24 16:07:03,431 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:07:03 INFO - 2015-11-24 16:07:03,431 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:07:03 INFO - 2015-11-24 16:07:03,431 DEBUG : BROWSER_OUTPUT: 16:07:03 INFO - 2015-11-24 16:07:03,432 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.10 Median:109.50 stddev:4.01 (3.7%) stddev-sans-first:4.26 16:07:03 INFO - 2015-11-24 16:07:03,432 DEBUG : BROWSER_OUTPUT: Values: 107.0 110.0 103.0 110.0 111.0 111.0 100.0 109.0 108.0 102.0 16:07:03 INFO - 2015-11-24 16:07:03,432 DEBUG : BROWSER_OUTPUT: 16:07:03 INFO - 2015-11-24 16:07:03,432 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.10 Median:150.50 stddev:17.32 (11.5%) stddev-sans-first:18.14 16:07:03 INFO - 2015-11-24 16:07:03,433 DEBUG : BROWSER_OUTPUT: Values: 151.0 124.0 150.0 164.0 125.0 150.0 151.0 125.0 168.0 123.0 16:07:03 INFO - 2015-11-24 16:07:03,433 DEBUG : BROWSER_OUTPUT: 16:07:03 INFO - 2015-11-24 16:07:03,433 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.10 Median:160.50 stddev:1.52 (0.9%) stddev-sans-first:1.58 16:07:03 INFO - 2015-11-24 16:07:03,433 DEBUG : BROWSER_OUTPUT: Values: 161.0 159.0 162.0 160.0 161.0 157.0 159.0 162.0 160.0 160.0 16:07:03 INFO - 2015-11-24 16:07:03,433 DEBUG : BROWSER_OUTPUT: 16:07:03 INFO - 2015-11-24 16:07:03,433 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.40 Median:76.00 stddev:11.04 (14.5%) stddev-sans-first:11.17 16:07:03 INFO - 2015-11-24 16:07:03,433 DEBUG : BROWSER_OUTPUT: Values: 71.0 75.0 80.0 93.0 77.0 72.0 72.0 102.0 91.0 71.0 16:07:03 INFO - 2015-11-24 16:07:03,433 DEBUG : BROWSER_OUTPUT: 16:07:03 INFO - 2015-11-24 16:07:03,433 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.80 Median:93.00 stddev:21.90 (23.5%) stddev-sans-first:22.65 16:07:03 INFO - 2015-11-24 16:07:03,434 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 137.0 93.0 93.0 94.0 144.0 93.0 93.0 134.0 16:07:03 INFO - 2015-11-24 16:07:03,434 DEBUG : BROWSER_OUTPUT: 16:07:03 INFO - 2015-11-24 16:07:03,434 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:07:03 INFO - 2015-11-24 16:07:03,434 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 110.0 109.0 110.0 110.0 110.0 110.0 16:07:03 INFO - 2015-11-24 16:07:03,434 DEBUG : BROWSER_OUTPUT: 16:07:03 INFO - 2015-11-24 16:07:03,435 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.85 (0.6%) stddev-sans-first:0.71 16:07:03 INFO - 2015-11-24 16:07:03,435 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 146.0 145.0 145.0 146.0 144.0 145.0 146.0 145.0 16:07:03 INFO - 2015-11-24 16:07:03,435 DEBUG : BROWSER_OUTPUT: 16:07:03 INFO - 2015-11-24 16:07:03,435 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:07:03 INFO - 2015-11-24 16:07:03,435 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 16:07:03 INFO - 2015-11-24 16:07:03,435 DEBUG : BROWSER_OUTPUT: 16:07:03 INFO - 2015-11-24 16:07:03,435 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.60 Median:57.00 stddev:0.84 (1.5%) stddev-sans-first:0.88 16:07:03 INFO - 2015-11-24 16:07:03,436 DEBUG : BROWSER_OUTPUT: Values: 57.0 57.0 57.0 56.0 57.0 58.0 56.0 56.0 57.0 55.0 16:07:03 INFO - 2015-11-24 16:07:03,436 DEBUG : BROWSER_OUTPUT: 16:07:03 INFO - 2015-11-24 16:07:03,436 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 16:07:03 INFO - 2015-11-24 16:07:03,436 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 69.0 69.0 69.0 69.0 68.0 69.0 69.0 16:07:03 INFO - 2015-11-24 16:07:03,436 DEBUG : BROWSER_OUTPUT: 16:07:03 INFO - 2015-11-24 16:07:03,436 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:84.00 stddev:0.99 (1.2%) stddev-sans-first:1.05 16:07:03 INFO - 2015-11-24 16:07:03,436 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 84.0 82.0 84.0 86.0 85.0 84.0 84.0 84.0 16:07:03 INFO - 2015-11-24 16:07:03,436 DEBUG : BROWSER_OUTPUT: 16:07:03 INFO - 2015-11-24 16:07:03,436 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.40 Median:122.50 stddev:6.22 (5.1%) stddev-sans-first:6.60 16:07:03 INFO - 2015-11-24 16:07:03,437 DEBUG : BROWSER_OUTPUT: Values: 122.0 120.0 124.0 110.0 123.0 117.0 119.0 118.0 129.0 132.0 16:07:03 INFO - 2015-11-24 16:07:03,437 DEBUG : BROWSER_OUTPUT: 16:07:03 INFO - 2015-11-24 16:07:03,437 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.60 Median:147.50 stddev:6.31 (4.3%) stddev-sans-first:6.36 16:07:03 INFO - 2015-11-24 16:07:03,437 DEBUG : BROWSER_OUTPUT: Values: 141.0 140.0 147.0 161.0 148.0 139.0 150.0 147.0 148.0 145.0 16:07:03 INFO - 2015-11-24 16:07:03,437 DEBUG : BROWSER_OUTPUT: 16:07:03 INFO - 2015-11-24 16:07:03,437 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:0.84 (1.3%) stddev-sans-first:0.87 16:07:03 INFO - 2015-11-24 16:07:03,437 DEBUG : BROWSER_OUTPUT: Values: 67.0 65.0 66.0 67.0 68.0 66.0 67.0 66.0 66.0 66.0 16:07:03 INFO - 2015-11-24 16:07:03,437 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:07:03 INFO - 2015-11-24 16:07:03,437 DEBUG : BROWSER_OUTPUT: 16:07:04 INFO - 2015-11-24 16:07:04,269 INFO : Browser exited with error code: 0 16:07:04 INFO - 2015-11-24 16:07:04,318 INFO : Completed test kraken (00:00:58) 16:07:04 INFO - 2015-11-24 16:07:04,318 INFO : Starting test v8_7 16:07:04 INFO - 2015-11-24 16:07:04,318 DEBUG : operating with platform_type : linux_ 16:07:04 INFO - 2015-11-24 16:07:04,318 INFO : Initialising browser for v8_7 test... 16:07:04 INFO - 2015-11-24 16:07:04,324 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoiGHkC/profile http://localhost:54230/getInfo.html 16:07:08 INFO - 2015-11-24 16:07:08,100 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:07:08 INFO - 2015-11-24 16:07:08,100 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:07:08 INFO - 2015-11-24 16:07:08,101 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:07:08 INFO - 2015-11-24 16:07:08,101 DEBUG : BROWSER_OUTPUT: __metrics 16:07:08 INFO - 2015-11-24 16:07:08,222 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:07:09 INFO - 2015-11-24 16:07:09,493 INFO : Browser initialized. 16:07:09 INFO - 2015-11-24 16:07:09,494 INFO : Running cycle 1/1 for v8_7 test... 16:07:09 INFO - 2015-11-24 16:07:09,494 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpoiGHkC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:07:21 INFO - 2015-11-24 16:07:21,263 DEBUG : BROWSER_OUTPUT: RSS: Main: 140345344 16:07:21 INFO - 2015-11-24 16:07:21,263 DEBUG : BROWSER_OUTPUT: 16:07:42 INFO - 2015-11-24 16:07:42,703 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54230/tests/v8_7/run.html (next: http://localhost:54230/tests/v8_7/run.html) 16:07:42 INFO - 2015-11-24 16:07:42,961 DEBUG : BROWSER_OUTPUT: RSS: Main: 606167040 16:07:42 INFO - 2015-11-24 16:07:42,961 DEBUG : BROWSER_OUTPUT: 16:07:42 INFO - 2015-11-24 16:07:42,961 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:07:42 INFO - 2015-11-24 16:07:42,961 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:07:42 INFO - 2015-11-24 16:07:42,961 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:07:42 INFO - 2015-11-24 16:07:42,961 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:07:42 INFO - 2015-11-24 16:07:42,961 DEBUG : BROWSER_OUTPUT: |0;Richards;189.9335232668566 16:07:42 INFO - 2015-11-24 16:07:42,961 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.46588767433096 16:07:42 INFO - 2015-11-24 16:07:42,961 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.08744710860367 16:07:42 INFO - 2015-11-24 16:07:42,961 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5000 16:07:42 INFO - 2015-11-24 16:07:42,962 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1980.1980198019803 16:07:42 INFO - 2015-11-24 16:07:42,962 DEBUG : BROWSER_OUTPUT: |5;Earley;777.6049766718507 16:07:42 INFO - 2015-11-24 16:07:42,962 DEBUG : BROWSER_OUTPUT: |6;Boyer;11904.761904761905 16:07:42 INFO - 2015-11-24 16:07:42,962 DEBUG : BROWSER_OUTPUT: |7;RegExp;26605.263157894737 16:07:42 INFO - 2015-11-24 16:07:42,962 DEBUG : BROWSER_OUTPUT: |8;Splay;648.2670089858793 16:07:42 INFO - 2015-11-24 16:07:42,962 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 16:07:42 INFO - 2015-11-24 16:07:42,962 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:07:42 INFO - 2015-11-24 16:07:42,962 DEBUG : BROWSER_OUTPUT: __startTimestamp1448410062954__endTimestamp 16:07:42 INFO - 2015-11-24 16:07:42,962 DEBUG : BROWSER_OUTPUT: 16:07:42 INFO - 2015-11-24 16:07:42,962 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:07:42 INFO - 2015-11-24 16:07:42,962 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:07:42 INFO - 2015-11-24 16:07:42,962 DEBUG : BROWSER_OUTPUT: 16:07:42 INFO - 2015-11-24 16:07:42,962 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:189.93 Median:189.93 stddev:0.00 (0.0%) 16:07:42 INFO - 2015-11-24 16:07:42,962 DEBUG : BROWSER_OUTPUT: Values: 189.9 16:07:42 INFO - 2015-11-24 16:07:42,962 DEBUG : BROWSER_OUTPUT: 16:07:42 INFO - 2015-11-24 16:07:42,962 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.47 Median:188.47 stddev:0.00 (0.0%) 16:07:42 INFO - 2015-11-24 16:07:42,963 DEBUG : BROWSER_OUTPUT: Values: 188.5 16:07:42 INFO - 2015-11-24 16:07:42,963 DEBUG : BROWSER_OUTPUT: 16:07:42 INFO - 2015-11-24 16:07:42,963 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.09 Median:282.09 stddev:0.00 (0.0%) 16:07:42 INFO - 2015-11-24 16:07:42,963 DEBUG : BROWSER_OUTPUT: Values: 282.1 16:07:42 INFO - 2015-11-24 16:07:42,963 DEBUG : BROWSER_OUTPUT: 16:07:42 INFO - 2015-11-24 16:07:42,963 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5000.00 Median:5000.00 stddev:0.00 (0.0%) 16:07:42 INFO - 2015-11-24 16:07:42,963 DEBUG : BROWSER_OUTPUT: Values: 5000.0 16:07:42 INFO - 2015-11-24 16:07:42,963 DEBUG : BROWSER_OUTPUT: 16:07:42 INFO - 2015-11-24 16:07:42,963 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1980.20 Median:1980.20 stddev:0.00 (0.0%) 16:07:42 INFO - 2015-11-24 16:07:42,963 DEBUG : BROWSER_OUTPUT: Values: 1980.2 16:07:42 INFO - 2015-11-24 16:07:42,963 DEBUG : BROWSER_OUTPUT: 16:07:42 INFO - 2015-11-24 16:07:42,963 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:777.60 Median:777.60 stddev:0.00 (0.0%) 16:07:42 INFO - 2015-11-24 16:07:42,963 DEBUG : BROWSER_OUTPUT: Values: 777.6 16:07:42 INFO - 2015-11-24 16:07:42,963 DEBUG : BROWSER_OUTPUT: 16:07:42 INFO - 2015-11-24 16:07:42,963 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11904.76 Median:11904.76 stddev:0.00 (0.0%) 16:07:42 INFO - 2015-11-24 16:07:42,963 DEBUG : BROWSER_OUTPUT: Values: 11904.8 16:07:42 INFO - 2015-11-24 16:07:42,963 DEBUG : BROWSER_OUTPUT: 16:07:42 INFO - 2015-11-24 16:07:42,964 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26605.26 Median:26605.26 stddev:0.00 (0.0%) 16:07:42 INFO - 2015-11-24 16:07:42,964 DEBUG : BROWSER_OUTPUT: Values: 26605.3 16:07:42 INFO - 2015-11-24 16:07:42,964 DEBUG : BROWSER_OUTPUT: 16:07:42 INFO - 2015-11-24 16:07:42,964 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:648.27 Median:648.27 stddev:0.00 (0.0%) 16:07:42 INFO - 2015-11-24 16:07:42,964 DEBUG : BROWSER_OUTPUT: Values: 648.3 16:07:42 INFO - 2015-11-24 16:07:42,964 DEBUG : BROWSER_OUTPUT: 16:07:42 INFO - 2015-11-24 16:07:42,964 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 16:07:42 INFO - 2015-11-24 16:07:42,964 DEBUG : BROWSER_OUTPUT: Values: 4845.4 16:07:42 INFO - 2015-11-24 16:07:42,964 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:07:42 INFO - 2015-11-24 16:07:42,964 DEBUG : BROWSER_OUTPUT: 16:07:43 INFO - 2015-11-24 16:07:43,737 INFO : Browser exited with error code: 0 16:07:43 INFO - 2015-11-24 16:07:43,754 INFO : Completed test v8_7 (00:00:39) 16:07:43 INFO - 2015-11-24 16:07:43,942 INFO : Completed test suite (00:20:14) 16:07:43 INFO - 2015-11-24 16:07:43,942 DEBUG : Working with test: dromaeo_css 16:07:43 INFO - 2015-11-24 16:07:43,942 DEBUG : Generating results file: dromaeo_css 16:07:43 INFO - 2015-11-24 16:07:43,943 DEBUG : Working with test: kraken 16:07:43 INFO - 2015-11-24 16:07:43,943 DEBUG : Generating results file: kraken 16:07:43 INFO - 2015-11-24 16:07:43,943 INFO : javascript benchmark 16:07:43 INFO - 2015-11-24 16:07:43,944 DEBUG : Working with test: v8_7 16:07:43 INFO - 2015-11-24 16:07:43,944 DEBUG : Generating results file: v8_7 16:07:43 INFO - 2015-11-24 16:07:43,944 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:07:44 INFO - 2015-11-24 16:07:44,004 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 16:07:44 INFO - 2015-11-24 16:07:44,004 DEBUG : process_Request line: dromaeo_css 6991.61 graph.html#tests=[[72,201,35]] 16:07:44 INFO - 2015-11-24 16:07:44,004 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:07:44 INFO - 2015-11-24 16:07:44,041 DEBUG : process_Request line: kraken 1492.20 graph.html#tests=[[232,201,35]] 16:07:44 INFO - 2015-11-24 16:07:44,042 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:07:44 INFO - 2015-11-24 16:07:44,167 DEBUG : process_Request line: v8_7 19523.21 graph.html#tests=[[230,201,35]] 16:07:44 INFO - 2015-11-24 16:07:44,169 INFO : javascript benchmark 16:07:44 INFO - 2015-11-24 16:07:44,172 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3161.0, 3219.597550306212, 3229.370272796804, 3240.2547414094774, 3242.85407156678, 5380.730963451826, 5382.730863456831, 5485.862853428666, 5510.393856675762, 5552.694601796905, 5416.485433883785, 5426.240326354314, 5475.808346707856, 5498.4501549845, 5553.888922221553, 4895.21676531755, 4915.041566894448, 4924.039812236615, 4928.852134435972, 4953.925691114636, 4871.537203965618, 4983.177775667011, 4993.7503124843615, 5018.272350509174, 5081.59347252219, 4854.296127061556, 4941.752912354404, 4962.379702537183, 4979.875503112415, 5005.599552035828, 4997.075541024886, 4999.850004499871, 5001.424836143854, 5008.924866127011, 5040.067587496325, 4898.877528061791, 4963.131451995922, 4980.153373926441, 4982.5017498250245, 5043.974780126113, 5181.559567436772, 5253.921191182136, 5325.866853328659, 5344.973275133639, 5374.193870919355, 5942.940570594282, 5945.286565612154, 5945.613535120204, 5947.553933454965, 5947.9702601486715, 5896.941030589682, 5969.8806023879715, 5977.282726072855, 5996.13056106862, 6021.217241758587, 5508.6970216638065, 5559.499645031926, 5570.192322113352, 5573.693446860461, 5624.915626265569, 6098.634081955097, 6120.755169793248, 6134.447899689049, 6137.539684523678, 6140.385961403824, 5640.407757185519, 5689.431056894277, 5912.054071348563, 5921.111833225051, 5942.405759424109, 5851.946649603027, 5920.2895652521975, 5967.5524335675, 5971.731272092679, 5982.7008649568215, 5879.323877754027, 5889.23439952812, 5890.676012819336, 5905.793297234576, 5919.6744179070565, 5887.4406931341455, 5888.205092312569, 5896.292444906639, 5909.231799866076, 5909.409059094142, 4406.801693923717, 4429.025614364835, 4439.400680908101, 4512.932306015412, 4525.773711314421, 4018.2767101921936, 4024.8993775155855, 4029.1135950090934, 4031.0124019614796, 4058.817353219112, 5590.832275031756, 5595.832125036255, 5597.132444471114, 5598.748056337475, 5653.152027195953, 5699.74351154199, 5769.682667453247, 5811.854703632443, 5859.765609375662, 5934.732937017845, 5610.579206559524, 5625.268715067097, 5627.352854421794, 5632.746526406321, 5646.943530564724, 5173.249878767558, 5179.404368497671, 5181.35233095863, 5184.429712731597, 5239.869003274873, 5893.086571581412, 6065.0, 6071.696415179312, 6188.0717892315615, 6218.968905155536, 5782.710864456844, 5858.443447872445, 5859.121131830259, 5866.061430171152, 5909.674967876636, 6080.908786368296, 6086.573939824169, 6090.512758979359, 6098.359672234352, 6104.664243466652, 5746.511546518593, 5797.188393624811, 5807.593468457337, 5819.912701309399, 5840.153177789111, 5827.271591051119, 5856.9121463178935, 5857.58996870215, 5875.823725288248, 5877.353491115889, 5724.255846739898, 5728.770849166153, 5734.397888221677, 5743.282089738783, 5752.165935939349, 5714.9142762857755, 5738.110592858114, 5753.568482363756, 5852.795152169653, 5854.063349864001, 5615.6630602164005, 5679.488846003879, 5679.545636348999, 5722.284714410699, 5734.3978882218435, 5840.357560668238, 5915.142304365929, 5916.437938395846, 5917.822465326047, 5968.791092311922, 5491.75287112073, 5691.686957217393, 5709.600327977168, 5774.56690748204, 5782.624129431573], "unit": "ms", "name": "dojo.html", "value": 5433.152306459665}, {"lowerIsBetter": false, "replicates": [563.5491606714628, 565.7482420322957, 573.5125143627916, 589.9705014749264, 595.2262059322879, 31035.379292414138, 36248.81875590621, 36952.260954780955, 36999.81500092496, 37016.81491592542, 40922.29393619735, 41514.79242603783, 41646.0, 41657.58342416575, 41786.37320440188, 7580.583067931261, 7703.653335599884, 8621.913780862189, 8777.473351598892, 8816.0, 10436.791264174712, 10704.625338113168, 10707.678769636923, 10717.089047430978, 10719.464026798667, 10336.793264134712, 10447.947760261188, 10456.111230545413, 10464.738381540485, 10484.423356715377, 7741.22587741227, 7935.563544005077, 7940.364770818378, 10231.897681023169, 10418.739531511697, 9817.263705222136, 9878.60485580576, 9923.503824808731, 9942.304038717293, 9947.353422027545, 36651.4502282466, 36748.26503469916, 37017.81491092527, 37200.0, 37264.44103338452, 2820.591014302935, 3222.5327327537375, 3272.378248132847, 3360.83195840207, 3543.486194501783, 30388.54417183744, 30557.929677406497, 30857.382852342827, 31037.22406939822, 31588.842055789573, 3795.7153213509096, 3833.9041523962123, 3882.70879684022, 3899.317619416619, 3973.3517754703007, 263731.0, 264006.0, 264128.0, 264652.0, 264738.0, 57878.7106064467, 58404.7079764607, 58420.415795841494, 58425.0, 58437.12344314839, 52752.208716869274, 53876.0, 59925.400745992854, 60053.399466005656, 60393.396066039655, 15745.68508629821, 15958.441454549034, 16022.19889005545, 16043.518694439186, 16059.357625694842, 12109.091818113677, 12128.575499857463, 12158.817617735742, 12171.208871423507, 12234.632961011184, 18659.44021679352, 18896.52758681044, 18940.0, 19009.42971710851, 19016.334428294944, 7428.702851885864, 7673.3477654398885, 7736.922630773733, 7742.574158421228, 7839.451238413257, 982.7346616413529, 1009.5658866687395, 1036.2176556699644, 1079.3631757263095, 1117.0114448712786, 28357.574636380472, 28456.715432845405, 28880.133595992153, 28957.42085158285, 28975.275618109717, 1015.8171529124828, 1038.807820553185, 1043.4991204222015, 1104.3373975614727, 1124.3254047571554, 13378.866211337956, 13393.799093013613, 13434.865651343556, 15043.473478428203, 15238.807831400423, 330318.0, 335795.0, 335848.0, 336085.0, 337425.0, 51903.0, 52013.7399313001, 52140.478595213564, 52244.73877630587, 52280.73859630677, 1288.4717265921115, 1343.993280033613, 1349.2511656030997, 1353.0866665001085, 1354.8848347890344, 27609.44781104407, 28546.57180142341, 28867.711322886502, 29049.419011620073, 29179.0, 45507.0, 46887.29669055035, 51350.22974655309, 52517.47482525126, 52631.73684131555, 261514.0, 262144.0, 262657.0, 263803.0, 263870.0, 27115.72884271132, 27635.44729105447, 29805.552916705834, 30165.396692066475, 30176.396472070875, 41697.58302416937, 41758.58241417547, 42474.575254247065, 42500.362494563225, 45571.31643025291, 34617.1345716349, 34917.30165396627, 34955.0, 35049.8247508771, 35600.28799424049, 34633.826830865684, 35005.0, 35466.0, 35973.0, 36853.815730921175, 32637.510437342982, 35268.0, 35804.82097589495, 35862.64137358593, 35911.461328079575, 27849.582256265767, 30195.09414717562, 30668.0, 30841.0, 32972.67027329696, 24172.153974610803, 24357.39106522351, 24821.255362339158, 24866.0, 25166.0], "unit": "ms", "name": "ext.html", "value": 18482.868170152375}, {"lowerIsBetter": false, "replicates": [351.32720839592184, 353.04853420033004, 356.1719003317288, 356.8251556737198, 357.17314417124373, 14089.859101408983, 14470.131792092481, 16115.194240287983, 16485.423010194645, 17249.05130217839, 16216.432424865132, 16240.187990600452, 16253.593660158502, 16267.0, 16285.91857040716, 4633.443986721598, 4814.964782571747, 4819.108464933998, 4819.638527110464, 4822.107910036637, 3729.272791805599, 3827.942580861289, 4769.403824521934, 4836.709797412166, 5528.474794894499, 5430.8913821723545, 5452.2094296327, 5497.725113744316, 5513.50378465938, 5521.641093328941, 5055.823046193384, 5172.0, 5190.0, 5198.220266959967, 5199.194124910645, 4797.928031079537, 4899.0, 4906.681065730716, 5001.824936127218, 5006.148954677714, 14997.550073497703, 15008.0, 15026.323815428223, 18555.536111597317, 19107.23571057156, 2023.2311721545718, 2112.384026219943, 2157.0832396231694, 2173.5870184665023, 2195.747489038749, 9594.280428967786, 10115.949420252851, 10392.428416437093, 11625.0, 13492.12301200419, 1816.7093265077656, 1849.8427633651156, 1864.0586503815487, 1895.1282410091374, 1999.1903279171959, 43691.56308436907, 43881.34177987333, 48141.75929120367, 54538.90922181574, 63181.0, 15385.384584616713, 15656.295466704025, 15713.921430392775, 15718.0, 15854.60363490922, 24347.14784982517, 24457.51084978326, 24631.753682462946, 24732.134375296777, 24736.381590460383, 8431.072582015973, 8483.872741908875, 8503.362247831314, 8578.699745509002, 8838.29293656506, 7175.354218120394, 7196.208417074117, 7204.855902881913, 7226.132864056347, 7248.383887369632, 7484.43866709988, 7611.3530349920875, 7756.379489640815, 7766.37868970481, 7775.883361749578, 2657.5349313869997, 2966.1398194523345, 3006.864691088906, 3007.3083190866223, 3053.5114381698822, 836.8242669039448, 920.2453987729997, 996.4121168510613, 1045.954045954046, 1066.3974854207347, 15874.285657145225, 16060.196990150445, 16677.0, 17032.148392580322, 17060.402885898933, 891.9687810926587, 903.8553831386946, 936.7236665183788, 994.7363948553639, 1038.4081073787868, 9274.072592740671, 9717.85423218638, 9762.46306453152, 9795.412275263507, 9825.361351512129, 373621.0, 376930.0, 420585.0, 511628.0, 513618.0, 78055.21944780592, 83366.0, 84217.0, 84462.15537844543, 85358.0, 1065.4566171252561, 1076.860008198929, 1079.63292480557, 1089.3627228071666, 1103.8896110388896, 12692.301923394301, 14998.775018374952, 15181.848181518486, 15242.085474871543, 15366.46217382431, 33417.0, 33457.33085338328, 33598.83200583982, 35421.114472138404, 36471.0, 44964.325535117656, 45540.31689524594, 46218.30672539847, 47458.52541474541, 47568.0, 8713.172248636369, 9575.329726919048, 9754.0733630305, 9764.414135151914, 9766.414015159113, 17739.822601773816, 17847.107644617976, 18076.819231807513, 18263.269469221083, 18393.264269429073, 14509.347079381665, 14626.122432654074, 14759.188244646648, 15067.09597424158, 15197.848021519643, 13429.462821487032, 14291.213983230606, 14683.339249734001, 14785.778213327023, 14869.628259293604, 14953.775693364825, 15114.848851511784, 15338.15640139803, 15466.690666186838, 15519.844801552292, 9320.533973301171, 9474.715758527254, 9910.504474776088, 9913.752156196153, 9930.354526955725, 10134.23993200498, 10225.795484090426, 12294.692632684255, 14815.18516481604, 15298.464553740565], "unit": "ms", "name": "jquery.html", "value": 9210.650759704638}, {"lowerIsBetter": false, "replicates": [1330.1154732103153, 1456.9635759106022, 1500.0549653718153, 1618.2636900210405, 1738.6175041490876, 6502.512311576633, 7187.245339239383, 7410.814729631762, 7431.331180193782, 7438.033055702765, 7506.774796756093, 7627.618619069038, 7635.618219089051, 7640.42696797741, 7642.04474440695, 1844.3729132095084, 1869.4204796513056, 2114.0803750368564, 2205.5037616536233, 2222.92219772308, 2156.8382371322136, 2174.70641463402, 2176.031665908671, 2177.6624623183434, 2180.5965896309153, 2105.7367829021373, 2195.890205489727, 2197.121151539389, 2197.2748992832326, 2199.0214354612203, 1946.8734532255357, 1954.2964532768192, 2145.2062736787334, 2172.5654869026257, 2174.7716489768504, 2117.110813458351, 2165.7401111866675, 2171.055590817999, 2176.5864485747816, 2178.8583742056717, 7418.221086785918, 7453.627318634047, 7470.775876723707, 7481.438892083062, 7495.213002634754, 4542.818287268538, 4594.793234304464, 4626.4910859805395, 4638.698484598491, 4641.791119399635, 2882.754965827907, 2964.43675701616, 2987.507061334877, 2995.9400811983637, 2996.460637085324, 908.1009800297724, 931.9394239374419, 942.8397172480695, 954.4178051388648, 961.5817119553017, 10515.789684206273, 10683.145348372189, 10687.412192329419, 10694.679159625224, 10695.09091727204, 4168.416421700904, 4234.195502854448, 4285.335772955197, 4286.928267933017, 4302.591253830881, 9265.583048762823, 9266.397684150508, 9270.0, 9292.53537323131, 9295.209907157967, 4713.128071306819, 4717.787699553528, 4727.125481785881, 4752.500987396343, 4756.7859446325, 4262.595053469915, 4295.22685916538, 4308.504521980012, 4308.719933204332, 4313.762743049162, 3513.4729790531114, 3577.5885773136424, 3594.227241143167, 3598.3702852000797, 3599.208174201671, 1088.7931293054294, 1107.3687997841314, 1114.3481063577897, 1127.8251870960014, 1128.373752567333, 1295.4086281345308, 1295.6242689619905, 1326.1843965960866, 1337.725766217923, 1352.2427440633278, 7017.649117544102, 7053.047838541834, 7103.147622285359, 7124.643767811589, 7131.286871312931, 404.54084613963363, 406.37012630422726, 410.86236110903184, 415.7671703845856, 428.63994244834487, 5623.775048998076, 5681.772729090872, 5689.0328644130595, 5694.487496125369, 5697.6296540724725, 8987.730368088967, 9001.729948101567, 9320.30097742672, 9330.160285574331, 9332.34673572857, 9098.454092754457, 9183.724488265363, 9201.539923003957, 9204.723858284262, 9206.723798286062, 7022.894656580155, 7076.787696369117, 7148.642567871586, 7177.569345839266, 7260.636968151572, 7116.110486189226, 7170.139583250043, 7224.060872086595, 7224.711011559479, 7224.819379515554, 7900.565468899265, 8067.757967260992, 8087.716929907425, 8089.393295502743, 8233.259006689426, 8299.045609754956, 8361.456505327134, 8366.205210504992, 8562.229399353839, 8571.828563428571, 6673.232578253563, 6769.492288078315, 6813.420859226823, 6829.248782634006, 6829.590224586541, 7420.814479638052, 7474.439417043634, 7479.252074792477, 7487.438442116754, 7495.662695178621, 5841.94158058431, 6794.796156115324, 6869.381755642016, 6981.546199497219, 7202.53183543068, 6915.343042410963, 6936.375726184668, 6997.090378250795, 7033.507654464139, 7044.647767611701, 6731.865362692621, 6840.11078559804, 6840.931590684029, 6842.726290948306, 6852.040714300102, 6301.779437719658, 6312.936870631235, 6321.146645202839, 6324.3991820776955, 6331.841703957438, 5992.250968628921, 6292.0, 6308.71610777507, 6393.520485963664, 6393.712282947372], "unit": "ms", "name": "mootools.html", "value": 4271.239268302848}, {"lowerIsBetter": false, "replicates": [309.860562746764, 314.88506695056304, 321.3749257693786, 322.2089769615594, 323.7220135904031, 5923.815236952605, 5959.255093113361, 5983.700814959251, 5985.4014598540125, 5986.940130598693, 5900.350961394243, 5927.318358388776, 5931.6441013539215, 5933.258342707161, 5953.315368732597, 4352.956470435302, 4389.473263208403, 4423.579759922818, 4481.753503557303, 4531.977340113303, 4502.347159661847, 4509.1883460977015, 4519.570640789119, 4532.546745325474, 4535.591796738293, 4442.267025940732, 4450.33245013249, 4463.866084017484, 4465.151621191963, 4483.910321793563, 4305.461817272841, 4382.255016647162, 4400.185965596375, 4441.600255976945, 4444.73331600105, 3866.8066596670055, 3866.8259928303296, 3885.9805700971315, 3901.1222474943193, 3901.824417901173, 5597.356304025048, 5601.635893666939, 5610.24261724666, 5611.242482264883, 5612.326520817487, 5178.766955487012, 5216.895662086737, 5217.060929032773, 5221.843344699665, 5227.059129356714, 6172.783952561684, 6286.371362863722, 6292.4966002719675, 6299.055141728777, 6300.495960323163, 4265.786710664454, 4266.616004559604, 4267.658587313008, 4268.701190916637, 4270.14597080582, 6501.869962600769, 6548.508861835334, 6553.935510314283, 6554.1151944487365, 6577.6711164441585, 4238.597333253336, 4291.442112525352, 4293.806778694966, 4295.656347492193, 4336.219480493542, 4378.8029538670835, 4385.956140438619, 4388.934165987513, 4390.187815254124, 4392.604665580113, 5134.717590532557, 5136.640435169577, 5142.97428512855, 5144.845654630367, 5147.356580427447, 6343.904841427382, 6354.650494222769, 6361.0, 6364.936350636527, 6366.808995730135, 1510.1090356689606, 1513.7199618070472, 1521.680447106098, 1522.1628104542458, 1586.920653967297, 987.7481242283171, 1042.9478526073665, 1053.5996321397972, 1060.7242117049623, 1063.1176123817213, 5995.070764031495, 6004.849878753066, 6008.0, 6023.48800351975, 6030.246219222598, 6461.450776684034, 6462.38607332312, 6467.644279564575, 6473.0, 6478.740850365933, 5981.312149102909, 5981.790637327673, 5990.251218597676, 5990.820275391745, 6003.0, 3349.1961929136833, 3426.297608990151, 3489.842957066938, 3574.749767516249, 3581.8567257309937, 6766.221884483249, 6792.320767923267, 6799.762008329685, 6800.6599670017295, 6806.5235433520165, 6722.630255336004, 6738.225104112992, 6749.0551322814845, 6750.662466876636, 6751.459883209332, 6629.270780214172, 6718.966405168041, 6728.058071869942, 6826.590404575742, 6845.657717114124, 6621.834454138685, 6621.867562648624, 6628.237752658313, 6630.734770609121, 6638.369354911276, 6363.204599425072, 6546.345365463416, 6547.050677651809, 6547.279799222177, 6558.1802274715665, 6819.0, 6827.829304267433, 6831.487638427038, 6833.4191593715095, 6834.453243740588, 4412.382266482759, 4450.399196108613, 4453.910921781481, 4455.131249406335, 4477.843275485342, 6595.406413422623, 6600.966995164993, 6602.735890564323, 6607.372299631527, 6617.073609694743, 6263.906041409474, 6420.390062944013, 6427.646479443675, 6430.742770289136, 6432.003039528693, 6401.711922963571, 6405.19935008124, 6407.327230640902, 6412.551121421642, 6413.8717225656155, 6234.438900498977, 6295.433410993032, 6305.558610897193, 6305.621662700252, 6316.399942005502, 6278.089676996901, 6427.068075129174, 6432.13166222554, 6446.226452825504, 6476.287608362982, 6299.811005669837, 6301.212348456443, 6304.6847657617855, 6309.779157729457, 6311.211098612674], "unit": "ms", "name": "prototype.html", "value": 4729.518210625818}, {"lowerIsBetter": false, "replicates": [738.4383908774148, 780.5550836023467, 844.7043534762834, 858.3433673239971, 870.4646642314974, 13087.80368294474, 13090.149140305886, 13161.341932903364, 13244.53644122456, 13257.270850103241, 12472.189307694993, 12483.875161248385, 12544.749105017894, 12623.17949333295, 12636.11547191697, 677.962712050837, 681.4582406986458, 794.7059587952466, 807.1887752808449, 825.0553116681397, 804.5856383962264, 814.1614137438419, 816.5468165168329, 822.3708862720024, 824.0153017144514, 702.5047341624169, 855.2644725536034, 867.2108381372952, 867.8741582470537, 868.956552172392, 697.0137255783061, 841.7685136587456, 854.3891117850767, 855.0850589868812, 856.546030603781, 629.8897692903723, 634.6414275934129, 640.782134074417, 640.8686219325027, 641.0928536121382, 12534.561290354884, 12649.0, 12649.241045537297, 12830.743385132246, 12860.421281042376, 11677.532898684043, 12305.0, 12316.322602256872, 12319.876801232052, 12644.810327845089, 9486.857697134548, 9579.712608621683, 9722.562484688206, 9850.852237216448, 10458.738531536696, 3566.7681600695873, 3580.6240344763687, 3596.982015089934, 3616.4213725803747, 3627.3289441453417, 43440.0, 43995.34006989898, 44232.3365149523, 46816.765916170545, 46940.29589556159, 9664.806703866025, 9746.75633109178, 9825.0, 9972.950135249277, 10111.988801119829, 17871.642567148585, 17898.10509474547, 17916.641667166583, 17917.193726282087, 17918.372856949944, 7714.614269286513, 7794.649240784178, 7828.334591559667, 7917.995398719395, 7942.404319676048, 4291.742495450283, 4324.762138082436, 4338.284183109815, 4385.51759306476, 4564.497905230422, 3029.106413607991, 3056.4040012197406, 3058.403611295776, 3059.0, 3060.43381974331, 536.1394961087476, 556.4741319453159, 568.5991376079854, 569.0156030067923, 569.5443645083999, 554.9944500554943, 606.0606060606043, 669.9698513566901, 689.8654762321299, 711.6477343714894, 8257.42198046131, 8260.752177434686, 8420.621072051772, 8517.867313835764, 8559.657613695383, 520.4353276694753, 609.8322961185621, 693.6774399904069, 701.1936273285762, 705.6507029020668, 4022.155347377025, 4053.9391909121387, 4061.3501839705505, 4125.525564560114, 4258.914821703611, 56212.71893640587, 56548.43451565514, 56960.0, 57135.714321428124, 57139.71430142823, 50904.49095509072, 51693.22460163101, 51958.0, 51959.0, 52329.738351308, 45295.77352113284, 45729.0, 46136.0, 46817.29774053392, 47373.763131184125, 8089.716859909875, 8120.512769233865, 8138.674453022049, 8149.8370032600205, 8315.542645154575, 34348.65651343555, 34374.82812585921, 34539.30921381609, 35508.82245588755, 35903.461448077775, 41353.37969930514, 41523.58476415197, 44391.668249952556, 44917.550824491336, 45103.77448112739, 10173.542190601589, 10458.581656733646, 10654.360738355723, 11264.324140551265, 11698.122640801803, 12007.0, 12274.140810143204, 12294.262344259372, 12520.937395312965, 12842.0, 11214.439278035903, 11561.421928903354, 11562.88437115618, 11632.88367116318, 12015.879841201477, 11339.603113890975, 11529.596464124052, 11646.475908583965, 11796.410179491162, 12113.394330283627, 11175.329480231212, 11487.483063262007, 11563.5952741657, 11609.129315301556, 11660.18378713482, 9793.85309220348, 9905.851412228678, 10023.899761002589, 10057.446840423847, 10339.0694837465, 9046.683366082156, 9098.454092754457, 9343.71968840936, 9364.719058428258, 9858.694683474156], "unit": "ms", "name": "yui.html", "value": 6250.848048750374}], "name": "dromaeo_css", "value": 6991.60729413926}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 110.0, 103.0, 110.0, 111.0, 111.0, 100.0, 109.0, 108.0, 102.0], "unit": "ms", "name": "ai-astar", "value": 107.1}, {"lowerIsBetter": true, "replicates": [151.0, 124.0, 150.0, 164.0, 125.0, 150.0, 151.0, 125.0, 168.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.1}, {"lowerIsBetter": true, "replicates": [161.0, 159.0, 162.0, 160.0, 161.0, 157.0, 159.0, 162.0, 160.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.1}, {"lowerIsBetter": true, "replicates": [71.0, 75.0, 80.0, 93.0, 77.0, 72.0, 72.0, 102.0, 91.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 137.0, 93.0, 93.0, 94.0, 144.0, 93.0, 93.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 145.0, 145.0, 146.0, 144.0, 145.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 57.0, 56.0, 57.0, 58.0, 56.0, 56.0, 57.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 84.0, 82.0, 84.0, 86.0, 85.0, 84.0, 84.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.1}, {"lowerIsBetter": true, "replicates": [122.0, 120.0, 124.0, 110.0, 123.0, 117.0, 119.0, 118.0, 129.0, 132.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.4}, {"lowerIsBetter": true, "replicates": [141.0, 140.0, 147.0, 161.0, 148.0, 139.0, 150.0, 147.0, 148.0, 145.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.6}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 66.0, 67.0, 68.0, 66.0, 67.0, 66.0, 66.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1492.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [189.9335232668566], "unit": "score", "name": "Richards", "value": 185.86502999999996}, {"lowerIsBetter": false, "replicates": [188.46588767433096], "unit": "score", "name": "DeltaBlue", "value": 350.8221079999999}, {"lowerIsBetter": false, "replicates": [282.08744710860367], "unit": "score", "name": "Encrypt", "value": 943.6116450000002}, {"lowerIsBetter": false, "replicates": [5000.0], "unit": "score", "name": "Decrypt", "value": 53.23619999999997}, {"lowerIsBetter": false, "replicates": [1980.1980198019803], "unit": "score", "name": "RayTrace", "value": 373.6944450000001}, {"lowerIsBetter": false, "replicates": [777.6049766718507], "unit": "score", "name": "Earley", "value": 857.0714179999998}, {"lowerIsBetter": false, "replicates": [11904.761904761905], "unit": "score", "name": "Boyer", "value": 55.98289200000003}, {"lowerIsBetter": false, "replicates": [26605.263157894737], "unit": "score", "name": "RegExp", "value": 34.24078140454997}, {"lowerIsBetter": false, "replicates": [648.2670089858793], "unit": "score", "name": "Splay", "value": 125.70591881188115}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19523.20920177761}]} 16:07:44 INFO - RETURN: dromaeo_css: 6991.61 16:07:44 INFO - RETURN: kraken: 1492.20 16:07:44 INFO - RETURN: v8_7: 19523.21 16:07:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19523.21"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1492.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6991.61"}}} 16:07:44 INFO - Return code: 0 16:07:44 INFO - # TBPL SUCCESS # 16:07:44 INFO - Running post-action listener: _resource_record_post_action 16:07:44 INFO - Running post-run listener: _resource_record_post_run 16:07:45 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 10547200; Write bytes: 395571200; Read time: 3548; Write time: 410128 16:07:45 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 266240; Read time: 0; Write time: 40 16:07:45 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 8355840; Write bytes: 395304960; Read time: 3176; Write time: 410088 16:07:45 INFO - Running post-run listener: _upload_blobber_files 16:07:45 INFO - Blob upload gear active. 16:07:45 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:07:45 INFO - Copying logs to upload dir... 16:07:45 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.259096 ========= master_lag: -0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-24 16:07:45.309417) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 16:07:45.313443) ========= 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=e10134013339c31d8d0c4708000001d6-1448408225.747718-395407925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/hG33TXeuSX21_fUJNUEZzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009943 build_url: 'https://queue.taskcluster.net/v1/task/hG33TXeuSX21_fUJNUEZzw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 16:07:45.365846) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 16:07:45.366517) ========= 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=e10134013339c31d8d0c4708000001d6-1448408225.747718-395407925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004588 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 16:07:45.416911) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 16:07:45.417343) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 16:07:45.417775) ========= ========= Total master_lag: 0.12 =========