builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1452769824.58 results: success (0) buildid: 20160114004007 builduid: f091a1d64ffb446ab8aa3d0204ed3ee6 revision: 3384695f473b9ab1796e75c22787b2410e0e54ba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 03:10:24.577042) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 03:10:24.577618) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 03:10:24.577904) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1452769303.403424-1146716374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006328 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 03:10:24.610789) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 03:10:24.611077) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 03:10:24.633013) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:10:24.633280) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1452769303.403424-1146716374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004621 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:10:24.694008) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 03:10:24.694281) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 03:10:24.694609) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:10:24.694875) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1452769303.403424-1146716374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-14 03:10:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-01-14 03:10:25 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.412979 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:10:25.119797) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:10:25.120096) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1452769303.403424-1146716374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019778 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:10:25.170003) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:10:25.170436) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3384695f473b9ab1796e75c22787b2410e0e54ba --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3384695f473b9ab1796e75c22787b2410e0e54ba --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=8c6b6742ce8f6f39ef4ce27d000001f1-1452769303.403424-1146716374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-14 03:10:25,522 truncating revision to first 12 chars 2016-01-14 03:10:25,522 Setting DEBUG logging. 2016-01-14 03:10:25,522 attempt 1/10 2016-01-14 03:10:25,522 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3384695f473b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-14 03:10:25,805 unpacking tar archive at: mozilla-aurora-3384695f473b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641025 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:10:25.826834) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 03:10:25.827378) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 03:10:25.838004) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 03:10:25.838520) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 03:10:25.839186) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-01-14 03:10:25.839659) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1452769303.403424-1146716374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:10:26 INFO - MultiFileLogger online at 20160114 03:10:26 in /builds/slave/test-pgo 03:10:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:10:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:10:26 INFO - {'append_to_log': False, 03:10:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:10:26 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:10:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:10:26 INFO - 'branch': 'Mozilla-Aurora', 03:10:26 INFO - 'buildbot_json_path': 'buildprops.json', 03:10:26 INFO - 'config_files': ('talos/linux_config.py',), 03:10:26 INFO - 'default_actions': ('clobber', 03:10:26 INFO - 'read-buildbot-config', 03:10:26 INFO - 'download-and-extract', 03:10:26 INFO - 'populate-webroot', 03:10:26 INFO - 'create-virtualenv', 03:10:26 INFO - 'install', 03:10:26 INFO - 'run-tests'), 03:10:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:10:26 INFO - 'download_minidump_stackwalk': True, 03:10:26 INFO - 'download_symbols': 'ondemand', 03:10:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:10:26 INFO - 'tooltool.py': '/tools/tooltool.py', 03:10:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:10:26 INFO - '/tools/misc-python/virtualenv.py')}, 03:10:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:10:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:10:26 INFO - 'installer_path': 'installer.exe', 03:10:26 INFO - 'log_level': 'info', 03:10:26 INFO - 'log_name': 'talos', 03:10:26 INFO - 'log_to_console': True, 03:10:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:10:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:10:26 INFO - 'opt_config_files': (), 03:10:26 INFO - 'pip_index': False, 03:10:26 INFO - 'sps_profile': False, 03:10:26 INFO - 'sps_profile_interval': 0, 03:10:26 INFO - 'suite': 'dromaeojs', 03:10:26 INFO - 'system_bits': '32', 03:10:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:10:26 INFO - 'title': 'talos-linux64-ix-041', 03:10:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:10:26 INFO - 'use_talos_json': True, 03:10:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:10:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:10:26 INFO - 'work_dir': 'build'} 03:10:26 INFO - ##### 03:10:26 INFO - ##### Running clobber step. 03:10:26 INFO - ##### 03:10:26 INFO - Running pre-action listener: _resource_record_pre_action 03:10:26 INFO - Running main action method: clobber 03:10:26 INFO - rmtree: /builds/slave/test-pgo/build 03:10:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:10:27 INFO - Running post-action listener: _resource_record_post_action 03:10:27 INFO - ##### 03:10:27 INFO - ##### Running read-buildbot-config step. 03:10:27 INFO - ##### 03:10:27 INFO - Running pre-action listener: _resource_record_pre_action 03:10:27 INFO - Running main action method: read_buildbot_config 03:10:27 INFO - Using buildbot properties: 03:10:27 INFO - { 03:10:27 INFO - "properties": { 03:10:27 INFO - "buildnumber": 197, 03:10:27 INFO - "product": "firefox", 03:10:27 INFO - "script_repo_revision": "production", 03:10:27 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:10:27 INFO - "repository": "", 03:10:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:10:27 INFO - "buildid": "20160114004007", 03:10:27 INFO - "slavename": "talos-linux64-ix-041", 03:10:27 INFO - "stage_platform": "linux64-pgo", 03:10:27 INFO - "basedir": "/builds/slave/test-pgo", 03:10:27 INFO - "nightly_build": "True", 03:10:27 INFO - "project": "", 03:10:27 INFO - "platform": "ubuntu64_hw", 03:10:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:10:27 INFO - "slavebuilddir": "test", 03:10:27 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:10:27 INFO - "branch": "mozilla-aurora", 03:10:27 INFO - "repo_path": "releases/mozilla-aurora", 03:10:27 INFO - "pgo_build": "True", 03:10:27 INFO - "builduid": "f091a1d64ffb446ab8aa3d0204ed3ee6", 03:10:27 INFO - "revision": "3384695f473b9ab1796e75c22787b2410e0e54ba" 03:10:27 INFO - }, 03:10:27 INFO - "sourcestamp": { 03:10:27 INFO - "repository": "", 03:10:27 INFO - "hasPatch": false, 03:10:27 INFO - "project": "", 03:10:27 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:10:27 INFO - "changes": [ 03:10:27 INFO - { 03:10:27 INFO - "category": null, 03:10:27 INFO - "files": [ 03:10:27 INFO - { 03:10:27 INFO - "url": null, 03:10:27 INFO - "name": "https://queue.taskcluster.net/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 03:10:27 INFO - } 03:10:27 INFO - ], 03:10:27 INFO - "repository": "", 03:10:27 INFO - "rev": "3384695f473b9ab1796e75c22787b2410e0e54ba", 03:10:27 INFO - "who": "sendchange", 03:10:27 INFO - "when": 1452769762, 03:10:27 INFO - "number": 7459391, 03:10:27 INFO - "comments": "", 03:10:27 INFO - "project": "", 03:10:27 INFO - "at": "Thu 14 Jan 2016 03:09:22", 03:10:27 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:10:27 INFO - "revlink": "", 03:10:27 INFO - "properties": [ 03:10:27 INFO - [ 03:10:27 INFO - "buildid", 03:10:27 INFO - "20160114004007", 03:10:27 INFO - "Change" 03:10:27 INFO - ], 03:10:27 INFO - [ 03:10:27 INFO - "builduid", 03:10:27 INFO - "f091a1d64ffb446ab8aa3d0204ed3ee6", 03:10:27 INFO - "Change" 03:10:27 INFO - ], 03:10:27 INFO - [ 03:10:27 INFO - "nightly_build", 03:10:27 INFO - "True", 03:10:27 INFO - "Change" 03:10:27 INFO - ], 03:10:27 INFO - [ 03:10:27 INFO - "pgo_build", 03:10:27 INFO - "True", 03:10:27 INFO - "Change" 03:10:27 INFO - ] 03:10:27 INFO - ], 03:10:27 INFO - "revision": "3384695f473b9ab1796e75c22787b2410e0e54ba" 03:10:27 INFO - } 03:10:27 INFO - ], 03:10:27 INFO - "revision": "3384695f473b9ab1796e75c22787b2410e0e54ba" 03:10:27 INFO - } 03:10:27 INFO - } 03:10:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 03:10:27 INFO - Running post-action listener: _resource_record_post_action 03:10:27 INFO - ##### 03:10:27 INFO - ##### Running download-and-extract step. 03:10:27 INFO - ##### 03:10:27 INFO - Running pre-action listener: _resource_record_pre_action 03:10:27 INFO - Running main action method: download_and_extract 03:10:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:27 INFO - https://queue.taskcluster.net/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:10:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/test_packages.json 03:10:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/test_packages.json 03:10:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:10:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:10:33 INFO - Downloaded 1302 bytes. 03:10:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:10:33 INFO - Using the following test package requirements: 03:10:33 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:10:33 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:10:33 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:10:33 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:10:33 INFO - u'jsshell-linux-x86_64.zip'], 03:10:33 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:10:33 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:10:33 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:10:33 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:10:33 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:10:33 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:10:33 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:10:33 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:10:33 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:10:33 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:10:33 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:10:33 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:10:33 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:10:33 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')]} 03:10:33 INFO - https://queue.taskcluster.net/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:10:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:10:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:10:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:10:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:10:42 INFO - Downloaded 23024812 bytes. 03:10:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:10:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:10:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:10:43 INFO - Return code: 0 03:10:43 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:10:43 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')]} 03:10:43 INFO - https://queue.taskcluster.net/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:10:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:10:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:10:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:10:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:10:47 INFO - Downloaded 23024812 bytes. 03:10:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:10:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:10:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:10:48 INFO - Return code: 0 03:10: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')]} 03:10:48 INFO - https://queue.taskcluster.net/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:10:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:10:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:10:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:10:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:10:50 INFO - Downloaded 11132038 bytes. 03:10:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 03:10:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:10:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 03:10:50 INFO - Return code: 0 03:10:50 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')]} 03:10:50 INFO - https://queue.taskcluster.net/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:10:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:10:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:10:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:10:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:11:03 INFO - Downloaded 58110519 bytes. 03:11:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:11:03 INFO - mkdir: /builds/slave/test-pgo/properties 03:11:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:11:03 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:11:03 INFO - Contents: 03:11:03 INFO - build_url:https://queue.taskcluster.net/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:11:03 INFO - Running post-action listener: _resource_record_post_action 03:11:03 INFO - Running post-action listener: set_extra_try_arguments 03:11:03 INFO - ##### 03:11:03 INFO - ##### Running populate-webroot step. 03:11:03 INFO - ##### 03:11:03 INFO - Running pre-action listener: _resource_record_pre_action 03:11:03 INFO - Running main action method: populate_webroot 03:11:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:11:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:11:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:11:03 INFO - '--tppagecycles', 03:11:03 INFO - '7'], 03:11:03 INFO - 'tests': ['tsvgm']}}, 03:11:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:11:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:11:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:11:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:11:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:11:03 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:11:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:11:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:03 INFO - 'talos_options': ['--e10s'], 03:11:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:11:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:03 INFO - 'tests': ['damp', 'tps']}, 03:11:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:03 INFO - 'talos_options': ['--e10s'], 03:11:03 INFO - 'tests': ['damp', 'tps']}, 03:11:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:11:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:11:03 INFO - 'other': {'tests': ['a11yr', 03:11:03 INFO - 'ts_paint', 03:11:03 INFO - 'tpaint', 03:11:03 INFO - 'sessionrestore', 03:11:03 INFO - 'sessionrestore_no_auto_restore']}, 03:11:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:11:03 INFO - 'tests': ['a11yr', 03:11:03 INFO - 'ts_paint', 03:11:03 INFO - 'tpaint', 03:11:03 INFO - 'sessionrestore', 03:11:03 INFO - 'sessionrestore_no_auto_restore']}, 03:11:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:11:03 INFO - 'tests': ['a11yr', 03:11:03 INFO - 'ts_paint', 03:11:03 INFO - 'tpaint', 03:11:03 INFO - 'sessionrestore', 03:11:03 INFO - 'sessionrestore_no_auto_restore']}, 03:11:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:11:03 INFO - 'tests': ['a11yr', 03:11:03 INFO - 'ts_paint', 03:11:03 INFO - 'tpaint', 03:11:03 INFO - 'sessionrestore', 03:11:03 INFO - 'sessionrestore_no_auto_restore']}, 03:11:03 INFO - 'other_l64': {'tests': ['a11yr', 03:11:03 INFO - 'ts_paint', 03:11:03 INFO - 'tpaint', 03:11:03 INFO - 'sessionrestore', 03:11:03 INFO - 'sessionrestore_no_auto_restore']}, 03:11:03 INFO - 'other_nol64': {'tests': ['a11yr', 03:11:03 INFO - 'ts_paint', 03:11:03 INFO - 'tpaint', 03:11:03 INFO - 'sessionrestore', 03:11:03 INFO - 'sessionrestore_no_auto_restore']}, 03:11:03 INFO - 'svgr': {'tests': ['tsvgx', 03:11:03 INFO - 'tsvgr_opacity', 03:11:03 INFO - 'tart', 03:11:03 INFO - 'tscrollx', 03:11:03 INFO - 'cart']}, 03:11:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:11:03 INFO - 'tests': ['tsvgx', 03:11:03 INFO - 'tsvgr_opacity', 03:11:03 INFO - 'tart', 03:11:03 INFO - 'tscrollx', 03:11:03 INFO - 'cart']}, 03:11:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:03 INFO - 'tests': ['tp5o']}, 03:11:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:03 INFO - 'talos_options': ['--e10s'], 03:11:03 INFO - 'tests': ['tp5o']}, 03:11:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:03 INFO - 'talos_options': ['--xperf_path', 03:11:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:11:03 INFO - 'tests': ['tp5n']}, 03:11:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:03 INFO - 'talos_options': ['--e10s', 03:11:03 INFO - '--xperf_path', 03:11:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:11:03 INFO - 'tests': ['tp5n']}}, 03:11:03 INFO - 'talos.zip': {'path': '', 03:11:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:11:03 INFO - Running post-action listener: _resource_record_post_action 03:11:03 INFO - ##### 03:11:03 INFO - ##### Running create-virtualenv step. 03:11:03 INFO - ##### 03:11:03 INFO - Running pre-action listener: _resource_record_pre_action 03:11:03 INFO - Running main action method: create_virtualenv 03:11:03 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:11:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 03:11:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:11:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:11:03 INFO - Using real prefix '/usr' 03:11:03 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:11:03 INFO - Installing distribute.............................................................................................................................................................................................done. 03:11:05 INFO - Installing pip.................done. 03:11:05 INFO - Return code: 0 03:11:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ce8a38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b0600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283f350>, '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 0x2840250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28406e0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452769303.403424-1146716374', '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 03:11:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 03:11:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:11:05 INFO - Using env: {'DISPLAY': ':0', 03:11:05 INFO - 'HOME': '/home/cltbld', 03:11:05 INFO - 'LANG': 'en_US.UTF-8', 03:11:05 INFO - 'LANGUAGE': 'en_US:en', 03:11:05 INFO - 'LOGNAME': 'cltbld', 03:11:05 INFO - 'MAIL': '/var/mail/cltbld', 03:11:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:05 INFO - 'MOZ_NO_REMOTE': '1', 03:11:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:05 INFO - 'NO_EM_RESTART': '1', 03:11:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:11:05 INFO - 'PWD': '/builds/slave/test-pgo', 03:11:05 INFO - 'SHELL': '/bin/bash', 03:11:05 INFO - 'SHLVL': '1', 03:11:05 INFO - 'TERM': 'linux', 03:11:05 INFO - 'TMOUT': '86400', 03:11:05 INFO - 'USER': 'cltbld', 03:11:05 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452769303.403424-1146716374', 03:11:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:05 INFO - '_': '/tools/buildbot/bin/python'} 03:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:11:06 INFO - Cleaning up... 03:11:06 INFO - Return code: 0 03:11:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:11: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')]} 03:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11: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')]} 03:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ce8a38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b0600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283f350>, '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 0x2840250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28406e0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452769303.403424-1146716374', '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 03:11:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 03:11:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:11:06 INFO - Using env: {'DISPLAY': ':0', 03:11:06 INFO - 'HOME': '/home/cltbld', 03:11:06 INFO - 'LANG': 'en_US.UTF-8', 03:11:06 INFO - 'LANGUAGE': 'en_US:en', 03:11:06 INFO - 'LOGNAME': 'cltbld', 03:11:06 INFO - 'MAIL': '/var/mail/cltbld', 03:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:06 INFO - 'MOZ_NO_REMOTE': '1', 03:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:06 INFO - 'NO_EM_RESTART': '1', 03:11:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:11:06 INFO - 'PWD': '/builds/slave/test-pgo', 03:11:06 INFO - 'SHELL': '/bin/bash', 03:11:06 INFO - 'SHLVL': '1', 03:11:06 INFO - 'TERM': 'linux', 03:11:06 INFO - 'TMOUT': '86400', 03:11:06 INFO - 'USER': 'cltbld', 03:11:06 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452769303.403424-1146716374', 03:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:06 INFO - '_': '/tools/buildbot/bin/python'} 03:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:06 INFO - Downloading/unpacking psutil>=0.7.1 03:11: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 03:11: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 03:11: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 03:11: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 03:11: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 03:11: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 03:11:07 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:11:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:11:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:11:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:11:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:11:08 INFO - Installing collected packages: psutil 03:11:08 INFO - Running setup.py install for psutil 03:11:08 INFO - building 'psutil._psutil_linux' extension 03:11:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:11:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:11:08 INFO - building 'psutil._psutil_posix' extension 03:11:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:11:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:11:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:11:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:11:08 INFO - Successfully installed psutil 03:11:08 INFO - Cleaning up... 03:11:08 INFO - Return code: 0 03:11:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ce8a38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b0600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283f350>, '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 0x2840250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28406e0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452769303.403424-1146716374', '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 03:11:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 03:11:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:11:08 INFO - Using env: {'DISPLAY': ':0', 03:11:08 INFO - 'HOME': '/home/cltbld', 03:11:08 INFO - 'LANG': 'en_US.UTF-8', 03:11:08 INFO - 'LANGUAGE': 'en_US:en', 03:11:08 INFO - 'LOGNAME': 'cltbld', 03:11:08 INFO - 'MAIL': '/var/mail/cltbld', 03:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:08 INFO - 'MOZ_NO_REMOTE': '1', 03:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:08 INFO - 'NO_EM_RESTART': '1', 03:11:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:11:08 INFO - 'PWD': '/builds/slave/test-pgo', 03:11:08 INFO - 'SHELL': '/bin/bash', 03:11:08 INFO - 'SHLVL': '1', 03:11:08 INFO - 'TERM': 'linux', 03:11:08 INFO - 'TMOUT': '86400', 03:11:08 INFO - 'USER': 'cltbld', 03:11:08 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452769303.403424-1146716374', 03:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:08 INFO - '_': '/tools/buildbot/bin/python'} 03:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:11:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:11:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:11:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:11:10 INFO - Installing collected packages: mozsystemmonitor 03:11:10 INFO - Running setup.py install for mozsystemmonitor 03:11:10 INFO - Successfully installed mozsystemmonitor 03:11:10 INFO - Cleaning up... 03:11:10 INFO - Return code: 0 03:11:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:11: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')]} 03:11:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11: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')]} 03:11:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ce8a38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b0600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283f350>, '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 0x2840250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28406e0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452769303.403424-1146716374', '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 03:11:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 03:11:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:11:10 INFO - Using env: {'DISPLAY': ':0', 03:11:10 INFO - 'HOME': '/home/cltbld', 03:11:10 INFO - 'LANG': 'en_US.UTF-8', 03:11:10 INFO - 'LANGUAGE': 'en_US:en', 03:11:10 INFO - 'LOGNAME': 'cltbld', 03:11:10 INFO - 'MAIL': '/var/mail/cltbld', 03:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:10 INFO - 'MOZ_NO_REMOTE': '1', 03:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:10 INFO - 'NO_EM_RESTART': '1', 03:11:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:11:10 INFO - 'PWD': '/builds/slave/test-pgo', 03:11:10 INFO - 'SHELL': '/bin/bash', 03:11:10 INFO - 'SHLVL': '1', 03:11:10 INFO - 'TERM': 'linux', 03:11:10 INFO - 'TMOUT': '86400', 03:11:10 INFO - 'USER': 'cltbld', 03:11:10 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452769303.403424-1146716374', 03:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:10 INFO - '_': '/tools/buildbot/bin/python'} 03:11:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:10 INFO - Downloading/unpacking blobuploader==1.2.4 03:11:10 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 03:11:10 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 03:11:10 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 03:11:10 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 03:11:10 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 03:11:10 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 03:11:12 INFO - Downloading blobuploader-1.2.4.tar.gz 03:11:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:11:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:11:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:11:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:11:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:13 INFO - Downloading docopt-0.6.1.tar.gz 03:11:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:11:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:11:13 INFO - Installing collected packages: blobuploader, requests, docopt 03:11:13 INFO - Running setup.py install for blobuploader 03:11:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:11:13 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:11:13 INFO - Running setup.py install for requests 03:11:13 INFO - Running setup.py install for docopt 03:11:13 INFO - Successfully installed blobuploader requests docopt 03:11:13 INFO - Cleaning up... 03:11:14 INFO - Return code: 0 03:11:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:11:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ce8a38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b0600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283f350>, '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 0x2840250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28406e0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452769303.403424-1146716374', '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 03:11:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 03:11:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:11:14 INFO - Using env: {'DISPLAY': ':0', 03:11:14 INFO - 'HOME': '/home/cltbld', 03:11:14 INFO - 'LANG': 'en_US.UTF-8', 03:11:14 INFO - 'LANGUAGE': 'en_US:en', 03:11:14 INFO - 'LOGNAME': 'cltbld', 03:11:14 INFO - 'MAIL': '/var/mail/cltbld', 03:11:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:14 INFO - 'MOZ_NO_REMOTE': '1', 03:11:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:14 INFO - 'NO_EM_RESTART': '1', 03:11:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:11:14 INFO - 'PWD': '/builds/slave/test-pgo', 03:11:14 INFO - 'SHELL': '/bin/bash', 03:11:14 INFO - 'SHLVL': '1', 03:11:14 INFO - 'TERM': 'linux', 03:11:14 INFO - 'TMOUT': '86400', 03:11:14 INFO - 'USER': 'cltbld', 03:11:14 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452769303.403424-1146716374', 03:11:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:14 INFO - '_': '/tools/buildbot/bin/python'} 03:11:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:11:14 INFO - Running setup.py (path:/tmp/pip-_Mh6mO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:11:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:11:14 INFO - Running setup.py (path:/tmp/pip-rKgf2l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:11:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:11:14 INFO - Running setup.py (path:/tmp/pip-MZLvoK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:11:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:11:14 INFO - Running setup.py (path:/tmp/pip-bcIiDL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:11:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:11:14 INFO - Running setup.py (path:/tmp/pip-JcaKIz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:11:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:11:14 INFO - Running setup.py (path:/tmp/pip-zJw9fI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:11:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:11:14 INFO - Running setup.py (path:/tmp/pip-O2LWWk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:11:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:11:14 INFO - Running setup.py (path:/tmp/pip-LSwtjM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:11:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:11:14 INFO - Running setup.py (path:/tmp/pip-Px5SFL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:11:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:11:14 INFO - Running setup.py (path:/tmp/pip-vrku9D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:11:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:11:14 INFO - Running setup.py (path:/tmp/pip-fM648M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:11:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:11:15 INFO - Running setup.py (path:/tmp/pip-XLfoW3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:11:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:11:15 INFO - Running setup.py (path:/tmp/pip-ZMF8fi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:11:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:11:15 INFO - Running setup.py (path:/tmp/pip-SecM0b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:11:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:11:15 INFO - Running setup.py (path:/tmp/pip-ZBDgGr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:11:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:11:15 INFO - Running setup.py (path:/tmp/pip-4RZNkA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:11:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:11:15 INFO - Running setup.py (path:/tmp/pip-EamRJv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:11:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:11:15 INFO - Running setup.py install for manifestparser 03:11:15 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:11:15 INFO - Running setup.py install for mozcrash 03:11:15 INFO - Running setup.py install for mozdebug 03:11:15 INFO - Running setup.py install for mozdevice 03:11:15 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:11:15 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:11:15 INFO - Running setup.py install for mozfile 03:11:15 INFO - Running setup.py install for mozhttpd 03:11:16 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:11:16 INFO - Running setup.py install for mozinfo 03:11:16 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:11:16 INFO - Running setup.py install for mozInstall 03:11:16 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:11:16 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:11:16 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:11:16 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:11:16 INFO - Running setup.py install for mozleak 03:11:16 INFO - Running setup.py install for mozlog 03:11:16 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:11:16 INFO - Running setup.py install for moznetwork 03:11:16 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:11:16 INFO - Running setup.py install for mozprocess 03:11:16 INFO - Running setup.py install for mozprofile 03:11:16 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:11:16 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:11:16 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:11:16 INFO - Running setup.py install for mozrunner 03:11:16 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:11:16 INFO - Running setup.py install for mozscreenshot 03:11:17 INFO - Running setup.py install for moztest 03:11:17 INFO - Running setup.py install for mozversion 03:11:17 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:11:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:11:17 INFO - Cleaning up... 03:11:17 INFO - Return code: 0 03:11:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:11:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ce8a38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b0600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283f350>, '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 0x2840250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28406e0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452769303.403424-1146716374', '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 03:11:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 03:11:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:11:17 INFO - Using env: {'DISPLAY': ':0', 03:11:17 INFO - 'HOME': '/home/cltbld', 03:11:17 INFO - 'LANG': 'en_US.UTF-8', 03:11:17 INFO - 'LANGUAGE': 'en_US:en', 03:11:17 INFO - 'LOGNAME': 'cltbld', 03:11:17 INFO - 'MAIL': '/var/mail/cltbld', 03:11:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:17 INFO - 'MOZ_NO_REMOTE': '1', 03:11:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:17 INFO - 'NO_EM_RESTART': '1', 03:11:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:11:17 INFO - 'PWD': '/builds/slave/test-pgo', 03:11:17 INFO - 'SHELL': '/bin/bash', 03:11:17 INFO - 'SHLVL': '1', 03:11:17 INFO - 'TERM': 'linux', 03:11:17 INFO - 'TMOUT': '86400', 03:11:17 INFO - 'USER': 'cltbld', 03:11:17 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452769303.403424-1146716374', 03:11:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:17 INFO - '_': '/tools/buildbot/bin/python'} 03:11:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:11:17 INFO - Running setup.py (path:/tmp/pip-4_nZRN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 03:11:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:11:17 INFO - Running setup.py (path:/tmp/pip-r6kelM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:11:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:11:17 INFO - Running setup.py (path:/tmp/pip-8agPVf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:11:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:11:17 INFO - Running setup.py (path:/tmp/pip-0Oioih-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:11:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:11:17 INFO - Running setup.py (path:/tmp/pip-v6XjMw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:11:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 03:11:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:11:17 INFO - Running setup.py (path:/tmp/pip-ArtQ_y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:11:17 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)) 03:11:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:11:17 INFO - Running setup.py (path:/tmp/pip-Y6cW3h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:11:17 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)) 03:11:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:11:17 INFO - Running setup.py (path:/tmp/pip-OSHQHQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 03:11:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:11:18 INFO - Running setup.py (path:/tmp/pip-OJNBCf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 03:11:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:11:18 INFO - Running setup.py (path:/tmp/pip-T01bF4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:11:18 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)) 03:11:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:11:18 INFO - Running setup.py (path:/tmp/pip-C5gR5B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 03:11:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:11:18 INFO - Running setup.py (path:/tmp/pip-brps_P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 03:11:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:11:18 INFO - Running setup.py (path:/tmp/pip-ebZFYP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 03:11:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:11:18 INFO - Running setup.py (path:/tmp/pip-giURIo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 03:11:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:11:18 INFO - Running setup.py (path:/tmp/pip-Cbd1u2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 03:11:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:11:18 INFO - Running setup.py (path:/tmp/pip-bqCqol-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 03:11:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:11:18 INFO - Running setup.py (path:/tmp/pip-g2R9iI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 03:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 03:11:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:20 INFO - Downloading blessings-1.5.1.tar.gz 03:11:20 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 03:11:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:11:20 INFO - Installing collected packages: blessings 03:11:20 INFO - Running setup.py install for blessings 03:11:21 INFO - Successfully installed blessings 03:11:21 INFO - Cleaning up... 03:11:21 INFO - Return code: 0 03:11:21 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:11:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:11:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:11:21 INFO - Reading from file tmpfile_stdout 03:11:21 INFO - Current package versions: 03:11:21 INFO - argparse == 1.2.1 03:11:21 INFO - blessings == 1.5.1 03:11:21 INFO - blobuploader == 1.2.4 03:11:21 INFO - docopt == 0.6.1 03:11:21 INFO - manifestparser == 1.1 03:11:21 INFO - mozInstall == 1.12 03:11:21 INFO - mozcrash == 0.16 03:11:21 INFO - mozdebug == 0.1 03:11:21 INFO - mozdevice == 0.47 03:11:21 INFO - mozfile == 1.2 03:11:21 INFO - mozhttpd == 0.7 03:11:21 INFO - mozinfo == 0.9 03:11:21 INFO - mozleak == 0.1 03:11:21 INFO - mozlog == 3.1 03:11:21 INFO - moznetwork == 0.27 03:11:21 INFO - mozprocess == 0.22 03:11:21 INFO - mozprofile == 0.27 03:11:21 INFO - mozrunner == 6.11 03:11:21 INFO - mozscreenshot == 0.1 03:11:21 INFO - mozsystemmonitor == 0.0 03:11:21 INFO - moztest == 0.7 03:11:21 INFO - mozversion == 1.4 03:11:21 INFO - psutil == 3.1.1 03:11:21 INFO - requests == 1.2.3 03:11:21 INFO - wsgiref == 0.1.2 03:11:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:11:21 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')]} 03:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:21 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')]} 03:11:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:21 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 0x7f0ce8a38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b0600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283f350>, '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 0x2840250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28406e0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452769303.403424-1146716374', '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 03:11:21 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 03:11:21 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 03:11:21 INFO - Using env: {'DISPLAY': ':0', 03:11:21 INFO - 'HOME': '/home/cltbld', 03:11:21 INFO - 'LANG': 'en_US.UTF-8', 03:11:21 INFO - 'LANGUAGE': 'en_US:en', 03:11:21 INFO - 'LOGNAME': 'cltbld', 03:11:21 INFO - 'MAIL': '/var/mail/cltbld', 03:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:21 INFO - 'MOZ_NO_REMOTE': '1', 03:11:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:21 INFO - 'NO_EM_RESTART': '1', 03:11:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:11:21 INFO - 'PWD': '/builds/slave/test-pgo', 03:11:21 INFO - 'SHELL': '/bin/bash', 03:11:21 INFO - 'SHLVL': '1', 03:11:21 INFO - 'TERM': 'linux', 03:11:21 INFO - 'TMOUT': '86400', 03:11:21 INFO - 'USER': 'cltbld', 03:11:21 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452769303.403424-1146716374', 03:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:21 INFO - '_': '/tools/buildbot/bin/python'} 03:11:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 03:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 03:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 03:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 03:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 03:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 03:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:11:21 INFO - Cleaning up... 03:11:21 INFO - Return code: 0 03:11:21 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:11:21 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')]} 03:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:21 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')]} 03:11:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ce8a38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b0600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283f350>, '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 0x2840250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28406e0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452769303.403424-1146716374', '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 03:11:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 03:11:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:11:21 INFO - Using env: {'DISPLAY': ':0', 03:11:21 INFO - 'HOME': '/home/cltbld', 03:11:21 INFO - 'LANG': 'en_US.UTF-8', 03:11:21 INFO - 'LANGUAGE': 'en_US:en', 03:11:21 INFO - 'LOGNAME': 'cltbld', 03:11:21 INFO - 'MAIL': '/var/mail/cltbld', 03:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:21 INFO - 'MOZ_NO_REMOTE': '1', 03:11:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:21 INFO - 'NO_EM_RESTART': '1', 03:11:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:11:21 INFO - 'PWD': '/builds/slave/test-pgo', 03:11:21 INFO - 'SHELL': '/bin/bash', 03:11:21 INFO - 'SHLVL': '1', 03:11:21 INFO - 'TERM': 'linux', 03:11:21 INFO - 'TMOUT': '86400', 03:11:21 INFO - 'USER': 'cltbld', 03:11:21 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452769303.403424-1146716374', 03:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:21 INFO - '_': '/tools/buildbot/bin/python'} 03:11:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:21 INFO - Downloading/unpacking jsonschema 03:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:11:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 03:11:23 INFO - Downloading/unpacking functools32 (from jsonschema) 03:11:23 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 03:11:23 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 03:11:23 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 03:11:23 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 03:11:23 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 03:11:23 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 03:11:23 INFO - Downloading functools32-3.2.3-2.tar.gz 03:11:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:11:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:11:23 INFO - warning: no files found matching '*.txt' 03:11:23 INFO - no previously-included directories found matching 'build' 03:11:23 INFO - no previously-included directories found matching 'dist' 03:11:23 INFO - no previously-included directories found matching '.git*' 03:11:23 INFO - Installing collected packages: jsonschema, functools32 03:11:23 INFO - Running setup.py install for functools32 03:11:24 INFO - warning: no files found matching '*.txt' 03:11:24 INFO - no previously-included directories found matching 'build' 03:11:24 INFO - no previously-included directories found matching 'dist' 03:11:24 INFO - no previously-included directories found matching '.git*' 03:11:24 INFO - Successfully installed jsonschema functools32 03:11:24 INFO - Cleaning up... 03:11:24 INFO - Return code: 0 03:11:24 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:11:24 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')]} 03:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:24 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')]} 03:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:24 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0ce8a38f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27b0600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283f350>, '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 0x2840250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28406e0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1452769303.403424-1146716374', '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 03:11:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 03:11:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:11:24 INFO - Using env: {'DISPLAY': ':0', 03:11:24 INFO - 'HOME': '/home/cltbld', 03:11:24 INFO - 'LANG': 'en_US.UTF-8', 03:11:24 INFO - 'LANGUAGE': 'en_US:en', 03:11:24 INFO - 'LOGNAME': 'cltbld', 03:11:24 INFO - 'MAIL': '/var/mail/cltbld', 03:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:24 INFO - 'MOZ_NO_REMOTE': '1', 03:11:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:24 INFO - 'NO_EM_RESTART': '1', 03:11:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:11:24 INFO - 'PWD': '/builds/slave/test-pgo', 03:11:24 INFO - 'SHELL': '/bin/bash', 03:11:24 INFO - 'SHLVL': '1', 03:11:24 INFO - 'TERM': 'linux', 03:11:24 INFO - 'TMOUT': '86400', 03:11:24 INFO - 'USER': 'cltbld', 03:11:24 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452769303.403424-1146716374', 03:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:24 INFO - '_': '/tools/buildbot/bin/python'} 03:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:24 INFO - Downloading/unpacking flake8 03:11:24 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 03:11:24 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 03:11:24 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 03:11:24 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 03:11:24 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 03:11:24 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 03:11:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:11:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 03:11:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:11:26 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 03:11:26 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 03:11:26 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 03:11:26 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 03:11:26 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 03:11:26 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 03:11:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:11:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 03:11:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:11:26 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 03:11:26 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 03:11:26 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 03:11:26 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 03:11:26 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 03:11:26 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 03:11:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 03:11:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:11:26 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 03:11:26 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 03:11:26 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 03:11:26 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 03:11:26 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 03:11:26 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 03:11:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:11:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:11:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:11:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:11:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:11:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:11:26 INFO - no previously-included directories found matching 'docs/_build' 03:11:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:11:26 INFO - Running setup.py install for pep8 03:11:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:11:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:11:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:11:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:11:27 INFO - no previously-included directories found matching 'docs/_build' 03:11:27 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:11:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:11:27 INFO - Cleaning up... 03:11:27 INFO - Return code: 0 03:11:27 INFO - Running post-action listener: _resource_record_post_action 03:11:27 INFO - Running post-action listener: _start_resource_monitoring 03:11:27 INFO - Starting resource monitoring. 03:11:27 INFO - ##### 03:11:27 INFO - ##### Running install step. 03:11:27 INFO - ##### 03:11:27 INFO - Running pre-action listener: _resource_record_pre_action 03:11:27 INFO - Running main action method: install 03:11:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:11:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:11:27 INFO - Reading from file tmpfile_stdout 03:11:27 INFO - Detecting whether we're running mozinstall >=1.0... 03:11:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:11:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:11:27 INFO - Reading from file tmpfile_stdout 03:11:27 INFO - Output received: 03:11:27 INFO - Usage: mozinstall [options] installer 03:11:27 INFO - Options: 03:11:27 INFO - -h, --help show this help message and exit 03:11:27 INFO - -d DEST, --destination=DEST 03:11:27 INFO - Directory to install application into. [default: 03:11:27 INFO - "/builds/slave/test-pgo"] 03:11:27 INFO - --app=APP Application being installed. [default: firefox] 03:11:27 INFO - mkdir: /builds/slave/test-pgo/build/application 03:11:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 03:11:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 03:11:42 INFO - Reading from file tmpfile_stdout 03:11:42 INFO - Output received: 03:11:42 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:11:42 INFO - Running post-action listener: _resource_record_post_action 03:11:42 INFO - ##### 03:11:42 INFO - ##### Running run-tests step. 03:11:42 INFO - ##### 03:11:42 INFO - Running pre-action listener: _resource_record_pre_action 03:11:42 INFO - Running main action method: run_tests 03:11:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:11:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:11:42 INFO - Python 2.7.3 03:11:42 INFO - Return code: 0 03:11:42 INFO - grabbing minidump binary from tooltool 03:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:42 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 0x283f350>, '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 0x2840250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28406e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:11:42 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 03:11:42 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 03:11:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:11:42 INFO - Return code: 0 03:11:42 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:11:42 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:11:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:11:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:11:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:11:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:11:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:11:43 INFO - Return code: 0 03:11:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:11:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost 03:11:43 INFO - Using env: {'DISPLAY': ':0', 03:11:43 INFO - 'HOME': '/home/cltbld', 03:11:43 INFO - 'LANG': 'en_US.UTF-8', 03:11:43 INFO - 'LANGUAGE': 'en_US:en', 03:11:43 INFO - 'LOGNAME': 'cltbld', 03:11:43 INFO - 'MAIL': '/var/mail/cltbld', 03:11:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:11:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:43 INFO - 'MOZ_NO_REMOTE': '1', 03:11:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:11:43 INFO - 'NO_EM_RESTART': '1', 03:11:43 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:11:43 INFO - 'PWD': '/builds/slave/test-pgo', 03:11:43 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:11:43 INFO - 'SHELL': '/bin/bash', 03:11:43 INFO - 'SHLVL': '1', 03:11:43 INFO - 'TERM': 'linux', 03:11:43 INFO - 'TMOUT': '86400', 03:11:43 INFO - 'USER': 'cltbld', 03:11:43 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1452769303.403424-1146716374', 03:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:43 INFO - '_': '/tools/buildbot/bin/python'} 03:11:43 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost'] with output_timeout 3600 03:11:43 INFO - mozversion INFO | application_buildid: 20160114004007 03:11:43 INFO - mozversion INFO | application_changeset: 3384695f473b9ab1796e75c22787b2410e0e54ba 03:11:43 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 03:11:43 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:11:43 INFO - mozversion INFO | application_name: Firefox 03:11:43 INFO - mozversion INFO | application_remotingname: firefox-dev 03:11:43 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:11:43 INFO - mozversion INFO | application_vendor: Mozilla 03:11:43 INFO - mozversion INFO | application_version: 45.0a2 03:11:43 INFO - mozversion INFO | platform_buildid: 20160114004007 03:11:43 INFO - mozversion INFO | platform_changeset: 3384695f473b9ab1796e75c22787b2410e0e54ba 03:11:43 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:11:43 INFO - mozversion INFO | platform_version: 45.0a2 03:11:43 INFO - 2016-01-14 03:11:43,268 DEBUG : using testdate: 1452769903 03:11:43 INFO - 2016-01-14 03:11:43,268 DEBUG : actual date: 1452769903 03:11:43 INFO - 2016-01-14 03:11:43,277 INFO : starting webserver on 'localhost:39957' 03:11:43 INFO - 2016-01-14 03:11:43,278 INFO : Starting test suite talos-linux64-ix-041 03:11:43 INFO - 2016-01-14 03:11:43,278 INFO : Starting test dromaeo_css 03:11:43 INFO - 2016-01-14 03:11:43,278 DEBUG : operating with platform_type : linux_ 03:11:43 INFO - 2016-01-14 03:11:43,279 INFO : Initialising browser for dromaeo_css test... 03:11:43 INFO - 2016-01-14 03:11:43,295 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpF4_ZfQ/profile http://localhost:39957/getInfo.html 03:11:47 INFO - 2016-01-14 03:11:47,563 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:11:47 INFO - 2016-01-14 03:11:47,563 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:11:47 INFO - 2016-01-14 03:11:47,563 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:11:47 INFO - 2016-01-14 03:11:47,563 DEBUG : BROWSER_OUTPUT: __metrics 03:11:47 INFO - 2016-01-14 03:11:47,761 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:11:48 INFO - 2016-01-14 03:11:48,515 INFO : Browser initialized. 03:11:48 INFO - 2016-01-14 03:11:48,515 INFO : Running cycle 1/1 for dromaeo_css test... 03:11:48 INFO - 2016-01-14 03:11:48,516 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpF4_ZfQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:12:00 INFO - 2016-01-14 03:12:00,305 DEBUG : BROWSER_OUTPUT: RSS: Main: 135999488 03:12:00 INFO - 2016-01-14 03:12:00,305 DEBUG : BROWSER_OUTPUT: 03:12:51 INFO - 2016-01-14 03:12:51,086 DEBUG : BROWSER_OUTPUT: 1452769971082 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] 03:14:59 INFO - 2016-01-14 03:14:59,855 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39957/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39957/tests/dromaeo/cssquery-ext.html) 03:15:00 INFO - 2016-01-14 03:15:00,899 DEBUG : BROWSER_OUTPUT: RSS: Main: 239906816 03:15:00 INFO - 2016-01-14 03:15:00,899 DEBUG : BROWSER_OUTPUT: 03:18:03 INFO - 2016-01-14 03:18:03,215 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39957/tests/dromaeo/cssquery-ext.html (next: http://localhost:39957/tests/dromaeo/cssquery-jquery.html) 03:18:03 INFO - 2016-01-14 03:18:03,777 DEBUG : BROWSER_OUTPUT: RSS: Main: 219131904 03:18:03 INFO - 2016-01-14 03:18:03,777 DEBUG : BROWSER_OUTPUT: 03:21:05 INFO - 2016-01-14 03:21:05,680 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39957/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39957/tests/dromaeo/cssquery-mootools.html) 03:21:06 INFO - 2016-01-14 03:21:06,233 DEBUG : BROWSER_OUTPUT: RSS: Main: 215404544 03:21:06 INFO - 2016-01-14 03:21:06,233 DEBUG : BROWSER_OUTPUT: 03:24:07 INFO - 2016-01-14 03:24:07,948 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39957/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39957/tests/dromaeo/cssquery-prototype.html) 03:24:08 INFO - 2016-01-14 03:24:08,514 DEBUG : BROWSER_OUTPUT: RSS: Main: 198770688 03:24:08 INFO - 2016-01-14 03:24:08,514 DEBUG : BROWSER_OUTPUT: 03:27:10 INFO - 2016-01-14 03:27:10,856 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39957/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39957/tests/dromaeo/cssquery-yui.html) 03:27:11 INFO - 2016-01-14 03:27:11,421 DEBUG : BROWSER_OUTPUT: RSS: Main: 200355840 03:27:11 INFO - 2016-01-14 03:27:11,421 DEBUG : BROWSER_OUTPUT: 03:30:13 INFO - 2016-01-14 03:30:13,674 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39957/tests/dromaeo/cssquery-yui.html (next: http://localhost:39957/tests/dromaeo/cssquery-dojo.html) 03:30:13 INFO - 2016-01-14 03:30:13,924 DEBUG : BROWSER_OUTPUT: RSS: Main: 246661120 03:30:13 INFO - 2016-01-14 03:30:13,924 DEBUG : BROWSER_OUTPUT: 03:30:13 INFO - 2016-01-14 03:30:13,927 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:30:13 INFO - 2016-01-14 03:30:13,927 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:30:13 INFO - 2016-01-14 03:30:13,927 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:30:13 INFO - 2016-01-14 03:30:13,928 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:30:13 INFO - 2016-01-14 03:30:13,928 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3319.9502007469887;3365.528825964364;3388.8983330500096;3392.050225936737;3421.9657803421965;5416.918746218805;5458.863528411792;5462.481064298895;5463.890722185554;5469.480399362059;5572.3870374258795;5582.218489411485;5582.358028826686;5587.273654424919;5594.076977298751;4968.105740966625;5056.721880296583;5057.03916255912;5072.289879416885;5139.691618502883;4984.053029924321;4999.700017998914;5072.67027643202;5087.79648814047;5145.279660847485;5103.285540024381;5167.560757335612;5178.352705911761;5182.4299327073995;5185.948140518603;5120.590352771769;5133.153029750087;5174.353205849269;5185.766640501187;5205.16717325228;4858.125537403266;4954.925676114861;4957.5786058185095;5055.69665820052;5065.341505604248;5410.5401040911565;5465.344158700942;5469.644473109275;5470;5478.671279723229;5763.308402991668;6060.636361818305;6064.636121832704;6064.757409703607;6068.33248342682;5816.854578635568;5972.074328479092;6074.179985701918;6080.30076541199;6100.542459315525;5666.348369937427;5676.574256930747;5679.318481782171;5688.857778555486;5696.857578560528;5870.178175055496;6085.604435711664;6143.38566143391;6143.416375444325;6148.538859585549;5855.677937713466;5912.320083190488;5913.940860591339;5925.703714814328;5958.970205148947;6012.338642749294;6092.268927728701;6118.235220597426;6131.816045518642;6132.846678833065;5748.367679555246;5860.355360910296;5902.173695682608;6073.605215660968;6081.695915204222;6004.249468816398;6040.456358927718;6066.181065556182;6078.331383547807;6106.358832322631;4637.814487420533;4674.485806561275;4674.813007479663;4676.392069031072;4694.788734506956;4055.858044968412;4154.1068670236045;4185.267578173807;4190.015346393595;4222;5606.411326810626;5676.205331253628;5681.176229446707;5701.0308247598;5702.8289151325525;6032.8793424132145;6035.6076855004285;6039.275286965592;6052.939470605325;6088.756449741961;5569;5668.546516278688;5745.109508026263;5750.827475175752;5751.827445176651;5141.2288156776785;5192.844214673566;5220.869478263074;5225.608079394061;5254.605904557174;6177.413145751147;6254.655993920287;6268.153799237136;6270.655113968775;6271.874562508724;5818.76724931015;5854.887571361428;6051.3948605140895;6103.23709536308;6116.26604807426;6206.286277078194;6207.379262073757;6211;6214.875702485834;6222.315545289924;5980.228348649339;5980.43185897339;5987.101934709828;5993.190919225849;6013.3685962975005;5716.771329146787;5823.94176058234;5969.73136208863;6051.122587224916;6067.120267561268;5918.852028699317;5920.615160014585;5950.851228719143;5956.374580668968;5957.76168953237;5951.404859514014;5954.225950626391;5954.523638109027;5957.702114894325;5963.4334738199805;5649.265595472562;5656.151577263443;5744.626599271034;5815.79644712433;5841.269841269841;5908.468237858613;5936.495397891055;5962;5962.642241465526;5996.010658241341;5478.890422191614;5832.3292821326095;5838.649681019152;5839.766409343749;5841.415858414124 03:30:13 INFO - 2016-01-14 03:30:13,931 DEBUG : BROWSER_OUTPUT: |1;ext.html;580.7909152705029;615.6306216270237;621.5183232994428;624.6127401011373;684.2439104789207;31483.685163148362;32018.039458816245;43053;43379.34930976038;43538.346924796155;46784;46822;46935.295970560466;47009.294860577116;47385.76307118468;7999.840003199933;9201.217896478807;9334.71995840126;9381.577828997677;9382.953085234565;8190.54951977641;10963.61627343043;11139.610113646024;11162;11226.15803814713;10960.725981850477;10980.725481862937;11049.779004419906;11053.723656908602;11057.834132488018;8084.717034903751;8224.588770561448;10909.890901091007;11023;11051.72370690731;10743.355398676105;10865.130789536817;10887;10888.782224355547;10896.18278629106;42857.785711071556;43478.130437391075;43722.56277437217;43753;43805.56194438079;3529.452934795085;3608.675219230282;3655.141041855162;3666.358387282215;4261.4460120184485;31186.532202016988;31473.527897081563;31484;31782.841085794655;32317.35365292681;3506.912327191815;3561.4123669594487;3640.508531348287;3812.275667623143;3900.4344370066183;299088;299889;302298.4425389361;302443;302449;65720.34279657238;66257.66871165614;66494;66768;69517.30482695108;62063;62704;62851;63072.36927630757;63236;16900.15499225034;17008.659826803396;17075;17077.316907323817;17099.658006840044;12785.232886026868;12888.742225155444;12894.67763305906;12901;13018.28399438021;22275.777242227694;22292.442688932908;22403.775962240168;22474.77525224727;22476.775232247794;8523.872141917876;8663.826723465621;8767.605457754416;8778.824423511494;8794.91205087941;1032.2464600841429;1112.7496313329598;1125.1617544929081;1153.7807816514835;1158.9130815188894;29134.27941595479;29626.815687136626;30582;30641.387172256877;30775.076747697603;1075.4945175767377;1081.1404933078222;1102.3330884814573;1170.0814860334597;1192.6720151958282;13677;15093.47172848945;15214;16288;17690;465471;468729;469577;469734;470968;58745;59457;59481.40518594759;59621.70189149113;59662.403375966554;1307.8495972963042;1351.216294549159;1354.2077884437715;1412.7598308287616;1416.7095745372173;30068.849655751583;30136.397272054874;30734;31020;31642.050738477883;45188.322175168054;45833.312500311855;46914;48195;49006.754966224944;256361;259810;260304;260340;260918;44217.77891110524;44855.77572112119;44902.10195796131;44945.55054449414;49362;51415.22877156921;51612;52321;52650.47349526609;52690.73654631702;42656.36015459709;42682;43215;43661.12677746491;47026.29460558163;41532.58467415287;42765.144697105265;42869;44063.33904991364;44300.33549496696;42803.785981069894;43251.78374108109;43534.346984795884;46886.531134688215;47570.762146189045;37304.813475932446;38574.80712596419;38779.224415510966;38987;39258.41112383259;28288.71711282861;28822.711772882;28840.849124490353;28934.42131157407;28959.565606515498 03:30:13 INFO - 2016-01-14 03:30:13,931 DEBUG : BROWSER_OUTPUT: |2;jquery.html;373.23300617231575;373.7553945361945;383.03093174269094;383.48804346197824;385.58742145903875;15070.547883563511;17151.228194731237;17782.911085444586;19340;19353.516162095955;17429.389971351004;17437.651246975052;17731.46805595831;17768.911155444235;17777.200025998827;4883.511648835106;4963.726995015273;4965.975170124144;4979.526944940225;4980.576650984671;3758.9060273493246;3836.731428799985;3837.846486140551;3839.808009599523;4934.407871055479;5503.504684578387;5671.035923892948;5674.404187560309;5677.6309539879985;5688.033034384164;5669.6314739541795;6127.356627554087;6139.907901381483;6164.66094364812;6174.135621013062;5405.459454054602;5496.697681627509;5496.890062198733;5500.50495455411;5511.366192887829;21418;21423.8928805355;21545.569088618297;22577.661335079985;22602.208922687627;2214.523877366374;2215.634420320645;2220.2340192633515;2229.7547269800307;2258.446680563256;11726.589569365116;13140;14337;14352.210628415432;14360.856391436057;1836.5225041489175;1856.1554492705786;1913.5311848597044;1924.220690620301;1956.5891162855817;64445.35554644441;65793.67103164454;66064.33935660678;66221.33778662248;66776;11054.22620416563;11077.390743509184;11084.390358530198;11093.38986355742;11116;14533.128012319296;14566.198859062853;14636.341364638616;14638.414463421344;14672.119672819665;8258.298044666271;8310;8352.373571982125;8398.832023359499;8409.03296120954;8158.796030099176;8193.180681931759;8211.507309561446;8244.711435099864;8281.751547453587;4712.340272361872;4774.7135171889795;4774.761261936889;4814.807407703723;4825.083234185494;1602.439146298786;1647.629283411247;1764.7705798246145;1877.727729479218;1975.9308424205371;875.4922145155922;958.5159494455255;965.4496936745987;996.1632228927735;1083.0198670203479;16487.752683709754;16490.34038638465;16800.495985120466;17038.74441883373;17156.828431715523;871.13322244366;942.2721222062091;998.116666749917;1006.8791744990648;1058.6929790360864;9573.425594464215;10024;10184.23618228621;10232;10415.323004004715;649786;651776;664900;669585;678421;85571.57214213889;86446.56776716076;86616.14141737418;88226.55886720525;88386;1181.8581770187461;1199.4182821331647;1199.4602428907026;1210.8002179640262;1228.1157566552067;15488.380464781734;15973.440929567409;16379.83620163783;16384.590385239986;16695;36152.09619759422;37419;37457;37727.62272377241;38387.424188636636;45137;46057;46608.766956165004;47000.529994700984;47108;9829.606815727291;10283.023112804272;10288.331258468175;10427.582896684047;10586.470676465991;11865.881341186478;11884.524619015488;13516.391762370913;18618.534536636693;18971.90514047421;14797.630059248175;15468.226588670746;15805.604859878595;15825.129617871127;16197.75703364427;14424.206668633326;14893.329800158803;15041.548753537412;15205.923970380078;15599;12263.816042759545;15444.382224711335;15450.60944514999;15881.285342159861;16013.199340033185;8637.179467950535;9202.447853128833;9294.070592940921;9437.858432123387;9928.354656947564;13268.601941941757;14695.3387097583;15040.247987600795;15116.244187790786;15318.463853765064 03:30:13 INFO - 2016-01-14 03:30:13,932 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1389.1665000999396;1526.7328217561924;1583.7624356346546;1783.2064731194616;1876.615293864757;6897.379235868771;7577.7726668199975;7918.524888506694;7922.009748781409;7922.128565857765;7679.500832445901;7967.44227904047;7975.401844861644;7978.601069946494;7979.441439099265;2331.9300420987356;2344.23812261015;2368.455255291284;2370.383700237933;2371.9169829055986;2335.7664233576675;2372.833901626887;2420.576399130145;2421.32202983165;2424.5393375258645;2299.908003679851;2317.582835089683;2320.5010922651627;2327.615943369342;2345.9882700586472;2289.1301305503966;2310.8151347892212;2322.303309007291;2332.673425720409;2336.649502574619;2341.7775311345395;2356.787889089973;2362.244081893795;2363.1138323128826;2364.550735360276;7792;7967;7967.920320796776;7968.960155199245;7972.521648701097;4722.220833562458;4731.29030645406;4755.571998520115;4772.16487114757;4798.184308667535;2980.806247593921;3021.879124835004;3027.137265879214;3031.045220755455;3104.58088158098;956.2541217850088;968.3124981263312;995.8605795188679;1007.5113569918584;1010.2524132142236;10491.055804977588;10499;10499.685009449653;10504.947475262576;10507.159427245879;4322;4350.891227719332;4368.104538569585;4396.648268138541;4404.4494438195225;9057.09429057089;9066.274698024143;9108.908910910806;9110.954445227731;9116;4762.714237145782;4764.95235047652;4767.356406885096;4785.928211076836;4795.256735206049;3877.515310586177;3948.0919388540797;4343.391925130484;4378.387025816388;4423.248047831877;3764.171882185915;3782.867599634;3801.163743976321;3843.0968722350226;3864.9806750966627;1228.8955438787625;1241.2304371289677;1243.6144795113544;1253.160382543698;1272.1413046193782;1134.9943250283695;1146.008702472372;1149.9827502587468;1366.2417358366004;1441.7981482592445;7511.661975211128;7607.619619019027;7637.236276372319;7657.46397752152;7663.080430348394;463.11776066593194;466.0864705177822;470.06222585941265;474.24358148753373;498.1108720933117;5968.343482216953;6006.189164462741;6011;6020.819375418744;6024.457798798129;9043.547822608843;9643.517824108767;9657.034296570428;9664.371815831948;9669.806603868024;9327.253819694544;9372.578233979488;9400.24798016157;9400.95299523498;9412.764680883032;7286.453515986216;7445.9255407445235;7514.887276690854;7516.285952834472;7611;7172.175199852084;7259.673314700745;7290.380317673057;7294.562326260441;7296.963515182602;8414;8474.872876906975;8611.569421529024;8664.306855451423;8687.478751274944;8521;8894.243989260727;8911.287097032351;8920.598573064357;8961.865572016295;5994.07091900756;6168.876622467616;6719.328067193242;7131;7167.104111986002;7700.229977002479;7710.8843367350655;7712.190220026816;7728.149903510722;7751.573663448565;7085.574865508086;7251.891221631785;7296.671649775667;7352.301531354513;7360.595167265852;7173;7198.820029499305;7245.166805817398;7273.563586184846;7279;7168.211496735459;7294.489385742947;7308.5614863108385;7323.890141647773;7334.376577990931;6735.158105236846;6761.425278851353;6766.898496522655;6770.289119642367;6779.72881084751;6364.459020983269;6624.138861947916;6663.000549917551;6716.865662686621;6718.496112791462 03:30:13 INFO - 2016-01-14 03:30:13,934 DEBUG : BROWSER_OUTPUT: |4;prototype.html;343.9105832483554;348.1157859038043;349.58748676561646;351.3394817742645;352.04595546070146;6047.516198704104;6061.151438798572;6085.908711369333;6086.847828804277;6106.419890110433;5798.855028624286;5851.912221316673;5958.731857066432;5988.191594134791;6038.788642397517;4675.994661147861;4685.039566888797;4690.061987602476;4694.507076756942;4721.126591580552;4447.911041779163;4692.991006933508;4698.812047518095;4709.2229782085915;4715.834945776898;4465.799039043234;4539.273716205408;4653.418322709661;4662.090892276007;4682.508336624656;4645.790939407735;4657.464391594959;4662.836800711959;4670.136024835382;4675.462321832999;4071.2875246831686;4096.180763847243;4103.466549348565;4108.958910410887;4110.897227569305;5651.943480565183;5713.914291285634;5744;5754.1944127822135;5770.884582308372;5332.733363331818;5343.038253114438;5343.545798607123;5344.893102137974;5346.545543628797;6319.778807741707;6396.616203027833;6408.90386644196;6410.519211059142;6417.03744438338;4388.188185185719;4391.01202229499;4391.560843915583;4397.2304846651705;4401.295792673157;6553.14809074822;6592.1100651411925;6624.73501059957;6655.234648015492;6662.93337066628;4532.637389008872;4534.614557762628;4537.2059889519205;4537.750423726727;4543.318502224693;4592.058627981322;4596.149712303235;4597.172508948354;4602.286645569875;4603.470600880874;5339.225812257201;5340.385855626575;5340.626156169031;5340.866478338073;5344.412114667383;6341.365863413622;6465.15952926126;6465.773697920645;6473.478732497859;6473.967630161913;1612.3067081154982;1623.1640705036916;1623.626565889852;1626.0406360247275;1626.8210496845338;1082.0477979378097;1093.5516438260274;1104.7845670094416;1117.7038084907506;1132.773445310941;6162;6165.414285642857;6165.475934545524;6170.753169873245;6178.6601736904;6469.094326794253;6653.9667301663185;6663.233728121328;6668;6673.766418175438;6244.12582238487;6254.2807577129215;6344.841378965562;6345.777897773556;6364.522660800459;3587.318409502186;3613.9819300903855;3628.092976755811;3628.2924829657964;3635.0730563706616;6779.288174741581;6901.654917254117;6902.068220790229;6914.135733033371;6915.343042410963;6889.931100689029;6892.689828957709;6893.551919125342;6894.379505844498;6894.586324820427;6900.171979362509;6904.551204171713;6906.551074180263;6908.6545672716165;6910.997905303703;6563.7702680405955;6691.966540167463;6695.096162018065;6702;6742.595444273359;6609.603423794588;6638.468922486286;6638.5684930479365;6647;6654.866902662016;6873.175218973555;6881.793546193622;6882.724691012303;6884.173899132136;6922.307769223037;4487.7980490877335;4635.884102897455;4640.582347588733;4647.95421030279;4648.814047438064;6674.566153200027;6677;6683.7660681875905;6684.16447944007;6692.59844409337;6498.220213574401;6508.186476690414;6510.544261901811;6510.804675859732;6513.609183449008;6359.554831161774;6494.253160886558;6501.382368674968;6508.088867558451;6509.698060388036;6368.108464815023;6386.329435409215;6387.073874288295;6392.52056095804;6393.264774550986;6477;6492.513061520499;6503.804885853432;6511.38141876521;6516;6308.369163083655;6332.145160403286;6346.587471814318;6349;6447.774327898501 03:30:13 INFO - 2016-01-14 03:30:13,934 DEBUG : BROWSER_OUTPUT: |5;yui.html;792.0455850699907;835.3776436554764;836.6444261188994;909.949008894726;962.191758922505;13363.799543006851;13722.794158087636;13729.382177801997;13744.931275343633;13778.655533611653;13082;13112.082154249207;13122;13144;13175.736485270289;761.702935855017;770.4606775257314;772.1236396689769;878.4421892098516;902.7246689759621;762.9389648828109;888.9199972002518;905.108468158863;905.302916754099;906.1165363770338;937.2408349237139;957.5403806173041;957.5978089202551;958.0228167269381;958.4728399380348;783.8941742864697;794.8688466403037;938.995305023474;947.1002547579792;947.2942657720008;692.9099217101794;698.9720411183547;702.0452185028357;702.4310308650009;702.6943279673308;13009.089363744542;13165.078444508888;13203.009774266968;13205.603831885059;13219.669508262274;12574.937125314407;12884.80672789909;13515.526956556474;13675.31623418835;13682;10031.849522257173;10177.338472999232;10329.690109296733;10425.165986721044;10670.51982660782;2784.540550809114;2823.50588646988;2861.7138286171426;2865.426914617064;2896.478633845907;48301.51698483005;48910;50238.7488062561;50448;50498.7475062626;10008.749781255527;10120.949395252977;10144.087032167141;10172.28793984414;10246.38521688701;19653.705194422095;19889.502762430766;19909.203631854853;19938;19959.301424450074;7700.730474433368;7718.382529397747;7721.8455630887065;7768;7790.961045194851;4350.151720414552;4359.1717573661535;4405.603495685404;4439.445069366329;4466.57567531084;3429.9314013719586;3453.671901169385;3457.8098204598487;3483.4252348362743;3484.790912545255;610.3438803286396;615.8952977993752;622.7384498510636;623.2738859229038;634.6033728919425;711.6263961420295;711.6797441151502;719.7085180501905;732.8900664900308;738.4978214813979;8552;8780.560971951378;9931.80136397268;10039.749006274902;10092.142167915663;583.0991118721586;679.188369897977;688.4182865478663;694.6110178300169;711.4664001998501;4028.778417187083;4108;4163.146554956226;4239.27932251518;4306.074194048295;54125.45874541204;57111.428885711444;57856.71071644615;57960.710196448745;58363.416365836645;48180.15265651281;48805;49498.75250623796;49987.50012499901;50161;47539.28691069637;47906.281405778944;47984.28023579649;48403.757981210576;49209.26186107211;9257.768555786159;9511.762205944906;9654.855177172207;9761.9023809761;10062.798744025225;36428.4535731959;36667.26665466729;36679;37553;37572.812135939144;47811.28283075826;48176;48235;49631.503684962685;50156;11098.500567474644;11646;12043.75912481728;12300.200486968319;12466.43901024438;13004.544840930523;13668;13686.178829270275;13715.451381944611;13905.652358691113;11783.882161178279;12096;12284.631461056182;12390.3185324808;12731.299778512272;12202.511899523919;12238.755224895274;12568.057395695543;12586.24482531051;13172;12004.579839705568;12078;12615.621531354074;12658.746825063263;12717.936410317889;10871;11005.284656497302;11035.503402347074;11056.668299951014;11334.149938754792;9992.15066719337;10205.183585313009;10241.283110182216;10269;10570.577176912837 03:30:13 INFO - 2016-01-14 03:30:13,934 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:30:13 INFO - 2016-01-14 03:30:13,934 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:30:13 INFO - 2016-01-14 03:30:13,934 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,763 03:30:13 INFO - 2016-01-14 03:30:13,934 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:30:13 INFO - 2016-01-14 03:30:13,934 DEBUG : BROWSER_OUTPUT: __startTimestamp1452771013925__endTimestamp 03:30:13 INFO - 2016-01-14 03:30:13,934 DEBUG : BROWSER_OUTPUT: 03:30:13 INFO - 2016-01-14 03:30:13,934 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:30:13 INFO - 2016-01-14 03:30:13,934 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:30:13 INFO - 2016-01-14 03:30:13,934 DEBUG : BROWSER_OUTPUT: 03:30:13 INFO - 2016-01-14 03:30:13,934 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5583.57 Median:5815.80 stddev:620.61 (10.7%) stddev-sans-first:596.56 03:30:13 INFO - 2016-01-14 03:30:13,936 DEBUG : BROWSER_OUTPUT: Values: 3320.0 3365.5 3388.9 3392.1 3422.0 5416.9 5458.9 5462.5 5463.9 5469.5 5572.4 5582.2 5582.4 5587.3 5594.1 4968.1 5056.7 5057.0 5072.3 5139.7 4984.1 4999.7 5072.7 5087.8 5145.3 5103.3 5167.6 5178.4 5182.4 5185.9 5120.6 5133.2 5174.4 5185.8 5205.2 4858.1 4954.9 4957.6 5055.7 5065.3 5410.5 5465.3 5469.6 5470.0 5478.7 5763.3 6060.6 6064.6 6064.8 6068.3 5816.9 5972.1 6074.2 6080.3 6100.5 5666.3 5676.6 5679.3 5688.9 5696.9 5870.2 6085.6 6143.4 6143.4 6148.5 5855.7 5912.3 5913.9 5925.7 5959.0 6012.3 6092.3 6118.2 6131.8 6132.8 5748.4 5860.4 5902.2 6073.6 6081.7 6004.2 6040.5 6066.2 6078.3 6106.4 4637.8 4674.5 4674.8 4676.4 4694.8 4055.9 4154.1 4185.3 4190.0 4222.0 5606.4 5676.2 5681.2 5701.0 5702.8 6032.9 6035.6 6039.3 6052.9 6088.8 5569.0 5668.5 5745.1 5750.8 5751.8 5141.2 5192.8 5220.9 5225.6 5254.6 6177.4 6254.7 6268.2 6270.7 6271.9 5818.8 5854.9 6051.4 6103.2 6116.3 6206.3 6207.4 6211.0 6214.9 6222.3 5980.2 5980.4 5987.1 5993.2 6013.4 5716.8 5823.9 5969.7 6051.1 6067.1 5918.9 5920.6 5950.9 5956.4 5957.8 5951.4 5954.2 5954.5 5957.7 5963.4 5649.3 5656.2 5744.6 5815.8 5841.3 5908.5 5936.5 5962.0 5962.6 5996.0 5478.9 5832.3 5838.6 5839.8 5841.4 03:30:13 INFO - 2016-01-14 03:30:13,936 DEBUG : BROWSER_OUTPUT: 03:30:13 INFO - 2016-01-14 03:30:13,936 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:53446.56 Median:20485.59 stddev:93438.47 (456.1%) stddev-sans-first:93616.28 03:30:13 INFO - 2016-01-14 03:30:13,936 DEBUG : BROWSER_OUTPUT: Values: 580.8 615.6 621.5 624.6 684.2 31483.7 32018.0 43053.0 43379.3 43538.3 46784.0 46822.0 46935.3 47009.3 47385.8 7999.8 9201.2 9334.7 9381.6 9383.0 8190.5 10963.6 11139.6 11162.0 11226.2 10960.7 10980.7 11049.8 11053.7 11057.8 8084.7 8224.6 10909.9 11023.0 11051.7 10743.4 10865.1 10887.0 10888.8 10896.2 42857.8 43478.1 43722.6 43753.0 43805.6 3529.5 3608.7 3655.1 3666.4 4261.4 31186.5 31473.5 31484.0 31782.8 32317.4 3506.9 3561.4 3640.5 3812.3 3900.4 299088.0 299889.0 302298.4 302443.0 302449.0 65720.3 66257.7 66494.0 66768.0 69517.3 62063.0 62704.0 62851.0 63072.4 63236.0 16900.2 17008.7 17075.0 17077.3 17099.7 12785.2 12888.7 12894.7 12901.0 13018.3 22275.8 22292.4 22403.8 22474.8 22476.8 8523.9 8663.8 8767.6 8778.8 8794.9 1032.2 1112.7 1125.2 1153.8 1158.9 29134.3 29626.8 30582.0 30641.4 30775.1 1075.5 1081.1 1102.3 1170.1 1192.7 13677.0 15093.5 15214.0 16288.0 17690.0 465471.0 468729.0 469577.0 469734.0 470968.0 58745.0 59457.0 59481.4 59621.7 59662.4 1307.8 1351.2 1354.2 1412.8 1416.7 30068.8 30136.4 30734.0 31020.0 31642.1 45188.3 45833.3 46914.0 48195.0 49006.8 256361.0 259810.0 260304.0 260340.0 260918.0 44217.8 44855.8 44902.1 44945.6 49362.0 51415.2 51612.0 52321.0 52650.5 52690.7 42656.4 42682.0 43215.0 43661.1 47026.3 41532.6 42765.1 42869.0 44063.3 44300.3 42803.8 43251.8 43534.3 46886.5 47570.8 37304.8 38574.8 38779.2 38987.0 39258.4 28288.7 28822.7 28840.8 28934.4 28959.6 03:30:13 INFO - 2016-01-14 03:30:13,936 DEBUG : BROWSER_OUTPUT: 03:30:13 INFO - 2016-01-14 03:30:13,936 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:33086.04 Median:2217.93 stddev:108254.11 (4880.9%) stddev-sans-first:108529.92 03:30:13 INFO - 2016-01-14 03:30:13,937 DEBUG : BROWSER_OUTPUT: Values: 373.2 373.8 383.0 383.5 385.6 15070.5 17151.2 17782.9 19340.0 19353.5 17429.4 17437.7 17731.5 17768.9 17777.2 4883.5 4963.7 4966.0 4979.5 4980.6 3758.9 3836.7 3837.8 3839.8 4934.4 5503.5 5671.0 5674.4 5677.6 5688.0 5669.6 6127.4 6139.9 6164.7 6174.1 5405.5 5496.7 5496.9 5500.5 5511.4 21418.0 21423.9 21545.6 22577.7 22602.2 2214.5 2215.6 2220.2 2229.8 2258.4 11726.6 13140.0 14337.0 14352.2 14360.9 1836.5 1856.2 1913.5 1924.2 1956.6 64445.4 65793.7 66064.3 66221.3 66776.0 11054.2 11077.4 11084.4 11093.4 11116.0 14533.1 14566.2 14636.3 14638.4 14672.1 8258.3 8310.0 8352.4 8398.8 8409.0 8158.8 8193.2 8211.5 8244.7 8281.8 4712.3 4774.7 4774.8 4814.8 4825.1 1602.4 1647.6 1764.8 1877.7 1975.9 875.5 958.5 965.4 996.2 1083.0 16487.8 16490.3 16800.5 17038.7 17156.8 871.1 942.3 998.1 1006.9 1058.7 9573.4 10024.0 10184.2 10232.0 10415.3 649786.0 651776.0 664900.0 669585.0 678421.0 85571.6 86446.6 86616.1 88226.6 88386.0 1181.9 1199.4 1199.5 1210.8 1228.1 15488.4 15973.4 16379.8 16384.6 16695.0 36152.1 37419.0 37457.0 37727.6 38387.4 45137.0 46057.0 46608.8 47000.5 47108.0 9829.6 10283.0 10288.3 10427.6 10586.5 11865.9 11884.5 13516.4 18618.5 18971.9 14797.6 15468.2 15805.6 15825.1 16197.8 14424.2 14893.3 15041.5 15205.9 15599.0 12263.8 15444.4 15450.6 15881.3 16013.2 8637.2 9202.4 9294.1 9437.9 9928.4 13268.6 14695.3 15040.2 15116.2 15318.5 03:30:13 INFO - 2016-01-14 03:30:13,937 DEBUG : BROWSER_OUTPUT: 03:30:13 INFO - 2016-01-14 03:30:13,937 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5543.99 Median:6643.57 stddev:2877.01 (43.3%) stddev-sans-first:2868.13 03:30:13 INFO - 2016-01-14 03:30:13,937 DEBUG : BROWSER_OUTPUT: Values: 1389.2 1526.7 1583.8 1783.2 1876.6 6897.4 7577.8 7918.5 7922.0 7922.1 7679.5 7967.4 7975.4 7978.6 7979.4 2331.9 2344.2 2368.5 2370.4 2371.9 2335.8 2372.8 2420.6 2421.3 2424.5 2299.9 2317.6 2320.5 2327.6 2346.0 2289.1 2310.8 2322.3 2332.7 2336.6 2341.8 2356.8 2362.2 2363.1 2364.6 7792.0 7967.0 7967.9 7969.0 7972.5 4722.2 4731.3 4755.6 4772.2 4798.2 2980.8 3021.9 3027.1 3031.0 3104.6 956.3 968.3 995.9 1007.5 1010.3 10491.1 10499.0 10499.7 10504.9 10507.2 4322.0 4350.9 4368.1 4396.6 4404.4 9057.1 9066.3 9108.9 9111.0 9116.0 4762.7 4765.0 4767.4 4785.9 4795.3 3877.5 3948.1 4343.4 4378.4 4423.2 3764.2 3782.9 3801.2 3843.1 3865.0 1228.9 1241.2 1243.6 1253.2 1272.1 1135.0 1146.0 1150.0 1366.2 1441.8 7511.7 7607.6 7637.2 7657.5 7663.1 463.1 466.1 470.1 474.2 498.1 5968.3 6006.2 6011.0 6020.8 6024.5 9043.5 9643.5 9657.0 9664.4 9669.8 9327.3 9372.6 9400.2 9401.0 9412.8 7286.5 7445.9 7514.9 7516.3 7611.0 7172.2 7259.7 7290.4 7294.6 7297.0 8414.0 8474.9 8611.6 8664.3 8687.5 8521.0 8894.2 8911.3 8920.6 8961.9 5994.1 6168.9 6719.3 7131.0 7167.1 7700.2 7710.9 7712.2 7728.1 7751.6 7085.6 7251.9 7296.7 7352.3 7360.6 7173.0 7198.8 7245.2 7273.6 7279.0 7168.2 7294.5 7308.6 7323.9 7334.4 6735.2 6761.4 6766.9 6770.3 6779.7 6364.5 6624.1 6663.0 6716.9 6718.5 03:30:13 INFO - 2016-01-14 03:30:13,938 DEBUG : BROWSER_OUTPUT: 03:30:13 INFO - 2016-01-14 03:30:13,938 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5397.55 Median:6163.71 stddev:1628.48 (26.4%) stddev-sans-first:1588.26 03:30:13 INFO - 2016-01-14 03:30:13,938 DEBUG : BROWSER_OUTPUT: Values: 343.9 348.1 349.6 351.3 352.0 6047.5 6061.2 6085.9 6086.8 6106.4 5798.9 5851.9 5958.7 5988.2 6038.8 4676.0 4685.0 4690.1 4694.5 4721.1 4447.9 4693.0 4698.8 4709.2 4715.8 4465.8 4539.3 4653.4 4662.1 4682.5 4645.8 4657.5 4662.8 4670.1 4675.5 4071.3 4096.2 4103.5 4109.0 4110.9 5651.9 5713.9 5744.0 5754.2 5770.9 5332.7 5343.0 5343.5 5344.9 5346.5 6319.8 6396.6 6408.9 6410.5 6417.0 4388.2 4391.0 4391.6 4397.2 4401.3 6553.1 6592.1 6624.7 6655.2 6662.9 4532.6 4534.6 4537.2 4537.8 4543.3 4592.1 4596.1 4597.2 4602.3 4603.5 5339.2 5340.4 5340.6 5340.9 5344.4 6341.4 6465.2 6465.8 6473.5 6474.0 1612.3 1623.2 1623.6 1626.0 1626.8 1082.0 1093.6 1104.8 1117.7 1132.8 6162.0 6165.4 6165.5 6170.8 6178.7 6469.1 6654.0 6663.2 6668.0 6673.8 6244.1 6254.3 6344.8 6345.8 6364.5 3587.3 3614.0 3628.1 3628.3 3635.1 6779.3 6901.7 6902.1 6914.1 6915.3 6889.9 6892.7 6893.6 6894.4 6894.6 6900.2 6904.6 6906.6 6908.7 6911.0 6563.8 6692.0 6695.1 6702.0 6742.6 6609.6 6638.5 6638.6 6647.0 6654.9 6873.2 6881.8 6882.7 6884.2 6922.3 4487.8 4635.9 4640.6 4648.0 4648.8 6674.6 6677.0 6683.8 6684.2 6692.6 6498.2 6508.2 6510.5 6510.8 6513.6 6359.6 6494.3 6501.4 6508.1 6509.7 6368.1 6386.3 6387.1 6392.5 6393.3 6477.0 6492.5 6503.8 6511.4 6516.0 6308.4 6332.1 6346.6 6349.0 6447.8 03:30:13 INFO - 2016-01-14 03:30:13,938 DEBUG : BROWSER_OUTPUT: 03:30:13 INFO - 2016-01-14 03:30:13,938 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14348.51 Median:4272.68 stddev:16257.49 (380.5%) stddev-sans-first:16271.22 03:30:13 INFO - 2016-01-14 03:30:13,939 DEBUG : BROWSER_OUTPUT: Values: 792.0 835.4 836.6 909.9 962.2 13363.8 13722.8 13729.4 13744.9 13778.7 13082.0 13112.1 13122.0 13144.0 13175.7 761.7 770.5 772.1 878.4 902.7 762.9 888.9 905.1 905.3 906.1 937.2 957.5 957.6 958.0 958.5 783.9 794.9 939.0 947.1 947.3 692.9 699.0 702.0 702.4 702.7 13009.1 13165.1 13203.0 13205.6 13219.7 12574.9 12884.8 13515.5 13675.3 13682.0 10031.8 10177.3 10329.7 10425.2 10670.5 2784.5 2823.5 2861.7 2865.4 2896.5 48301.5 48910.0 50238.7 50448.0 50498.7 10008.7 10120.9 10144.1 10172.3 10246.4 19653.7 19889.5 19909.2 19938.0 19959.3 7700.7 7718.4 7721.8 7768.0 7791.0 4350.2 4359.2 4405.6 4439.4 4466.6 3429.9 3453.7 3457.8 3483.4 3484.8 610.3 615.9 622.7 623.3 634.6 711.6 711.7 719.7 732.9 738.5 8552.0 8780.6 9931.8 10039.7 10092.1 583.1 679.2 688.4 694.6 711.5 4028.8 4108.0 4163.1 4239.3 4306.1 54125.5 57111.4 57856.7 57960.7 58363.4 48180.2 48805.0 49498.8 49987.5 50161.0 47539.3 47906.3 47984.3 48403.8 49209.3 9257.8 9511.8 9654.9 9761.9 10062.8 36428.5 36667.3 36679.0 37553.0 37572.8 47811.3 48176.0 48235.0 49631.5 50156.0 11098.5 11646.0 12043.8 12300.2 12466.4 13004.5 13668.0 13686.2 13715.5 13905.7 11783.9 12096.0 12284.6 12390.3 12731.3 12202.5 12238.8 12568.1 12586.2 13172.0 12004.6 12078.0 12615.6 12658.7 12717.9 10871.0 11005.3 11035.5 11056.7 11334.1 9992.2 10205.2 10241.3 10269.0 10570.6 03:30:13 INFO - 2016-01-14 03:30:13,939 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:30:13 INFO - 2016-01-14 03:30:13,939 DEBUG : BROWSER_OUTPUT: 03:30:14 INFO - 2016-01-14 03:30:14,643 INFO : Browser exited with error code: 0 03:30:14 INFO - 2016-01-14 03:30:14,659 INFO : Completed test dromaeo_css (00:18:31) 03:30:14 INFO - 2016-01-14 03:30:14,659 INFO : Starting test kraken 03:30:14 INFO - 2016-01-14 03:30:14,659 DEBUG : operating with platform_type : linux_ 03:30:14 INFO - 2016-01-14 03:30:14,659 INFO : Initialising browser for kraken test... 03:30:14 INFO - 2016-01-14 03:30:14,665 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAxn4Lu/profile http://localhost:39957/getInfo.html 03:30:18 INFO - 2016-01-14 03:30:18,549 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:30:18 INFO - 2016-01-14 03:30:18,549 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:30:18 INFO - 2016-01-14 03:30:18,549 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:30:18 INFO - 2016-01-14 03:30:18,549 DEBUG : BROWSER_OUTPUT: __metrics 03:30:18 INFO - 2016-01-14 03:30:18,694 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:30:19 INFO - 2016-01-14 03:30:19,834 INFO : Browser initialized. 03:30:19 INFO - 2016-01-14 03:30:19,835 INFO : Running cycle 1/1 for kraken test... 03:30:19 INFO - 2016-01-14 03:30:19,835 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAxn4Lu/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:30:31 INFO - 2016-01-14 03:30:31,649 DEBUG : BROWSER_OUTPUT: RSS: Main: 136695808 03:30:31 INFO - 2016-01-14 03:30:31,650 DEBUG : BROWSER_OUTPUT: 03:30:34 INFO - 2016-01-14 03:30:34,110 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39957/tests/kraken/driver.html?testName=audio-beat-detection) 03:30:34 INFO - 2016-01-14 03:30:34,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 167710720 03:30:34 INFO - 2016-01-14 03:30:34,692 DEBUG : BROWSER_OUTPUT: 03:30:37 INFO - 2016-01-14 03:30:37,288 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39957/tests/kraken/driver.html?testName=audio-dft) 03:30:37 INFO - 2016-01-14 03:30:37,854 DEBUG : BROWSER_OUTPUT: RSS: Main: 167833600 03:30:37 INFO - 2016-01-14 03:30:37,854 DEBUG : BROWSER_OUTPUT: 03:30:40 INFO - 2016-01-14 03:30:40,653 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39957/tests/kraken/driver.html?testName=audio-fft) 03:30:41 INFO - 2016-01-14 03:30:41,219 DEBUG : BROWSER_OUTPUT: RSS: Main: 165556224 03:30:41 INFO - 2016-01-14 03:30:41,220 DEBUG : BROWSER_OUTPUT: 03:30:43 INFO - 2016-01-14 03:30:43,237 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39957/tests/kraken/driver.html?testName=audio-oscillator) 03:30:43 INFO - 2016-01-14 03:30:43,802 DEBUG : BROWSER_OUTPUT: RSS: Main: 164904960 03:30:43 INFO - 2016-01-14 03:30:43,803 DEBUG : BROWSER_OUTPUT: 03:30:45 INFO - 2016-01-14 03:30:45,997 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39957/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:30:46 INFO - 2016-01-14 03:30:46,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 163115008 03:30:46 INFO - 2016-01-14 03:30:46,551 DEBUG : BROWSER_OUTPUT: 03:30:49 INFO - 2016-01-14 03:30:49,414 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39957/tests/kraken/driver.html?testName=imaging-darkroom) 03:30:49 INFO - 2016-01-14 03:30:49,980 DEBUG : BROWSER_OUTPUT: RSS: Main: 163954688 03:30:49 INFO - 2016-01-14 03:30:49,980 DEBUG : BROWSER_OUTPUT: 03:30:53 INFO - 2016-01-14 03:30:53,334 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39957/tests/kraken/driver.html?testName=imaging-desaturate) 03:30:53 INFO - 2016-01-14 03:30:53,901 DEBUG : BROWSER_OUTPUT: RSS: Main: 163450880 03:30:53 INFO - 2016-01-14 03:30:53,901 DEBUG : BROWSER_OUTPUT: 03:30:56 INFO - 2016-01-14 03:30:56,624 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39957/tests/kraken/driver.html?testName=json-parse-financial) 03:30:57 INFO - 2016-01-14 03:30:57,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 163831808 03:30:57 INFO - 2016-01-14 03:30:57,199 DEBUG : BROWSER_OUTPUT: 03:30:58 INFO - 2016-01-14 03:30:58,747 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39957/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:30:59 INFO - 2016-01-14 03:30:59,309 DEBUG : BROWSER_OUTPUT: RSS: Main: 168783872 03:30:59 INFO - 2016-01-14 03:30:59,309 DEBUG : BROWSER_OUTPUT: 03:31:01 INFO - 2016-01-14 03:31:01,071 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39957/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:31:01 INFO - 2016-01-14 03:31:01,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 166850560 03:31:01 INFO - 2016-01-14 03:31:01,666 DEBUG : BROWSER_OUTPUT: 03:31:03 INFO - 2016-01-14 03:31:03,661 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39957/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:31:04 INFO - 2016-01-14 03:31:04,242 DEBUG : BROWSER_OUTPUT: RSS: Main: 174788608 03:31:04 INFO - 2016-01-14 03:31:04,243 DEBUG : BROWSER_OUTPUT: 03:31:06 INFO - 2016-01-14 03:31:06,589 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39957/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:31:07 INFO - 2016-01-14 03:31:07,171 DEBUG : BROWSER_OUTPUT: RSS: Main: 181600256 03:31:07 INFO - 2016-01-14 03:31:07,172 DEBUG : BROWSER_OUTPUT: 03:31:09 INFO - 2016-01-14 03:31:09,675 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39957/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:31:10 INFO - 2016-01-14 03:31:10,243 DEBUG : BROWSER_OUTPUT: RSS: Main: 178196480 03:31:10 INFO - 2016-01-14 03:31:10,243 DEBUG : BROWSER_OUTPUT: 03:31:11 INFO - 2016-01-14 03:31:11,914 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39957/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39957/tests/kraken/driver.html?testName=ai-astar) 03:31:12 INFO - 2016-01-14 03:31:12,165 DEBUG : BROWSER_OUTPUT: RSS: Main: 237015040 03:31:12 INFO - 2016-01-14 03:31:12,165 DEBUG : BROWSER_OUTPUT: 03:31:12 INFO - 2016-01-14 03:31:12,168 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:31:12 INFO - 2016-01-14 03:31:12,168 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:31:12 INFO - 2016-01-14 03:31:12,169 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:31:12 INFO - 2016-01-14 03:31:12,169 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:31:12 INFO - 2016-01-14 03:31:12,169 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;108;103;107;109;109;99;108;109;108 03:31:12 INFO - 2016-01-14 03:31:12,169 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;122;145;160;125;152;153;124;167;122 03:31:12 INFO - 2016-01-14 03:31:12,169 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;167;162;162;161;161;161;163;161;161 03:31:12 INFO - 2016-01-14 03:31:12,169 DEBUG : BROWSER_OUTPUT: |3;audio-fft;77;72;73;161;70;73;71;71;157;71 03:31:12 INFO - 2016-01-14 03:31:12,169 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;93;137;92;94;93;144;92;93;136 03:31:12 INFO - 2016-01-14 03:31:12,169 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;109;109 03:31:12 INFO - 2016-01-14 03:31:12,170 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;145;146;145;146;146;146;146;145 03:31:12 INFO - 2016-01-14 03:31:12,170 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;95;95;95;96;95;96 03:31:12 INFO - 2016-01-14 03:31:12,170 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;57;57;56;57;58;58;56;56;55 03:31:12 INFO - 2016-01-14 03:31:12,170 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;65;64;64;64;64;65;64;64;64 03:31:12 INFO - 2016-01-14 03:31:12,170 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;79;80;88;81;80;80;82;81;80;89 03:31:12 INFO - 2016-01-14 03:31:12,170 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;117;112;116;126;113;110;111;120;114 03:31:12 INFO - 2016-01-14 03:31:12,170 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;152;141;139;141;143;140;143;141;156;131 03:31:12 INFO - 2016-01-14 03:31:12,171 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;66;67;67;64;65;66;63;65;64 03:31:12 INFO - 2016-01-14 03:31:12,171 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:31:12 INFO - 2016-01-14 03:31:12,171 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:31:12 INFO - 2016-01-14 03:31:12,171 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,900 03:31:12 INFO - 2016-01-14 03:31:12,171 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:31:12 INFO - 2016-01-14 03:31:12,171 DEBUG : BROWSER_OUTPUT: __startTimestamp1452771072166__endTimestamp 03:31:12 INFO - 2016-01-14 03:31:12,171 DEBUG : BROWSER_OUTPUT: 03:31:12 INFO - 2016-01-14 03:31:12,175 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:31:12 INFO - 2016-01-14 03:31:12,175 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:31:12 INFO - 2016-01-14 03:31:12,175 DEBUG : BROWSER_OUTPUT: 03:31:12 INFO - 2016-01-14 03:31:12,175 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.80 Median:108.50 stddev:3.26 (3.0%) stddev-sans-first:3.43 03:31:12 INFO - 2016-01-14 03:31:12,176 DEBUG : BROWSER_OUTPUT: Values: 108.0 108.0 103.0 107.0 109.0 109.0 99.0 108.0 109.0 108.0 03:31:12 INFO - 2016-01-14 03:31:12,176 DEBUG : BROWSER_OUTPUT: 03:31:12 INFO - 2016-01-14 03:31:12,176 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.80 Median:150.00 stddev:17.09 (11.4%) stddev-sans-first:17.98 03:31:12 INFO - 2016-01-14 03:31:12,176 DEBUG : BROWSER_OUTPUT: Values: 148.0 122.0 145.0 160.0 125.0 152.0 153.0 124.0 167.0 122.0 03:31:12 INFO - 2016-01-14 03:31:12,176 DEBUG : BROWSER_OUTPUT: 03:31:12 INFO - 2016-01-14 03:31:12,176 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.00 Median:161.50 stddev:1.89 (1.2%) stddev-sans-first:1.96 03:31:12 INFO - 2016-01-14 03:31:12,176 DEBUG : BROWSER_OUTPUT: Values: 161.0 167.0 162.0 162.0 161.0 161.0 161.0 163.0 161.0 161.0 03:31:12 INFO - 2016-01-14 03:31:12,177 DEBUG : BROWSER_OUTPUT: 03:31:12 INFO - 2016-01-14 03:31:12,177 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.60 Median:71.50 stddev:36.64 (51.2%) stddev-sans-first:38.58 03:31:12 INFO - 2016-01-14 03:31:12,177 DEBUG : BROWSER_OUTPUT: Values: 77.0 72.0 73.0 161.0 70.0 73.0 71.0 71.0 157.0 71.0 03:31:12 INFO - 2016-01-14 03:31:12,177 DEBUG : BROWSER_OUTPUT: 03:31:12 INFO - 2016-01-14 03:31:12,177 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.80 Median:93.00 stddev:22.32 (24.0%) stddev-sans-first:23.19 03:31:12 INFO - 2016-01-14 03:31:12,178 DEBUG : BROWSER_OUTPUT: Values: 94.0 93.0 137.0 92.0 94.0 93.0 144.0 92.0 93.0 136.0 03:31:12 INFO - 2016-01-14 03:31:12,178 DEBUG : BROWSER_OUTPUT: 03:31:12 INFO - 2016-01-14 03:31:12,178 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 03:31:12 INFO - 2016-01-14 03:31:12,178 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 03:31:12 INFO - 2016-01-14 03:31:12,178 DEBUG : BROWSER_OUTPUT: 03:31:12 INFO - 2016-01-14 03:31:12,178 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 03:31:12 INFO - 2016-01-14 03:31:12,179 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 145.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 03:31:12 INFO - 2016-01-14 03:31:12,179 DEBUG : BROWSER_OUTPUT: 03:31:12 INFO - 2016-01-14 03:31:12,179 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 03:31:12 INFO - 2016-01-14 03:31:12,179 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 03:31:12 INFO - 2016-01-14 03:31:12,179 DEBUG : BROWSER_OUTPUT: 03:31:12 INFO - 2016-01-14 03:31:12,179 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.60 Median:57.00 stddev:0.97 (1.7%) stddev-sans-first:1.00 03:31:12 INFO - 2016-01-14 03:31:12,179 DEBUG : BROWSER_OUTPUT: Values: 56.0 57.0 57.0 56.0 57.0 58.0 58.0 56.0 56.0 55.0 03:31:12 INFO - 2016-01-14 03:31:12,180 DEBUG : BROWSER_OUTPUT: 03:31:12 INFO - 2016-01-14 03:31:12,180 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 03:31:12 INFO - 2016-01-14 03:31:12,180 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 64.0 64.0 64.0 64.0 65.0 64.0 64.0 64.0 03:31:12 INFO - 2016-01-14 03:31:12,180 DEBUG : BROWSER_OUTPUT: 03:31:12 INFO - 2016-01-14 03:31:12,180 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:81.00 stddev:3.53 (4.4%) stddev-sans-first:3.57 03:31:12 INFO - 2016-01-14 03:31:12,180 DEBUG : BROWSER_OUTPUT: Values: 79.0 80.0 88.0 81.0 80.0 80.0 82.0 81.0 80.0 89.0 03:31:12 INFO - 2016-01-14 03:31:12,180 DEBUG : BROWSER_OUTPUT: 03:31:12 INFO - 2016-01-14 03:31:12,180 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:115.50 Median:116.00 stddev:4.77 (4.1%) stddev-sans-first:5.05 03:31:12 INFO - 2016-01-14 03:31:12,181 DEBUG : BROWSER_OUTPUT: Values: 116.0 117.0 112.0 116.0 126.0 113.0 110.0 111.0 120.0 114.0 03:31:12 INFO - 2016-01-14 03:31:12,181 DEBUG : BROWSER_OUTPUT: 03:31:12 INFO - 2016-01-14 03:31:12,181 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.70 Median:142.00 stddev:6.91 (4.9%) stddev-sans-first:6.46 03:31:12 INFO - 2016-01-14 03:31:12,181 DEBUG : BROWSER_OUTPUT: Values: 152.0 141.0 139.0 141.0 143.0 140.0 143.0 141.0 156.0 131.0 03:31:12 INFO - 2016-01-14 03:31:12,181 DEBUG : BROWSER_OUTPUT: 03:31:12 INFO - 2016-01-14 03:31:12,181 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.50 stddev:1.37 (2.1%) stddev-sans-first:1.39 03:31:12 INFO - 2016-01-14 03:31:12,181 DEBUG : BROWSER_OUTPUT: Values: 64.0 66.0 67.0 67.0 64.0 65.0 66.0 63.0 65.0 64.0 03:31:12 INFO - 2016-01-14 03:31:12,182 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:31:12 INFO - 2016-01-14 03:31:12,182 DEBUG : BROWSER_OUTPUT: 03:31:13 INFO - 2016-01-14 03:31:13,039 INFO : Browser exited with error code: 0 03:31:13 INFO - 2016-01-14 03:31:13,092 INFO : Completed test kraken (00:00:58) 03:31:13 INFO - 2016-01-14 03:31:13,093 INFO : Starting test v8_7 03:31:13 INFO - 2016-01-14 03:31:13,093 DEBUG : operating with platform_type : linux_ 03:31:13 INFO - 2016-01-14 03:31:13,093 INFO : Initialising browser for v8_7 test... 03:31:13 INFO - 2016-01-14 03:31:13,099 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEubQ94/profile http://localhost:39957/getInfo.html 03:31:17 INFO - 2016-01-14 03:31:17,141 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:31:17 INFO - 2016-01-14 03:31:17,141 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:31:17 INFO - 2016-01-14 03:31:17,141 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:31:17 INFO - 2016-01-14 03:31:17,142 DEBUG : BROWSER_OUTPUT: __metrics 03:31:17 INFO - 2016-01-14 03:31:17,323 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:31:18 INFO - 2016-01-14 03:31:18,418 INFO : Browser initialized. 03:31:18 INFO - 2016-01-14 03:31:18,419 INFO : Running cycle 1/1 for v8_7 test... 03:31:18 INFO - 2016-01-14 03:31:18,419 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEubQ94/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:31:30 INFO - 2016-01-14 03:31:30,205 DEBUG : BROWSER_OUTPUT: RSS: Main: 136704000 03:31:30 INFO - 2016-01-14 03:31:30,205 DEBUG : BROWSER_OUTPUT: 03:31:51 INFO - 2016-01-14 03:31:51,543 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39957/tests/v8_7/run.html (next: http://localhost:39957/tests/v8_7/run.html) 03:31:51 INFO - 2016-01-14 03:31:51,802 DEBUG : BROWSER_OUTPUT: RSS: Main: 425979904 03:31:51 INFO - 2016-01-14 03:31:51,802 DEBUG : BROWSER_OUTPUT: 03:31:51 INFO - 2016-01-14 03:31:51,802 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:31:51 INFO - 2016-01-14 03:31:51,802 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:31:51 INFO - 2016-01-14 03:31:51,803 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:31:51 INFO - 2016-01-14 03:31:51,803 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:31:51 INFO - 2016-01-14 03:31:51,803 DEBUG : BROWSER_OUTPUT: |0;Richards;166.80567139282735 03:31:51 INFO - 2016-01-14 03:31:51,803 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;173.25017325017325 03:31:51 INFO - 2016-01-14 03:31:51,803 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.2516056967328 03:31:51 INFO - 2016-01-14 03:31:51,803 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5112.244897959184 03:31:51 INFO - 2016-01-14 03:31:51,803 DEBUG : BROWSER_OUTPUT: |4;RayTrace;952.3809523809524 03:31:51 INFO - 2016-01-14 03:31:51,804 DEBUG : BROWSER_OUTPUT: |5;Earley;558.659217877095 03:31:51 INFO - 2016-01-14 03:31:51,804 DEBUG : BROWSER_OUTPUT: |6;Boyer;11133.333333333334 03:31:51 INFO - 2016-01-14 03:31:51,804 DEBUG : BROWSER_OUTPUT: |7;RegExp;24047.619047619046 03:31:51 INFO - 2016-01-14 03:31:51,804 DEBUG : BROWSER_OUTPUT: |8;Splay;526.592943654555 03:31:51 INFO - 2016-01-14 03:31:51,804 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 03:31:51 INFO - 2016-01-14 03:31:51,804 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:31:51 INFO - 2016-01-14 03:31:51,804 DEBUG : BROWSER_OUTPUT: __startTimestamp1452771111795__endTimestamp 03:31:51 INFO - 2016-01-14 03:31:51,804 DEBUG : BROWSER_OUTPUT: 03:31:51 INFO - 2016-01-14 03:31:51,805 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:31:51 INFO - 2016-01-14 03:31:51,805 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:31:51 INFO - 2016-01-14 03:31:51,805 DEBUG : BROWSER_OUTPUT: 03:31:51 INFO - 2016-01-14 03:31:51,805 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.81 Median:166.81 stddev:0.00 (0.0%) 03:31:51 INFO - 2016-01-14 03:31:51,805 DEBUG : BROWSER_OUTPUT: Values: 166.8 03:31:51 INFO - 2016-01-14 03:31:51,805 DEBUG : BROWSER_OUTPUT: 03:31:51 INFO - 2016-01-14 03:31:51,805 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:173.25 Median:173.25 stddev:0.00 (0.0%) 03:31:51 INFO - 2016-01-14 03:31:51,806 DEBUG : BROWSER_OUTPUT: Values: 173.3 03:31:51 INFO - 2016-01-14 03:31:51,806 DEBUG : BROWSER_OUTPUT: 03:31:51 INFO - 2016-01-14 03:31:51,806 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 03:31:51 INFO - 2016-01-14 03:31:51,806 DEBUG : BROWSER_OUTPUT: Values: 279.3 03:31:51 INFO - 2016-01-14 03:31:51,806 DEBUG : BROWSER_OUTPUT: 03:31:51 INFO - 2016-01-14 03:31:51,806 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5112.24 Median:5112.24 stddev:0.00 (0.0%) 03:31:51 INFO - 2016-01-14 03:31:51,806 DEBUG : BROWSER_OUTPUT: Values: 5112.2 03:31:51 INFO - 2016-01-14 03:31:51,806 DEBUG : BROWSER_OUTPUT: 03:31:51 INFO - 2016-01-14 03:31:51,807 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:952.38 Median:952.38 stddev:0.00 (0.0%) 03:31:51 INFO - 2016-01-14 03:31:51,807 DEBUG : BROWSER_OUTPUT: Values: 952.4 03:31:51 INFO - 2016-01-14 03:31:51,807 DEBUG : BROWSER_OUTPUT: 03:31:51 INFO - 2016-01-14 03:31:51,807 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:558.66 Median:558.66 stddev:0.00 (0.0%) 03:31:51 INFO - 2016-01-14 03:31:51,807 DEBUG : BROWSER_OUTPUT: Values: 558.7 03:31:51 INFO - 2016-01-14 03:31:51,807 DEBUG : BROWSER_OUTPUT: 03:31:51 INFO - 2016-01-14 03:31:51,807 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11133.33 Median:11133.33 stddev:0.00 (0.0%) 03:31:51 INFO - 2016-01-14 03:31:51,808 DEBUG : BROWSER_OUTPUT: Values: 11133.3 03:31:51 INFO - 2016-01-14 03:31:51,808 DEBUG : BROWSER_OUTPUT: 03:31:51 INFO - 2016-01-14 03:31:51,808 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24047.62 Median:24047.62 stddev:0.00 (0.0%) 03:31:51 INFO - 2016-01-14 03:31:51,808 DEBUG : BROWSER_OUTPUT: Values: 24047.6 03:31:51 INFO - 2016-01-14 03:31:51,808 DEBUG : BROWSER_OUTPUT: 03:31:51 INFO - 2016-01-14 03:31:51,808 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:526.59 Median:526.59 stddev:0.00 (0.0%) 03:31:51 INFO - 2016-01-14 03:31:51,808 DEBUG : BROWSER_OUTPUT: Values: 526.6 03:31:51 INFO - 2016-01-14 03:31:51,808 DEBUG : BROWSER_OUTPUT: 03:31:51 INFO - 2016-01-14 03:31:51,809 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 03:31:51 INFO - 2016-01-14 03:31:51,809 DEBUG : BROWSER_OUTPUT: Values: 4822.1 03:31:51 INFO - 2016-01-14 03:31:51,809 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:31:51 INFO - 2016-01-14 03:31:51,809 DEBUG : BROWSER_OUTPUT: 03:31:52 INFO - 2016-01-14 03:31:52,635 INFO : Browser exited with error code: 0 03:31:52 INFO - 2016-01-14 03:31:52,647 INFO : Completed test v8_7 (00:00:39) 03:31:52 INFO - 2016-01-14 03:31:52,830 INFO : Completed test suite (00:20:09) 03:31:52 INFO - 2016-01-14 03:31:52,830 DEBUG : Working with test: dromaeo_css 03:31:52 INFO - 2016-01-14 03:31:52,830 DEBUG : Generating results file: dromaeo_css 03:31:52 INFO - 2016-01-14 03:31:52,832 DEBUG : Working with test: kraken 03:31:52 INFO - 2016-01-14 03:31:52,832 DEBUG : Generating results file: kraken 03:31:52 INFO - 2016-01-14 03:31:52,832 INFO : javascript benchmark 03:31:52 INFO - 2016-01-14 03:31:52,832 DEBUG : Working with test: v8_7 03:31:52 INFO - 2016-01-14 03:31:52,832 DEBUG : Generating results file: v8_7 03:31:52 INFO - 2016-01-14 03:31:52,833 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:31:52 INFO - 2016-01-14 03:31:52,908 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 03:31:52 INFO - 2016-01-14 03:31:52,908 DEBUG : process_Request line: dromaeo_css 7331.73 graph.html#tests=[[72,52,35]] 03:31:52 INFO - 2016-01-14 03:31:52,908 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:31:52 INFO - 2016-01-14 03:31:52,938 DEBUG : process_Request line: kraken 1483.20 graph.html#tests=[[232,52,35]] 03:31:52 INFO - 2016-01-14 03:31:52,938 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:31:52 INFO - 2016-01-14 03:31:52,976 DEBUG : process_Request line: v8_7 23015.25 graph.html#tests=[[230,52,35]] 03:31:52 INFO - 2016-01-14 03:31:52,977 INFO : javascript benchmark 03:31:53 INFO - 2016-01-14 03:31:52,981 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3319.9502007469887, 3365.528825964364, 3388.8983330500096, 3392.050225936737, 3421.9657803421965, 5416.918746218805, 5458.863528411792, 5462.481064298895, 5463.890722185554, 5469.480399362059, 5572.3870374258795, 5582.218489411485, 5582.358028826686, 5587.273654424919, 5594.076977298751, 4968.105740966625, 5056.721880296583, 5057.03916255912, 5072.289879416885, 5139.691618502883, 4984.053029924321, 4999.700017998914, 5072.67027643202, 5087.79648814047, 5145.279660847485, 5103.285540024381, 5167.560757335612, 5178.352705911761, 5182.4299327073995, 5185.948140518603, 5120.590352771769, 5133.153029750087, 5174.353205849269, 5185.766640501187, 5205.16717325228, 4858.125537403266, 4954.925676114861, 4957.5786058185095, 5055.69665820052, 5065.341505604248, 5410.5401040911565, 5465.344158700942, 5469.644473109275, 5470.0, 5478.671279723229, 5763.308402991668, 6060.636361818305, 6064.636121832704, 6064.757409703607, 6068.33248342682, 5816.854578635568, 5972.074328479092, 6074.179985701918, 6080.30076541199, 6100.542459315525, 5666.348369937427, 5676.574256930747, 5679.318481782171, 5688.857778555486, 5696.857578560528, 5870.178175055496, 6085.604435711664, 6143.38566143391, 6143.416375444325, 6148.538859585549, 5855.677937713466, 5912.320083190488, 5913.940860591339, 5925.703714814328, 5958.970205148947, 6012.338642749294, 6092.268927728701, 6118.235220597426, 6131.816045518642, 6132.846678833065, 5748.367679555246, 5860.355360910296, 5902.173695682608, 6073.605215660968, 6081.695915204222, 6004.249468816398, 6040.456358927718, 6066.181065556182, 6078.331383547807, 6106.358832322631, 4637.814487420533, 4674.485806561275, 4674.813007479663, 4676.392069031072, 4694.788734506956, 4055.858044968412, 4154.1068670236045, 4185.267578173807, 4190.015346393595, 4222.0, 5606.411326810626, 5676.205331253628, 5681.176229446707, 5701.0308247598, 5702.8289151325525, 6032.8793424132145, 6035.6076855004285, 6039.275286965592, 6052.939470605325, 6088.756449741961, 5569.0, 5668.546516278688, 5745.109508026263, 5750.827475175752, 5751.827445176651, 5141.2288156776785, 5192.844214673566, 5220.869478263074, 5225.608079394061, 5254.605904557174, 6177.413145751147, 6254.655993920287, 6268.153799237136, 6270.655113968775, 6271.874562508724, 5818.76724931015, 5854.887571361428, 6051.3948605140895, 6103.23709536308, 6116.26604807426, 6206.286277078194, 6207.379262073757, 6211.0, 6214.875702485834, 6222.315545289924, 5980.228348649339, 5980.43185897339, 5987.101934709828, 5993.190919225849, 6013.3685962975005, 5716.771329146787, 5823.94176058234, 5969.73136208863, 6051.122587224916, 6067.120267561268, 5918.852028699317, 5920.615160014585, 5950.851228719143, 5956.374580668968, 5957.76168953237, 5951.404859514014, 5954.225950626391, 5954.523638109027, 5957.702114894325, 5963.4334738199805, 5649.265595472562, 5656.151577263443, 5744.626599271034, 5815.79644712433, 5841.269841269841, 5908.468237858613, 5936.495397891055, 5962.0, 5962.642241465526, 5996.010658241341, 5478.890422191614, 5832.3292821326095, 5838.649681019152, 5839.766409343749, 5841.415858414124], "unit": "ms", "name": "dojo.html", "value": 5543.64687577473}, {"lowerIsBetter": false, "replicates": [580.7909152705029, 615.6306216270237, 621.5183232994428, 624.6127401011373, 684.2439104789207, 31483.685163148362, 32018.039458816245, 43053.0, 43379.34930976038, 43538.346924796155, 46784.0, 46822.0, 46935.295970560466, 47009.294860577116, 47385.76307118468, 7999.840003199933, 9201.217896478807, 9334.71995840126, 9381.577828997677, 9382.953085234565, 8190.54951977641, 10963.61627343043, 11139.610113646024, 11162.0, 11226.15803814713, 10960.725981850477, 10980.725481862937, 11049.779004419906, 11053.723656908602, 11057.834132488018, 8084.717034903751, 8224.588770561448, 10909.890901091007, 11023.0, 11051.72370690731, 10743.355398676105, 10865.130789536817, 10887.0, 10888.782224355547, 10896.18278629106, 42857.785711071556, 43478.130437391075, 43722.56277437217, 43753.0, 43805.56194438079, 3529.452934795085, 3608.675219230282, 3655.141041855162, 3666.358387282215, 4261.4460120184485, 31186.532202016988, 31473.527897081563, 31484.0, 31782.841085794655, 32317.35365292681, 3506.912327191815, 3561.4123669594487, 3640.508531348287, 3812.275667623143, 3900.4344370066183, 299088.0, 299889.0, 302298.4425389361, 302443.0, 302449.0, 65720.34279657238, 66257.66871165614, 66494.0, 66768.0, 69517.30482695108, 62063.0, 62704.0, 62851.0, 63072.36927630757, 63236.0, 16900.15499225034, 17008.659826803396, 17075.0, 17077.316907323817, 17099.658006840044, 12785.232886026868, 12888.742225155444, 12894.67763305906, 12901.0, 13018.28399438021, 22275.777242227694, 22292.442688932908, 22403.775962240168, 22474.77525224727, 22476.775232247794, 8523.872141917876, 8663.826723465621, 8767.605457754416, 8778.824423511494, 8794.91205087941, 1032.2464600841429, 1112.7496313329598, 1125.1617544929081, 1153.7807816514835, 1158.9130815188894, 29134.27941595479, 29626.815687136626, 30582.0, 30641.387172256877, 30775.076747697603, 1075.4945175767377, 1081.1404933078222, 1102.3330884814573, 1170.0814860334597, 1192.6720151958282, 13677.0, 15093.47172848945, 15214.0, 16288.0, 17690.0, 465471.0, 468729.0, 469577.0, 469734.0, 470968.0, 58745.0, 59457.0, 59481.40518594759, 59621.70189149113, 59662.403375966554, 1307.8495972963042, 1351.216294549159, 1354.2077884437715, 1412.7598308287616, 1416.7095745372173, 30068.849655751583, 30136.397272054874, 30734.0, 31020.0, 31642.050738477883, 45188.322175168054, 45833.312500311855, 46914.0, 48195.0, 49006.754966224944, 256361.0, 259810.0, 260304.0, 260340.0, 260918.0, 44217.77891110524, 44855.77572112119, 44902.10195796131, 44945.55054449414, 49362.0, 51415.22877156921, 51612.0, 52321.0, 52650.47349526609, 52690.73654631702, 42656.36015459709, 42682.0, 43215.0, 43661.12677746491, 47026.29460558163, 41532.58467415287, 42765.144697105265, 42869.0, 44063.33904991364, 44300.33549496696, 42803.785981069894, 43251.78374108109, 43534.346984795884, 46886.531134688215, 47570.762146189045, 37304.813475932446, 38574.80712596419, 38779.224415510966, 38987.0, 39258.41112383259, 28288.71711282861, 28822.711772882, 28840.849124490353, 28934.42131157407, 28959.565606515498], "unit": "ms", "name": "ext.html", "value": 20730.371670492626}, {"lowerIsBetter": false, "replicates": [373.23300617231575, 373.7553945361945, 383.03093174269094, 383.48804346197824, 385.58742145903875, 15070.547883563511, 17151.228194731237, 17782.911085444586, 19340.0, 19353.516162095955, 17429.389971351004, 17437.651246975052, 17731.46805595831, 17768.911155444235, 17777.200025998827, 4883.511648835106, 4963.726995015273, 4965.975170124144, 4979.526944940225, 4980.576650984671, 3758.9060273493246, 3836.731428799985, 3837.846486140551, 3839.808009599523, 4934.407871055479, 5503.504684578387, 5671.035923892948, 5674.404187560309, 5677.6309539879985, 5688.033034384164, 5669.6314739541795, 6127.356627554087, 6139.907901381483, 6164.66094364812, 6174.135621013062, 5405.459454054602, 5496.697681627509, 5496.890062198733, 5500.50495455411, 5511.366192887829, 21418.0, 21423.8928805355, 21545.569088618297, 22577.661335079985, 22602.208922687627, 2214.523877366374, 2215.634420320645, 2220.2340192633515, 2229.7547269800307, 2258.446680563256, 11726.589569365116, 13140.0, 14337.0, 14352.210628415432, 14360.856391436057, 1836.5225041489175, 1856.1554492705786, 1913.5311848597044, 1924.220690620301, 1956.5891162855817, 64445.35554644441, 65793.67103164454, 66064.33935660678, 66221.33778662248, 66776.0, 11054.22620416563, 11077.390743509184, 11084.390358530198, 11093.38986355742, 11116.0, 14533.128012319296, 14566.198859062853, 14636.341364638616, 14638.414463421344, 14672.119672819665, 8258.298044666271, 8310.0, 8352.373571982125, 8398.832023359499, 8409.03296120954, 8158.796030099176, 8193.180681931759, 8211.507309561446, 8244.711435099864, 8281.751547453587, 4712.340272361872, 4774.7135171889795, 4774.761261936889, 4814.807407703723, 4825.083234185494, 1602.439146298786, 1647.629283411247, 1764.7705798246145, 1877.727729479218, 1975.9308424205371, 875.4922145155922, 958.5159494455255, 965.4496936745987, 996.1632228927735, 1083.0198670203479, 16487.752683709754, 16490.34038638465, 16800.495985120466, 17038.74441883373, 17156.828431715523, 871.13322244366, 942.2721222062091, 998.116666749917, 1006.8791744990648, 1058.6929790360864, 9573.425594464215, 10024.0, 10184.23618228621, 10232.0, 10415.323004004715, 649786.0, 651776.0, 664900.0, 669585.0, 678421.0, 85571.57214213889, 86446.56776716076, 86616.14141737418, 88226.55886720525, 88386.0, 1181.8581770187461, 1199.4182821331647, 1199.4602428907026, 1210.8002179640262, 1228.1157566552067, 15488.380464781734, 15973.440929567409, 16379.83620163783, 16384.590385239986, 16695.0, 36152.09619759422, 37419.0, 37457.0, 37727.62272377241, 38387.424188636636, 45137.0, 46057.0, 46608.766956165004, 47000.529994700984, 47108.0, 9829.606815727291, 10283.023112804272, 10288.331258468175, 10427.582896684047, 10586.470676465991, 11865.881341186478, 11884.524619015488, 13516.391762370913, 18618.534536636693, 18971.90514047421, 14797.630059248175, 15468.226588670746, 15805.604859878595, 15825.129617871127, 16197.75703364427, 14424.206668633326, 14893.329800158803, 15041.548753537412, 15205.923970380078, 15599.0, 12263.816042759545, 15444.382224711335, 15450.60944514999, 15881.285342159861, 16013.199340033185, 8637.179467950535, 9202.447853128833, 9294.070592940921, 9437.858432123387, 9928.354656947564, 13268.601941941757, 14695.3387097583, 15040.247987600795, 15116.244187790786, 15318.463853765064], "unit": "ms", "name": "jquery.html", "value": 9327.468263306853}, {"lowerIsBetter": false, "replicates": [1389.1665000999396, 1526.7328217561924, 1583.7624356346546, 1783.2064731194616, 1876.615293864757, 6897.379235868771, 7577.7726668199975, 7918.524888506694, 7922.009748781409, 7922.128565857765, 7679.500832445901, 7967.44227904047, 7975.401844861644, 7978.601069946494, 7979.441439099265, 2331.9300420987356, 2344.23812261015, 2368.455255291284, 2370.383700237933, 2371.9169829055986, 2335.7664233576675, 2372.833901626887, 2420.576399130145, 2421.32202983165, 2424.5393375258645, 2299.908003679851, 2317.582835089683, 2320.5010922651627, 2327.615943369342, 2345.9882700586472, 2289.1301305503966, 2310.8151347892212, 2322.303309007291, 2332.673425720409, 2336.649502574619, 2341.7775311345395, 2356.787889089973, 2362.244081893795, 2363.1138323128826, 2364.550735360276, 7792.0, 7967.0, 7967.920320796776, 7968.960155199245, 7972.521648701097, 4722.220833562458, 4731.29030645406, 4755.571998520115, 4772.16487114757, 4798.184308667535, 2980.806247593921, 3021.879124835004, 3027.137265879214, 3031.045220755455, 3104.58088158098, 956.2541217850088, 968.3124981263312, 995.8605795188679, 1007.5113569918584, 1010.2524132142236, 10491.055804977588, 10499.0, 10499.685009449653, 10504.947475262576, 10507.159427245879, 4322.0, 4350.891227719332, 4368.104538569585, 4396.648268138541, 4404.4494438195225, 9057.09429057089, 9066.274698024143, 9108.908910910806, 9110.954445227731, 9116.0, 4762.714237145782, 4764.95235047652, 4767.356406885096, 4785.928211076836, 4795.256735206049, 3877.515310586177, 3948.0919388540797, 4343.391925130484, 4378.387025816388, 4423.248047831877, 3764.171882185915, 3782.867599634, 3801.163743976321, 3843.0968722350226, 3864.9806750966627, 1228.8955438787625, 1241.2304371289677, 1243.6144795113544, 1253.160382543698, 1272.1413046193782, 1134.9943250283695, 1146.008702472372, 1149.9827502587468, 1366.2417358366004, 1441.7981482592445, 7511.661975211128, 7607.619619019027, 7637.236276372319, 7657.46397752152, 7663.080430348394, 463.11776066593194, 466.0864705177822, 470.06222585941265, 474.24358148753373, 498.1108720933117, 5968.343482216953, 6006.189164462741, 6011.0, 6020.819375418744, 6024.457798798129, 9043.547822608843, 9643.517824108767, 9657.034296570428, 9664.371815831948, 9669.806603868024, 9327.253819694544, 9372.578233979488, 9400.24798016157, 9400.95299523498, 9412.764680883032, 7286.453515986216, 7445.9255407445235, 7514.887276690854, 7516.285952834472, 7611.0, 7172.175199852084, 7259.673314700745, 7290.380317673057, 7294.562326260441, 7296.963515182602, 8414.0, 8474.872876906975, 8611.569421529024, 8664.306855451423, 8687.478751274944, 8521.0, 8894.243989260727, 8911.287097032351, 8920.598573064357, 8961.865572016295, 5994.07091900756, 6168.876622467616, 6719.328067193242, 7131.0, 7167.104111986002, 7700.229977002479, 7710.8843367350655, 7712.190220026816, 7728.149903510722, 7751.573663448565, 7085.574865508086, 7251.891221631785, 7296.671649775667, 7352.301531354513, 7360.595167265852, 7173.0, 7198.820029499305, 7245.166805817398, 7273.563586184846, 7279.0, 7168.211496735459, 7294.489385742947, 7308.5614863108385, 7323.890141647773, 7334.376577990931, 6735.158105236846, 6761.425278851353, 6766.898496522655, 6770.289119642367, 6779.72881084751, 6364.459020983269, 6624.138861947916, 6663.000549917551, 6716.865662686621, 6718.496112791462], "unit": "ms", "name": "mootools.html", "value": 4479.985043826244}, {"lowerIsBetter": false, "replicates": [343.9105832483554, 348.1157859038043, 349.58748676561646, 351.3394817742645, 352.04595546070146, 6047.516198704104, 6061.151438798572, 6085.908711369333, 6086.847828804277, 6106.419890110433, 5798.855028624286, 5851.912221316673, 5958.731857066432, 5988.191594134791, 6038.788642397517, 4675.994661147861, 4685.039566888797, 4690.061987602476, 4694.507076756942, 4721.126591580552, 4447.911041779163, 4692.991006933508, 4698.812047518095, 4709.2229782085915, 4715.834945776898, 4465.799039043234, 4539.273716205408, 4653.418322709661, 4662.090892276007, 4682.508336624656, 4645.790939407735, 4657.464391594959, 4662.836800711959, 4670.136024835382, 4675.462321832999, 4071.2875246831686, 4096.180763847243, 4103.466549348565, 4108.958910410887, 4110.897227569305, 5651.943480565183, 5713.914291285634, 5744.0, 5754.1944127822135, 5770.884582308372, 5332.733363331818, 5343.038253114438, 5343.545798607123, 5344.893102137974, 5346.545543628797, 6319.778807741707, 6396.616203027833, 6408.90386644196, 6410.519211059142, 6417.03744438338, 4388.188185185719, 4391.01202229499, 4391.560843915583, 4397.2304846651705, 4401.295792673157, 6553.14809074822, 6592.1100651411925, 6624.73501059957, 6655.234648015492, 6662.93337066628, 4532.637389008872, 4534.614557762628, 4537.2059889519205, 4537.750423726727, 4543.318502224693, 4592.058627981322, 4596.149712303235, 4597.172508948354, 4602.286645569875, 4603.470600880874, 5339.225812257201, 5340.385855626575, 5340.626156169031, 5340.866478338073, 5344.412114667383, 6341.365863413622, 6465.15952926126, 6465.773697920645, 6473.478732497859, 6473.967630161913, 1612.3067081154982, 1623.1640705036916, 1623.626565889852, 1626.0406360247275, 1626.8210496845338, 1082.0477979378097, 1093.5516438260274, 1104.7845670094416, 1117.7038084907506, 1132.773445310941, 6162.0, 6165.414285642857, 6165.475934545524, 6170.753169873245, 6178.6601736904, 6469.094326794253, 6653.9667301663185, 6663.233728121328, 6668.0, 6673.766418175438, 6244.12582238487, 6254.2807577129215, 6344.841378965562, 6345.777897773556, 6364.522660800459, 3587.318409502186, 3613.9819300903855, 3628.092976755811, 3628.2924829657964, 3635.0730563706616, 6779.288174741581, 6901.654917254117, 6902.068220790229, 6914.135733033371, 6915.343042410963, 6889.931100689029, 6892.689828957709, 6893.551919125342, 6894.379505844498, 6894.586324820427, 6900.171979362509, 6904.551204171713, 6906.551074180263, 6908.6545672716165, 6910.997905303703, 6563.7702680405955, 6691.966540167463, 6695.096162018065, 6702.0, 6742.595444273359, 6609.603423794588, 6638.468922486286, 6638.5684930479365, 6647.0, 6654.866902662016, 6873.175218973555, 6881.793546193622, 6882.724691012303, 6884.173899132136, 6922.307769223037, 4487.7980490877335, 4635.884102897455, 4640.582347588733, 4647.95421030279, 4648.814047438064, 6674.566153200027, 6677.0, 6683.7660681875905, 6684.16447944007, 6692.59844409337, 6498.220213574401, 6508.186476690414, 6510.544261901811, 6510.804675859732, 6513.609183449008, 6359.554831161774, 6494.253160886558, 6501.382368674968, 6508.088867558451, 6509.698060388036, 6368.108464815023, 6386.329435409215, 6387.073874288295, 6392.52056095804, 6393.264774550986, 6477.0, 6492.513061520499, 6503.804885853432, 6511.38141876521, 6516.0, 6308.369163083655, 6332.145160403286, 6346.587471814318, 6349.0, 6447.774327898501], "unit": "ms", "name": "prototype.html", "value": 4870.891832512009}, {"lowerIsBetter": false, "replicates": [792.0455850699907, 835.3776436554764, 836.6444261188994, 909.949008894726, 962.191758922505, 13363.799543006851, 13722.794158087636, 13729.382177801997, 13744.931275343633, 13778.655533611653, 13082.0, 13112.082154249207, 13122.0, 13144.0, 13175.736485270289, 761.702935855017, 770.4606775257314, 772.1236396689769, 878.4421892098516, 902.7246689759621, 762.9389648828109, 888.9199972002518, 905.108468158863, 905.302916754099, 906.1165363770338, 937.2408349237139, 957.5403806173041, 957.5978089202551, 958.0228167269381, 958.4728399380348, 783.8941742864697, 794.8688466403037, 938.995305023474, 947.1002547579792, 947.2942657720008, 692.9099217101794, 698.9720411183547, 702.0452185028357, 702.4310308650009, 702.6943279673308, 13009.089363744542, 13165.078444508888, 13203.009774266968, 13205.603831885059, 13219.669508262274, 12574.937125314407, 12884.80672789909, 13515.526956556474, 13675.31623418835, 13682.0, 10031.849522257173, 10177.338472999232, 10329.690109296733, 10425.165986721044, 10670.51982660782, 2784.540550809114, 2823.50588646988, 2861.7138286171426, 2865.426914617064, 2896.478633845907, 48301.51698483005, 48910.0, 50238.7488062561, 50448.0, 50498.7475062626, 10008.749781255527, 10120.949395252977, 10144.087032167141, 10172.28793984414, 10246.38521688701, 19653.705194422095, 19889.502762430766, 19909.203631854853, 19938.0, 19959.301424450074, 7700.730474433368, 7718.382529397747, 7721.8455630887065, 7768.0, 7790.961045194851, 4350.151720414552, 4359.1717573661535, 4405.603495685404, 4439.445069366329, 4466.57567531084, 3429.9314013719586, 3453.671901169385, 3457.8098204598487, 3483.4252348362743, 3484.790912545255, 610.3438803286396, 615.8952977993752, 622.7384498510636, 623.2738859229038, 634.6033728919425, 711.6263961420295, 711.6797441151502, 719.7085180501905, 732.8900664900308, 738.4978214813979, 8552.0, 8780.560971951378, 9931.80136397268, 10039.749006274902, 10092.142167915663, 583.0991118721586, 679.188369897977, 688.4182865478663, 694.6110178300169, 711.4664001998501, 4028.778417187083, 4108.0, 4163.146554956226, 4239.27932251518, 4306.074194048295, 54125.45874541204, 57111.428885711444, 57856.71071644615, 57960.710196448745, 58363.416365836645, 48180.15265651281, 48805.0, 49498.75250623796, 49987.50012499901, 50161.0, 47539.28691069637, 47906.281405778944, 47984.28023579649, 48403.757981210576, 49209.26186107211, 9257.768555786159, 9511.762205944906, 9654.855177172207, 9761.9023809761, 10062.798744025225, 36428.4535731959, 36667.26665466729, 36679.0, 37553.0, 37572.812135939144, 47811.28283075826, 48176.0, 48235.0, 49631.503684962685, 50156.0, 11098.500567474644, 11646.0, 12043.75912481728, 12300.200486968319, 12466.43901024438, 13004.544840930523, 13668.0, 13686.178829270275, 13715.451381944611, 13905.652358691113, 11783.882161178279, 12096.0, 12284.631461056182, 12390.3185324808, 12731.299778512272, 12202.511899523919, 12238.755224895274, 12568.057395695543, 12586.24482531051, 13172.0, 12004.579839705568, 12078.0, 12615.621531354074, 12658.746825063263, 12717.936410317889, 10871.0, 11005.284656497302, 11035.503402347074, 11056.668299951014, 11334.149938754792, 9992.15066719337, 10205.183585313009, 10241.283110182216, 10269.0, 10570.577176912837], "unit": "ms", "name": "yui.html", "value": 6639.629980802611}], "name": "dromaeo_css", "value": 7331.725828542564}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 108.0, 103.0, 107.0, 109.0, 109.0, 99.0, 108.0, 109.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 106.8}, {"lowerIsBetter": true, "replicates": [148.0, 122.0, 145.0, 160.0, 125.0, 152.0, 153.0, 124.0, 167.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.8}, {"lowerIsBetter": true, "replicates": [161.0, 167.0, 162.0, 162.0, 161.0, 161.0, 161.0, 163.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [77.0, 72.0, 73.0, 161.0, 70.0, 73.0, 71.0, 71.0, 157.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 89.6}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 137.0, 92.0, 94.0, 93.0, 144.0, 92.0, 93.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 57.0, 56.0, 57.0, 58.0, 58.0, 56.0, 56.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [79.0, 80.0, 88.0, 81.0, 80.0, 80.0, 82.0, 81.0, 80.0, 89.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.0}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 112.0, 116.0, 126.0, 113.0, 110.0, 111.0, 120.0, 114.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 115.5}, {"lowerIsBetter": true, "replicates": [152.0, 141.0, 139.0, 141.0, 143.0, 140.0, 143.0, 141.0, 156.0, 131.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.7}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 67.0, 67.0, 64.0, 65.0, 66.0, 63.0, 65.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.1}], "name": "kraken", "value": 1483.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.80567139282735], "unit": "score", "name": "Richards", "value": 211.6354900000001}, {"lowerIsBetter": false, "replicates": [173.25017325017325], "unit": "score", "name": "DeltaBlue", "value": 381.6330960000001}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5112.244897959184], "unit": "score", "name": "Decrypt", "value": 52.067341317365305}, {"lowerIsBetter": false, "replicates": [952.3809523809524], "unit": "score", "name": "RayTrace", "value": 776.9884500000003}, {"lowerIsBetter": false, "replicates": [558.659217877095], "unit": "score", "name": "Earley", "value": 1192.9687700000002}, {"lowerIsBetter": false, "replicates": [11133.333333333334], "unit": "score", "name": "Boyer", "value": 59.86194610778439}, {"lowerIsBetter": false, "replicates": [24047.619047619046], "unit": "score", "name": "RegExp", "value": 37.88254455445545}, {"lowerIsBetter": false, "replicates": [526.592943654555], "unit": "score", "name": "Splay", "value": 154.75140899999997}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 23015.251319323805}]} 03:31:53 INFO - RETURN: dromaeo_css: 7331.73 03:31:53 INFO - RETURN: kraken: 1483.20 03:31:53 INFO - RETURN: v8_7: 23015.25 03:31:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "23015.25"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1483.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7331.73"}}} 03:31:53 INFO - Return code: 0 03:31:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 03:31:53 INFO - # TBPL SUCCESS # 03:31:53 INFO - Running post-action listener: _resource_record_post_action 03:31:53 INFO - Running post-run listener: _resource_record_post_run 03:31:54 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 266240; Write bytes: 280002560; Read time: 52; Write time: 187196 03:31:54 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 19746816; Read time: 0; Write time: 9040 03:31:54 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 266240; Write bytes: 259391488; Read time: 52; Write time: 178112 03:31:54 INFO - Running post-run listener: _upload_blobber_files 03:31:54 INFO - Blob upload gear active. 03:31:54 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:31:54 INFO - Copying logs to upload dir... 03:31:54 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1288.089252 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-01-14 03:31:53.951118) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-14 03:31:53.954610) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1452769303.403424-1146716374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.008860 build_url: 'https://queue.taskcluster.net/v1/task/yXbzAdfuTOuqlCkfzi4oNw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-14 03:31:54.005684) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:31:54.006023) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1452769303.403424-1146716374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 03:31:54.056497) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 03:31:54.056860) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 03:31:54.057179) ========= ========= Total master_lag: 0.25 =========