builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1448544326.25 results: success (0) buildid: 20151126035113 builduid: 673fd583569b4f66b24b34108e3dd88e revision: 5fe77514a40b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 05:25:26.254469) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-26 05:25:26.254985) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 05:25:26.255341) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448540767.538764-668980821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.003033 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-26 05:25:26.294222) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 05:25:26.294534) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-26 05:25:26.335597) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 05:25:26.335886) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448540767.538764-668980821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020537 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 05:25:26.385483) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 05:25:26.386085) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-26 05:25:26.386750) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 05:25:26.387257) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448540767.538764-668980821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-26 05:25:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.5M=0s 2015-11-26 05:25:26 (40.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.262676 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 05:25:26.663257) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 05:25:26.663595) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448540767.538764-668980821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.125856 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 05:25:26.801141) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-26 05:25:26.801508) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5fe77514a40b --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 5fe77514a40b --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=70a720fcaf18edea6683c2dc000001ad-1448540767.538764-668980821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-26 05:25:26,881 Setting DEBUG logging. 2015-11-26 05:25:26,881 attempt 1/10 2015-11-26 05:25:26,881 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5fe77514a40b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-26 05:25:27,534 unpacking tar archive at: fx-team-5fe77514a40b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.282767 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-26 05:25:28.097640) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 05:25:28.097987) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-26 05:25:28.107118) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 05:25:28.107702) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-26 05:25:28.108608) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-11-26 05:25:28.108975) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=70a720fcaf18edea6683c2dc000001ad-1448540767.538764-668980821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:25:28 INFO - MultiFileLogger online at 20151126 05:25:28 in /builds/slave/test-pgo 05:25:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:25:28 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:25:28 INFO - {'append_to_log': False, 05:25:28 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:25:28 INFO - 'blob_upload_branch': 'Fx-Team', 05:25:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:25:28 INFO - 'branch': 'Fx-Team', 05:25:28 INFO - 'buildbot_json_path': 'buildprops.json', 05:25:28 INFO - 'config_files': ('talos/linux_config.py',), 05:25:28 INFO - 'default_actions': ('clobber', 05:25:28 INFO - 'read-buildbot-config', 05:25:28 INFO - 'download-and-extract', 05:25:28 INFO - 'populate-webroot', 05:25:28 INFO - 'create-virtualenv', 05:25:28 INFO - 'install', 05:25:28 INFO - 'run-tests'), 05:25:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:25:28 INFO - 'download_minidump_stackwalk': True, 05:25:28 INFO - 'download_symbols': 'ondemand', 05:25:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:25:28 INFO - 'tooltool.py': '/tools/tooltool.py', 05:25:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:25:28 INFO - '/tools/misc-python/virtualenv.py')}, 05:25:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:25:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:25:28 INFO - 'installer_path': 'installer.exe', 05:25:28 INFO - 'log_level': 'info', 05:25:28 INFO - 'log_name': 'talos', 05:25:28 INFO - 'log_to_console': True, 05:25:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:25:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:25:28 INFO - 'opt_config_files': (), 05:25:28 INFO - 'pip_index': False, 05:25:28 INFO - 'sps_profile': False, 05:25:28 INFO - 'sps_profile_interval': 0, 05:25:28 INFO - 'suite': 'dromaeojs', 05:25:28 INFO - 'system_bits': '64', 05:25:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:25:28 INFO - 'title': 'talos-linux64-ix-015', 05:25:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:25:28 INFO - 'use_talos_json': True, 05:25:28 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:25:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:25:28 INFO - 'work_dir': 'build'} 05:25:28 INFO - ##### 05:25:28 INFO - ##### Running clobber step. 05:25:28 INFO - ##### 05:25:28 INFO - Running pre-action listener: _resource_record_pre_action 05:25:28 INFO - Running main action method: clobber 05:25:28 INFO - rmtree: /builds/slave/test-pgo/build 05:25:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:25:29 INFO - Running post-action listener: _resource_record_post_action 05:25:29 INFO - ##### 05:25:29 INFO - ##### Running read-buildbot-config step. 05:25:29 INFO - ##### 05:25:29 INFO - Running pre-action listener: _resource_record_pre_action 05:25:29 INFO - Running main action method: read_buildbot_config 05:25:29 INFO - Using buildbot properties: 05:25:29 INFO - { 05:25:29 INFO - "properties": { 05:25:29 INFO - "buildnumber": 518, 05:25:29 INFO - "product": "firefox", 05:25:29 INFO - "script_repo_revision": "production", 05:25:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:25:29 INFO - "repository": "", 05:25:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:25:29 INFO - "buildid": "20151126035113", 05:25:29 INFO - "slavename": "talos-linux64-ix-015", 05:25:29 INFO - "pgo_build": "True", 05:25:29 INFO - "basedir": "/builds/slave/test-pgo", 05:25:29 INFO - "project": "", 05:25:29 INFO - "platform": "ubuntu64_hw", 05:25:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:25:29 INFO - "slavebuilddir": "test", 05:25:29 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:25:29 INFO - "branch": "fx-team", 05:25:29 INFO - "repo_path": "integration/fx-team", 05:25:29 INFO - "stage_platform": "linux64-pgo", 05:25:29 INFO - "builduid": "673fd583569b4f66b24b34108e3dd88e", 05:25:29 INFO - "revision": "5fe77514a40b" 05:25:29 INFO - }, 05:25:29 INFO - "sourcestamp": { 05:25:29 INFO - "repository": "", 05:25:29 INFO - "hasPatch": false, 05:25:29 INFO - "project": "", 05:25:29 INFO - "branch": "fx-team-linux64-pgo-talos", 05:25:29 INFO - "changes": [ 05:25:29 INFO - { 05:25:29 INFO - "category": null, 05:25:29 INFO - "files": [ 05:25:29 INFO - { 05:25:29 INFO - "url": null, 05:25:29 INFO - "name": "https://queue.taskcluster.net/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 05:25:29 INFO - } 05:25:29 INFO - ], 05:25:29 INFO - "repository": "", 05:25:29 INFO - "rev": "5fe77514a40b", 05:25:29 INFO - "who": "sendchange", 05:25:29 INFO - "when": 1448544239, 05:25:29 INFO - "number": 6710756, 05:25:29 INFO - "comments": "", 05:25:29 INFO - "project": "", 05:25:29 INFO - "at": "Thu 26 Nov 2015 05:23:59", 05:25:29 INFO - "branch": "fx-team-linux64-pgo-talos", 05:25:29 INFO - "revlink": "", 05:25:29 INFO - "properties": [ 05:25:29 INFO - [ 05:25:29 INFO - "buildid", 05:25:29 INFO - "20151126035113", 05:25:29 INFO - "Change" 05:25:29 INFO - ], 05:25:29 INFO - [ 05:25:29 INFO - "builduid", 05:25:29 INFO - "673fd583569b4f66b24b34108e3dd88e", 05:25:29 INFO - "Change" 05:25:29 INFO - ], 05:25:29 INFO - [ 05:25:29 INFO - "pgo_build", 05:25:29 INFO - "True", 05:25:29 INFO - "Change" 05:25:29 INFO - ] 05:25:29 INFO - ], 05:25:29 INFO - "revision": "5fe77514a40b" 05:25:29 INFO - } 05:25:29 INFO - ], 05:25:29 INFO - "revision": "5fe77514a40b" 05:25:29 INFO - } 05:25:29 INFO - } 05:25:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 05:25:29 INFO - Running post-action listener: _resource_record_post_action 05:25:29 INFO - ##### 05:25:29 INFO - ##### Running download-and-extract step. 05:25:29 INFO - ##### 05:25:29 INFO - Running pre-action listener: _resource_record_pre_action 05:25:29 INFO - Running main action method: download_and_extract 05:25:29 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:25:29 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')]} 05:25:29 INFO - https://queue.taskcluster.net/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:25:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/test_packages.json 05:25:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/test_packages.json 05:25:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:25:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:25:30 INFO - Downloaded 1302 bytes. 05:25:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:25:30 INFO - Using the following test package requirements: 05:25:30 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:25:30 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:25:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:25:30 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:25:30 INFO - u'jsshell-linux-x86_64.zip'], 05:25:30 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:25:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:25:30 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:25:30 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:25:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:25:30 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:25:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:25:30 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:25:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:25:30 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:25:30 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:25:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:25:30 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:25:30 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')]} 05:25:30 INFO - https://queue.taskcluster.net/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:25:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:25:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:25:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:25:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:25:31 INFO - Downloaded 22755760 bytes. 05:25:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:25:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:25:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:25:32 INFO - Return code: 0 05:25:32 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:25:32 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')]} 05:25:32 INFO - https://queue.taskcluster.net/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:25:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:25:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:25:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:25:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:25:33 INFO - Downloaded 22755760 bytes. 05:25:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:25:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:25:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:25:34 INFO - Return code: 0 05:25:34 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')]} 05:25:34 INFO - https://queue.taskcluster.net/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:25:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:25:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:25:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:25:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:25:35 INFO - Downloaded 11131717 bytes. 05:25:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:25:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:25:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:25:35 INFO - Return code: 0 05:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:35 INFO - https://queue.taskcluster.net/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:25:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:25:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:25:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:25:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:25:38 INFO - Downloaded 58386673 bytes. 05:25:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:25:38 INFO - mkdir: /builds/slave/test-pgo/properties 05:25:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:25:38 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:25:38 INFO - Contents: 05:25:38 INFO - build_url:https://queue.taskcluster.net/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:25:38 INFO - Running post-action listener: _resource_record_post_action 05:25:38 INFO - Running post-action listener: set_extra_try_arguments 05:25:38 INFO - ##### 05:25:38 INFO - ##### Running populate-webroot step. 05:25:38 INFO - ##### 05:25:38 INFO - Running pre-action listener: _resource_record_pre_action 05:25:38 INFO - Running main action method: populate_webroot 05:25:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:25:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:25:38 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:25:38 INFO - '../fennec_ids.txt'], 05:25:38 INFO - 'tests': ['tcheck2']}, 05:25:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:25:38 INFO - '--tppagecycles', 05:25:38 INFO - '7'], 05:25:38 INFO - 'tests': ['tsvgm']}}, 05:25:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:25:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:25:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:25:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:25:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:25:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:25:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:25:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:38 INFO - 'talos_options': ['--e10s'], 05:25:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:25:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:38 INFO - 'tests': ['damp', 'tps']}, 05:25:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:38 INFO - 'talos_options': ['--e10s'], 05:25:38 INFO - 'tests': ['damp', 'tps']}, 05:25:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:25:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:25:38 INFO - 'other': {'tests': ['a11yr', 05:25:38 INFO - 'ts_paint', 05:25:38 INFO - 'tpaint', 05:25:38 INFO - 'sessionrestore', 05:25:38 INFO - 'sessionrestore_no_auto_restore']}, 05:25:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:25:38 INFO - 'tests': ['a11yr', 05:25:38 INFO - 'ts_paint', 05:25:38 INFO - 'tpaint', 05:25:38 INFO - 'sessionrestore', 05:25:38 INFO - 'sessionrestore_no_auto_restore']}, 05:25:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:25:38 INFO - 'tests': ['a11yr', 05:25:38 INFO - 'ts_paint', 05:25:38 INFO - 'tpaint', 05:25:38 INFO - 'sessionrestore', 05:25:38 INFO - 'sessionrestore_no_auto_restore']}, 05:25:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:25:38 INFO - 'tests': ['a11yr', 05:25:38 INFO - 'ts_paint', 05:25:38 INFO - 'tpaint', 05:25:38 INFO - 'sessionrestore', 05:25:38 INFO - 'sessionrestore_no_auto_restore']}, 05:25:38 INFO - 'other_l64': {'tests': ['a11yr', 05:25:38 INFO - 'ts_paint', 05:25:38 INFO - 'tpaint', 05:25:38 INFO - 'sessionrestore', 05:25:38 INFO - 'sessionrestore_no_auto_restore']}, 05:25:38 INFO - 'other_nol64': {'tests': ['a11yr', 05:25:38 INFO - 'ts_paint', 05:25:38 INFO - 'tpaint', 05:25:38 INFO - 'sessionrestore', 05:25:38 INFO - 'sessionrestore_no_auto_restore']}, 05:25:38 INFO - 'svgr': {'tests': ['tsvgx', 05:25:38 INFO - 'tsvgr_opacity', 05:25:38 INFO - 'tart', 05:25:38 INFO - 'tscrollx', 05:25:38 INFO - 'cart']}, 05:25:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:25:38 INFO - 'tests': ['tsvgx', 05:25:38 INFO - 'tsvgr_opacity', 05:25:38 INFO - 'tart', 05:25:38 INFO - 'tscrollx', 05:25:38 INFO - 'cart']}, 05:25:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:38 INFO - 'tests': ['tp5o']}, 05:25:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:38 INFO - 'talos_options': ['--e10s'], 05:25:38 INFO - 'tests': ['tp5o']}, 05:25:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:38 INFO - 'talos_options': ['--xperf_path', 05:25:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:25:38 INFO - 'tests': ['tp5n']}, 05:25:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:38 INFO - 'talos_options': ['--e10s', 05:25:38 INFO - '--xperf_path', 05:25:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:25:38 INFO - 'tests': ['tp5n']}}, 05:25:38 INFO - 'talos.zip': {'path': '', 05:25:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:25:38 INFO - Running post-action listener: _resource_record_post_action 05:25:38 INFO - ##### 05:25:38 INFO - ##### Running create-virtualenv step. 05:25:38 INFO - ##### 05:25:38 INFO - Running pre-action listener: _resource_record_pre_action 05:25:38 INFO - Running main action method: create_virtualenv 05:25:38 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:25:38 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 05:25:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:25:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:25:38 INFO - Using real prefix '/usr' 05:25:38 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:25:39 INFO - Installing distribute.............................................................................................................................................................................................done. 05:25:41 INFO - Installing pip.................done. 05:25:41 INFO - Return code: 0 05:25:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:41 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 0x264f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290b640>, '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 0x290c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290c9d0>, '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': '70a720fcaf18edea6683c2dc000001ad-1448540767.538764-668980821', '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 05:25:41 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 05:25:41 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 05:25:41 INFO - Using env: {'DISPLAY': ':0', 05:25:41 INFO - 'HOME': '/home/cltbld', 05:25:41 INFO - 'LANG': 'en_US.UTF-8', 05:25:41 INFO - 'LANGUAGE': 'en_US:en', 05:25:41 INFO - 'LOGNAME': 'cltbld', 05:25:41 INFO - 'MAIL': '/var/mail/cltbld', 05:25:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:41 INFO - 'MOZ_NO_REMOTE': '1', 05:25:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:41 INFO - 'NO_EM_RESTART': '1', 05:25:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:25:41 INFO - 'PWD': '/builds/slave/test-pgo', 05:25:41 INFO - 'SHELL': '/bin/bash', 05:25:41 INFO - 'SHLVL': '1', 05:25:41 INFO - 'TERM': 'linux', 05:25:41 INFO - 'TMOUT': '86400', 05:25:41 INFO - 'USER': 'cltbld', 05:25:41 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448540767.538764-668980821', 05:25:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:41 INFO - '_': '/tools/buildbot/bin/python'} 05:25:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:41 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 05:25:41 INFO - Cleaning up... 05:25:41 INFO - Return code: 0 05:25:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:41 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 0x264f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290b640>, '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 0x290c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290c9d0>, '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': '70a720fcaf18edea6683c2dc000001ad-1448540767.538764-668980821', '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 05:25:41 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 05:25:41 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 05:25:41 INFO - Using env: {'DISPLAY': ':0', 05:25:41 INFO - 'HOME': '/home/cltbld', 05:25:41 INFO - 'LANG': 'en_US.UTF-8', 05:25:41 INFO - 'LANGUAGE': 'en_US:en', 05:25:41 INFO - 'LOGNAME': 'cltbld', 05:25:41 INFO - 'MAIL': '/var/mail/cltbld', 05:25:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:41 INFO - 'MOZ_NO_REMOTE': '1', 05:25:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:41 INFO - 'NO_EM_RESTART': '1', 05:25:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:25:41 INFO - 'PWD': '/builds/slave/test-pgo', 05:25:41 INFO - 'SHELL': '/bin/bash', 05:25:41 INFO - 'SHLVL': '1', 05:25:41 INFO - 'TERM': 'linux', 05:25:41 INFO - 'TMOUT': '86400', 05:25:41 INFO - 'USER': 'cltbld', 05:25:41 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448540767.538764-668980821', 05:25:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:41 INFO - '_': '/tools/buildbot/bin/python'} 05:25:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:41 INFO - Downloading/unpacking psutil>=0.7.1 05:25:41 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 05:25:41 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 05:25:41 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 05:25:41 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 05:25:41 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 05:25:41 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 05:25:43 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:25:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:25:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:25:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:25:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:25:44 INFO - Installing collected packages: psutil 05:25:44 INFO - Running setup.py install for psutil 05:25:44 INFO - building 'psutil._psutil_linux' extension 05:25:44 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 05:25:45 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 05:25:45 INFO - building 'psutil._psutil_posix' extension 05:25:45 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 05:25:45 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 05:25:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:25:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:25:45 INFO - Successfully installed psutil 05:25:45 INFO - Cleaning up... 05:25:45 INFO - Return code: 0 05:25:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:45 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 0x264f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290b640>, '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 0x290c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290c9d0>, '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': '70a720fcaf18edea6683c2dc000001ad-1448540767.538764-668980821', '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 05:25:45 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 05:25:45 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 05:25:45 INFO - Using env: {'DISPLAY': ':0', 05:25:45 INFO - 'HOME': '/home/cltbld', 05:25:45 INFO - 'LANG': 'en_US.UTF-8', 05:25:45 INFO - 'LANGUAGE': 'en_US:en', 05:25:45 INFO - 'LOGNAME': 'cltbld', 05:25:45 INFO - 'MAIL': '/var/mail/cltbld', 05:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:45 INFO - 'MOZ_NO_REMOTE': '1', 05:25:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:45 INFO - 'NO_EM_RESTART': '1', 05:25:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:25:45 INFO - 'PWD': '/builds/slave/test-pgo', 05:25:45 INFO - 'SHELL': '/bin/bash', 05:25:45 INFO - 'SHLVL': '1', 05:25:45 INFO - 'TERM': 'linux', 05:25:45 INFO - 'TMOUT': '86400', 05:25:45 INFO - 'USER': 'cltbld', 05:25:45 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448540767.538764-668980821', 05:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:45 INFO - '_': '/tools/buildbot/bin/python'} 05:25:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:25:46 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 05:25:46 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 05:25:46 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 05:25:46 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 05:25:46 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 05:25:46 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 05:25:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:25:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:25:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:25:47 INFO - Installing collected packages: mozsystemmonitor 05:25:47 INFO - Running setup.py install for mozsystemmonitor 05:25:47 INFO - Successfully installed mozsystemmonitor 05:25:47 INFO - Cleaning up... 05:25:47 INFO - Return code: 0 05:25:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:25:47 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')]} 05:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:47 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')]} 05:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:47 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 0x264f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290b640>, '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 0x290c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290c9d0>, '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': '70a720fcaf18edea6683c2dc000001ad-1448540767.538764-668980821', '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 05:25:47 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 05:25:47 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 05:25:47 INFO - Using env: {'DISPLAY': ':0', 05:25:47 INFO - 'HOME': '/home/cltbld', 05:25:47 INFO - 'LANG': 'en_US.UTF-8', 05:25:47 INFO - 'LANGUAGE': 'en_US:en', 05:25:47 INFO - 'LOGNAME': 'cltbld', 05:25:47 INFO - 'MAIL': '/var/mail/cltbld', 05:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:47 INFO - 'MOZ_NO_REMOTE': '1', 05:25:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:47 INFO - 'NO_EM_RESTART': '1', 05:25:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:25:47 INFO - 'PWD': '/builds/slave/test-pgo', 05:25:47 INFO - 'SHELL': '/bin/bash', 05:25:47 INFO - 'SHLVL': '1', 05:25:47 INFO - 'TERM': 'linux', 05:25:47 INFO - 'TMOUT': '86400', 05:25:47 INFO - 'USER': 'cltbld', 05:25:47 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448540767.538764-668980821', 05:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:47 INFO - '_': '/tools/buildbot/bin/python'} 05:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:48 INFO - Downloading/unpacking blobuploader==1.2.4 05:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:49 INFO - Downloading blobuploader-1.2.4.tar.gz 05:25:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:25:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:25:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:25:49 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 05:25:49 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 05:25:49 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 05:25:49 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 05:25:49 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 05:25:49 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 05:25:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:25:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:25:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:25:50 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 05:25:50 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 05:25:50 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 05:25:50 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 05:25:50 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 05:25:50 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 05:25:50 INFO - Downloading docopt-0.6.1.tar.gz 05:25:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:25:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:25:50 INFO - Installing collected packages: blobuploader, requests, docopt 05:25:50 INFO - Running setup.py install for blobuploader 05:25:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:25:50 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:25:50 INFO - Running setup.py install for requests 05:25:50 INFO - Running setup.py install for docopt 05:25:51 INFO - Successfully installed blobuploader requests docopt 05:25:51 INFO - Cleaning up... 05:25:51 INFO - Return code: 0 05:25:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:51 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 0x264f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290b640>, '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 0x290c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290c9d0>, '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': '70a720fcaf18edea6683c2dc000001ad-1448540767.538764-668980821', '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 05:25:51 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 05:25:51 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 05:25:51 INFO - Using env: {'DISPLAY': ':0', 05:25:51 INFO - 'HOME': '/home/cltbld', 05:25:51 INFO - 'LANG': 'en_US.UTF-8', 05:25:51 INFO - 'LANGUAGE': 'en_US:en', 05:25:51 INFO - 'LOGNAME': 'cltbld', 05:25:51 INFO - 'MAIL': '/var/mail/cltbld', 05:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:51 INFO - 'MOZ_NO_REMOTE': '1', 05:25:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:51 INFO - 'NO_EM_RESTART': '1', 05:25:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:25:51 INFO - 'PWD': '/builds/slave/test-pgo', 05:25:51 INFO - 'SHELL': '/bin/bash', 05:25:51 INFO - 'SHLVL': '1', 05:25:51 INFO - 'TERM': 'linux', 05:25:51 INFO - 'TMOUT': '86400', 05:25:51 INFO - 'USER': 'cltbld', 05:25:51 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448540767.538764-668980821', 05:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:51 INFO - '_': '/tools/buildbot/bin/python'} 05:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:25:51 INFO - Running setup.py (path:/tmp/pip-otxTgo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:25:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:25:51 INFO - Running setup.py (path:/tmp/pip-UBYqyA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:25:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:25:51 INFO - Running setup.py (path:/tmp/pip-wBsmtB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:25:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:25:51 INFO - Running setup.py (path:/tmp/pip-Tcc2AJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:25:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:25:51 INFO - Running setup.py (path:/tmp/pip-Y7HIPj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:25:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:25:51 INFO - Running setup.py (path:/tmp/pip-HPg85z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:25:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:25:51 INFO - Running setup.py (path:/tmp/pip-tWca5c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:25:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:25:51 INFO - Running setup.py (path:/tmp/pip-d3IOZD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:25:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:25:51 INFO - Running setup.py (path:/tmp/pip-xFSELV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:25:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:25:51 INFO - Running setup.py (path:/tmp/pip-3UqAJA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:25:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:25:52 INFO - Running setup.py (path:/tmp/pip-m98SiE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:25:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:25:52 INFO - Running setup.py (path:/tmp/pip-I4sl4C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:25:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:25:52 INFO - Running setup.py (path:/tmp/pip-fUtges-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:25:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:25:52 INFO - Running setup.py (path:/tmp/pip-YhyHFj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:25:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:25:52 INFO - Running setup.py (path:/tmp/pip-nTC2OK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:25:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:25:52 INFO - Running setup.py (path:/tmp/pip-xet_Is-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:25:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:25:52 INFO - Running setup.py (path:/tmp/pip-fF0itk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:25:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:25:52 INFO - Running setup.py install for manifestparser 05:25:52 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:25:52 INFO - Running setup.py install for mozcrash 05:25:52 INFO - Running setup.py install for mozdebug 05:25:52 INFO - Running setup.py install for mozdevice 05:25:52 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:25:52 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:25:52 INFO - Running setup.py install for mozfile 05:25:53 INFO - Running setup.py install for mozhttpd 05:25:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:25:53 INFO - Running setup.py install for mozinfo 05:25:53 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:25:53 INFO - Running setup.py install for mozInstall 05:25:53 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:25:53 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:25:53 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:25:53 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:25:53 INFO - Running setup.py install for mozleak 05:25:53 INFO - Running setup.py install for mozlog 05:25:53 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:25:53 INFO - Running setup.py install for moznetwork 05:25:53 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:25:53 INFO - Running setup.py install for mozprocess 05:25:53 INFO - Running setup.py install for mozprofile 05:25:53 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:25:53 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:25:53 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:25:53 INFO - Running setup.py install for mozrunner 05:25:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:25:54 INFO - Running setup.py install for mozscreenshot 05:25:54 INFO - Running setup.py install for moztest 05:25:54 INFO - Running setup.py install for mozversion 05:25:54 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:25:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:25:54 INFO - Cleaning up... 05:25:54 INFO - Return code: 0 05:25:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:25:54 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')]} 05:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:54 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')]} 05:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:54 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 0x264f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290b640>, '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 0x290c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290c9d0>, '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': '70a720fcaf18edea6683c2dc000001ad-1448540767.538764-668980821', '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 05:25:54 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 05:25:54 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 05:25:54 INFO - Using env: {'DISPLAY': ':0', 05:25:54 INFO - 'HOME': '/home/cltbld', 05:25:54 INFO - 'LANG': 'en_US.UTF-8', 05:25:54 INFO - 'LANGUAGE': 'en_US:en', 05:25:54 INFO - 'LOGNAME': 'cltbld', 05:25:54 INFO - 'MAIL': '/var/mail/cltbld', 05:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:54 INFO - 'MOZ_NO_REMOTE': '1', 05:25:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:54 INFO - 'NO_EM_RESTART': '1', 05:25:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:25:54 INFO - 'PWD': '/builds/slave/test-pgo', 05:25:54 INFO - 'SHELL': '/bin/bash', 05:25:54 INFO - 'SHLVL': '1', 05:25:54 INFO - 'TERM': 'linux', 05:25:54 INFO - 'TMOUT': '86400', 05:25:54 INFO - 'USER': 'cltbld', 05:25:54 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448540767.538764-668980821', 05:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:54 INFO - '_': '/tools/buildbot/bin/python'} 05:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:25:54 INFO - Running setup.py (path:/tmp/pip-128Evy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:25:54 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)) 05:25:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:25:54 INFO - Running setup.py (path:/tmp/pip-U7sP5m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:25:54 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)) 05:25:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:25:54 INFO - Running setup.py (path:/tmp/pip-bExhVh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:25:54 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)) 05:25:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:25:54 INFO - Running setup.py (path:/tmp/pip-I6yRFE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:25:54 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)) 05:25:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:25:54 INFO - Running setup.py (path:/tmp/pip-iNmoU7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:25:54 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)) 05:25:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:25:54 INFO - Running setup.py (path:/tmp/pip-jtm__u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:25:54 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)) 05:25:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:25:54 INFO - Running setup.py (path:/tmp/pip-ger7Cy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:25:55 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)) 05:25:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:25:55 INFO - Running setup.py (path:/tmp/pip-h4hLbI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:25:55 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)) 05:25:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:25:55 INFO - Running setup.py (path:/tmp/pip-WVmbm5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:25:55 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)) 05:25:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:25:55 INFO - Running setup.py (path:/tmp/pip-f7Sl4K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:25:55 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)) 05:25:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:25:55 INFO - Running setup.py (path:/tmp/pip-Y3GZvg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:25:55 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)) 05:25:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:25:55 INFO - Running setup.py (path:/tmp/pip-iuwZbe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:25:55 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)) 05:25:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:25:55 INFO - Running setup.py (path:/tmp/pip-6bhJav-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:25:55 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)) 05:25:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:25:55 INFO - Running setup.py (path:/tmp/pip-Yqjl95-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:25:55 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)) 05:25:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:25:55 INFO - Running setup.py (path:/tmp/pip-cXNU9v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:25:55 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)) 05:25:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:25:55 INFO - Running setup.py (path:/tmp/pip-_DevO8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:25:55 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)) 05:25:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:25:55 INFO - Running setup.py (path:/tmp/pip-De7CFu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:25:55 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)) 05:25:55 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)) 05:25:55 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)) 05:25:55 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)) 05:25:55 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)) 05:25:55 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)) 05:25:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:57 INFO - Downloading blessings-1.5.1.tar.gz 05:25:57 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 05:25:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:25:57 INFO - Installing collected packages: blessings 05:25:57 INFO - Running setup.py install for blessings 05:25:57 INFO - Successfully installed blessings 05:25:57 INFO - Cleaning up... 05:25:57 INFO - Return code: 0 05:25:57 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:25:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:25:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:25:58 INFO - Reading from file tmpfile_stdout 05:25:58 INFO - Current package versions: 05:25:58 INFO - argparse == 1.2.1 05:25:58 INFO - blessings == 1.5.1 05:25:58 INFO - blobuploader == 1.2.4 05:25:58 INFO - docopt == 0.6.1 05:25:58 INFO - manifestparser == 1.1 05:25:58 INFO - mozInstall == 1.12 05:25:58 INFO - mozcrash == 0.16 05:25:58 INFO - mozdebug == 0.1 05:25:58 INFO - mozdevice == 0.47 05:25:58 INFO - mozfile == 1.2 05:25:58 INFO - mozhttpd == 0.7 05:25:58 INFO - mozinfo == 0.9 05:25:58 INFO - mozleak == 0.1 05:25:58 INFO - mozlog == 3.1 05:25:58 INFO - moznetwork == 0.27 05:25:58 INFO - mozprocess == 0.22 05:25:58 INFO - mozprofile == 0.27 05:25:58 INFO - mozrunner == 6.11 05:25:58 INFO - mozscreenshot == 0.1 05:25:58 INFO - mozsystemmonitor == 0.0 05:25:58 INFO - moztest == 0.7 05:25:58 INFO - mozversion == 1.4 05:25:58 INFO - psutil == 3.1.1 05:25:58 INFO - requests == 1.2.3 05:25:58 INFO - wsgiref == 0.1.2 05:25:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x264f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290b640>, '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 0x290c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290c9d0>, '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': '70a720fcaf18edea6683c2dc000001ad-1448540767.538764-668980821', '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 05:25:58 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 05:25:58 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 05:25:58 INFO - Using env: {'DISPLAY': ':0', 05:25:58 INFO - 'HOME': '/home/cltbld', 05:25:58 INFO - 'LANG': 'en_US.UTF-8', 05:25:58 INFO - 'LANGUAGE': 'en_US:en', 05:25:58 INFO - 'LOGNAME': 'cltbld', 05:25:58 INFO - 'MAIL': '/var/mail/cltbld', 05:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:58 INFO - 'MOZ_NO_REMOTE': '1', 05:25:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:58 INFO - 'NO_EM_RESTART': '1', 05:25:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:25:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:25:58 INFO - 'SHELL': '/bin/bash', 05:25:58 INFO - 'SHLVL': '1', 05:25:58 INFO - 'TERM': 'linux', 05:25:58 INFO - 'TMOUT': '86400', 05:25:58 INFO - 'USER': 'cltbld', 05:25:58 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448540767.538764-668980821', 05:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:58 INFO - '_': '/tools/buildbot/bin/python'} 05:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:58 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)) 05:25:58 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)) 05:25:58 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)) 05:25:58 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)) 05:25:58 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)) 05:25:58 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)) 05:25:58 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)) 05:25:58 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)) 05:25:58 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)) 05:25:58 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)) 05:25:58 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)) 05:25:58 INFO - Cleaning up... 05:25:58 INFO - Return code: 0 05:25:58 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290b640>, '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 0x290c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290c9d0>, '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': '70a720fcaf18edea6683c2dc000001ad-1448540767.538764-668980821', '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 05:25:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:25:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:25:58 INFO - Using env: {'DISPLAY': ':0', 05:25:58 INFO - 'HOME': '/home/cltbld', 05:25:58 INFO - 'LANG': 'en_US.UTF-8', 05:25:58 INFO - 'LANGUAGE': 'en_US:en', 05:25:58 INFO - 'LOGNAME': 'cltbld', 05:25:58 INFO - 'MAIL': '/var/mail/cltbld', 05:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:58 INFO - 'MOZ_NO_REMOTE': '1', 05:25:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:58 INFO - 'NO_EM_RESTART': '1', 05:25:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:25:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:25:58 INFO - 'SHELL': '/bin/bash', 05:25:58 INFO - 'SHLVL': '1', 05:25:58 INFO - 'TERM': 'linux', 05:25:58 INFO - 'TMOUT': '86400', 05:25:58 INFO - 'USER': 'cltbld', 05:25:58 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448540767.538764-668980821', 05:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:58 INFO - '_': '/tools/buildbot/bin/python'} 05:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:58 INFO - Downloading/unpacking jsonschema 05:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:26:00 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 05:26:00 INFO - Downloading/unpacking functools32 (from jsonschema) 05:26:00 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 05:26:00 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 05:26:00 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 05:26:00 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 05:26:00 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 05:26:00 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 05:26:00 INFO - Downloading functools32-3.2.3-2.tar.gz 05:26:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:26:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:26:00 INFO - warning: no files found matching '*.txt' 05:26:00 INFO - no previously-included directories found matching 'build' 05:26:00 INFO - no previously-included directories found matching 'dist' 05:26:00 INFO - no previously-included directories found matching '.git*' 05:26:00 INFO - Installing collected packages: jsonschema, functools32 05:26:00 INFO - Running setup.py install for functools32 05:26:00 INFO - warning: no files found matching '*.txt' 05:26:00 INFO - no previously-included directories found matching 'build' 05:26:00 INFO - no previously-included directories found matching 'dist' 05:26:00 INFO - no previously-included directories found matching '.git*' 05:26:00 INFO - Successfully installed jsonschema functools32 05:26:00 INFO - Cleaning up... 05:26:00 INFO - Return code: 0 05:26:00 INFO - Running post-action listener: _resource_record_post_action 05:26:00 INFO - Running post-action listener: _start_resource_monitoring 05:26:00 INFO - Starting resource monitoring. 05:26:00 INFO - ##### 05:26:00 INFO - ##### Running install step. 05:26:00 INFO - ##### 05:26:00 INFO - Running pre-action listener: _resource_record_pre_action 05:26:00 INFO - Running main action method: install 05:26:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:26:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:26:00 INFO - Reading from file tmpfile_stdout 05:26:00 INFO - Detecting whether we're running mozinstall >=1.0... 05:26:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:26:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:26:01 INFO - Reading from file tmpfile_stdout 05:26:01 INFO - Output received: 05:26:01 INFO - Usage: mozinstall [options] installer 05:26:01 INFO - Options: 05:26:01 INFO - -h, --help show this help message and exit 05:26:01 INFO - -d DEST, --destination=DEST 05:26:01 INFO - Directory to install application into. [default: 05:26:01 INFO - "/builds/slave/test-pgo"] 05:26:01 INFO - --app=APP Application being installed. [default: firefox] 05:26:01 INFO - mkdir: /builds/slave/test-pgo/build/application 05:26:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:26:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:26:15 INFO - Reading from file tmpfile_stdout 05:26:15 INFO - Output received: 05:26:15 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:26:15 INFO - Running post-action listener: _resource_record_post_action 05:26:15 INFO - ##### 05:26:15 INFO - ##### Running run-tests step. 05:26:15 INFO - ##### 05:26:15 INFO - Running pre-action listener: _resource_record_pre_action 05:26:15 INFO - Running main action method: run_tests 05:26:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:26:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:26:15 INFO - Python 2.7.3 05:26:15 INFO - Return code: 0 05:26:15 INFO - grabbing minidump binary from tooltool 05:26:15 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')]} 05:26:15 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 0x290b640>, '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 0x290c540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290c9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:26:15 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 05:26:15 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 05:26:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:26:15 INFO - Return code: 0 05:26:15 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:26:15 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:26:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:26:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:26:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:26:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:26:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost 05:26:15 INFO - Using env: {'DISPLAY': ':0', 05:26:15 INFO - 'HOME': '/home/cltbld', 05:26:15 INFO - 'LANG': 'en_US.UTF-8', 05:26:15 INFO - 'LANGUAGE': 'en_US:en', 05:26:15 INFO - 'LOGNAME': 'cltbld', 05:26:15 INFO - 'MAIL': '/var/mail/cltbld', 05:26:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:26:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:26:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:15 INFO - 'MOZ_NO_REMOTE': '1', 05:26:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:26:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:15 INFO - 'NO_EM_RESTART': '1', 05:26:15 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:26:15 INFO - 'PWD': '/builds/slave/test-pgo', 05:26:15 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:26:15 INFO - 'SHELL': '/bin/bash', 05:26:15 INFO - 'SHLVL': '1', 05:26:15 INFO - 'TERM': 'linux', 05:26:15 INFO - 'TMOUT': '86400', 05:26:15 INFO - 'USER': 'cltbld', 05:26:15 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1448540767.538764-668980821', 05:26:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:15 INFO - '_': '/tools/buildbot/bin/python'} 05:26:15 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost'] with output_timeout 3600 05:26:15 INFO - mozversion INFO | application_buildid: 20151126035113 05:26:15 INFO - mozversion INFO | application_changeset: 5fe77514a40b016456ea9935fd9794f32bde3230 05:26:15 INFO - mozversion INFO | application_display_name: Nightly 05:26:15 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:26:15 INFO - mozversion INFO | application_name: Firefox 05:26:15 INFO - mozversion INFO | application_remotingname: firefox 05:26:15 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 05:26:15 INFO - mozversion INFO | application_vendor: Mozilla 05:26:15 INFO - mozversion INFO | application_version: 45.0a1 05:26:15 INFO - mozversion INFO | platform_buildid: 20151126035113 05:26:15 INFO - mozversion INFO | platform_changeset: 5fe77514a40b016456ea9935fd9794f32bde3230 05:26:15 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 05:26:15 INFO - mozversion INFO | platform_version: 45.0a1 05:26:15 INFO - 2015-11-26 05:26:15,989 DEBUG : using testdate: 1448544375 05:26:15 INFO - 2015-11-26 05:26:15,989 DEBUG : actual date: 1448544375 05:26:16 INFO - 2015-11-26 05:26:16,074 INFO : starting webserver on 'localhost:36584' 05:26:16 INFO - 2015-11-26 05:26:16,075 INFO : Starting test suite talos-linux64-ix-015 05:26:16 INFO - 2015-11-26 05:26:16,075 INFO : Starting test dromaeo_css 05:26:16 INFO - 2015-11-26 05:26:16,075 DEBUG : operating with platform_type : linux_ 05:26:16 INFO - 2015-11-26 05:26:16,076 INFO : Initialising browser for dromaeo_css test... 05:26:16 INFO - 2015-11-26 05:26:16,093 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMglbfd/profile http://localhost:36584/getInfo.html 05:26:23 INFO - 2015-11-26 05:26:23,300 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:26:23 INFO - 2015-11-26 05:26:23,301 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:26:23 INFO - 2015-11-26 05:26:23,301 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:26:23 INFO - 2015-11-26 05:26:23,301 DEBUG : BROWSER_OUTPUT: __metrics 05:26:23 INFO - 2015-11-26 05:26:23,502 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] 05:26:24 INFO - 2015-11-26 05:26:24,714 INFO : Browser initialized. 05:26:24 INFO - 2015-11-26 05:26:24,714 INFO : Running cycle 1/1 for dromaeo_css test... 05:26:24 INFO - 2015-11-26 05:26:24,715 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMglbfd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:26:36 INFO - 2015-11-26 05:26:36,426 DEBUG : BROWSER_OUTPUT: RSS: Main: 141295616 05:26:36 INFO - 2015-11-26 05:26:36,426 DEBUG : BROWSER_OUTPUT: 05:27:27 INFO - 2015-11-26 05:27:27,386 DEBUG : BROWSER_OUTPUT: 1448544447384 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] 05:29:37 INFO - 2015-11-26 05:29:37,241 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36584/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36584/tests/dromaeo/cssquery-ext.html) 05:29:38 INFO - 2015-11-26 05:29:38,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 269127680 05:29:38 INFO - 2015-11-26 05:29:38,535 DEBUG : BROWSER_OUTPUT: 05:32:41 INFO - 2015-11-26 05:32:41,146 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36584/tests/dromaeo/cssquery-ext.html (next: http://localhost:36584/tests/dromaeo/cssquery-jquery.html) 05:32:41 INFO - 2015-11-26 05:32:41,715 DEBUG : BROWSER_OUTPUT: RSS: Main: 219734016 05:32:41 INFO - 2015-11-26 05:32:41,715 DEBUG : BROWSER_OUTPUT: 05:35:43 INFO - 2015-11-26 05:35:43,664 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36584/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36584/tests/dromaeo/cssquery-mootools.html) 05:35:44 INFO - 2015-11-26 05:35:44,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 211611648 05:35:44 INFO - 2015-11-26 05:35:44,237 DEBUG : BROWSER_OUTPUT: 05:38:46 INFO - 2015-11-26 05:38:46,156 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36584/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36584/tests/dromaeo/cssquery-prototype.html) 05:38:46 INFO - 2015-11-26 05:38:46,718 DEBUG : BROWSER_OUTPUT: RSS: Main: 201224192 05:38:46 INFO - 2015-11-26 05:38:46,718 DEBUG : BROWSER_OUTPUT: 05:41:49 INFO - 2015-11-26 05:41:49,244 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36584/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36584/tests/dromaeo/cssquery-yui.html) 05:41:49 INFO - 2015-11-26 05:41:49,839 DEBUG : BROWSER_OUTPUT: RSS: Main: 204222464 05:41:49 INFO - 2015-11-26 05:41:49,839 DEBUG : BROWSER_OUTPUT: 05:44:52 INFO - 2015-11-26 05:44:52,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36584/tests/dromaeo/cssquery-yui.html (next: http://localhost:36584/tests/dromaeo/cssquery-dojo.html) 05:44:52 INFO - 2015-11-26 05:44:52,649 DEBUG : BROWSER_OUTPUT: RSS: Main: 248922112 05:44:52 INFO - 2015-11-26 05:44:52,649 DEBUG : BROWSER_OUTPUT: 05:44:52 INFO - 2015-11-26 05:44:52,649 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:44:52 INFO - 2015-11-26 05:44:52,650 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:44:52 INFO - 2015-11-26 05:44:52,650 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:44:52 INFO - 2015-11-26 05:44:52,650 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:44:52 INFO - 2015-11-26 05:44:52,650 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3181.1092893989685;3207.3745619604188;3256.6906143916335;3257.283397652517;3293.094399040263;5236.764345604447;5343.625946183769;5456.618036737425;5476.790642529065;5480.890382192354;5398.379186393566;5407.729613519318;5439.755211015504;5494.972525137368;5558.194061861028;4908.239222920444;4945;4977.825776097838;5013.799448022075;5044.117279476095;4882.926756098661;4973.104841128596;4988.700677959316;5025.673331233476;5051.166557518005;4841.540053694911;4889.486603906575;4933.210686290212;4950.925736113961;4956.653034287583;4958.231474121517;5005.549500544968;5018.996200759862;5025.974870125626;5062.443131255559;4773.522647735199;4969.304297398331;4974.1543937530705;4991.500849915015;5062.265971434122;5182.326297581328;5244.292020577212;5272.789088436458;5288.286081379041;5306.9120830230095;5926.614770039977;5947.762089516415;5950.285965684102;5951.137085122677;5952.434518720715;5602.327720673546;5776.249087618583;5998.610090344114;6015.639061656315;6017.428344307327;5420.566354691615;5481.040817856859;5495.917561236504;5516.91724624131;5564.081926482166;5971.343152253248;5976.85057873548;5978.910316345258;5981.820545383645;6032.336442991267;5609.943900560942;5653.491185793298;5814.709264536757;5815.563832712563;5823.475887170091;5826.941730582725;5842.444967728059;5920.8815823684145;5936.436038576415;5950.67271300074;5861.736221870026;5866.120081987736;5867;5874.794382196603;5921.230240068763;5816.651000939957;5861.589688721749;5879.617824841372;5899.203607512931;5959.612625179349;4384;4462.085272519126;4471.441069866267;4506.842260520866;4535.886602834956;4062.898427539335;4067.5322337930925;4069.104796944667;4084.0606660467665;4099.508059032935;5356.625036247426;5388.110961691277;5579.804706835323;5593.496585307342;5593.524550413179;5850.531957443394;5902.675352855548;5929.080992446177;5937.317208521075;5957.404259574095;5537.556995440355;5542.836004439032;5544.861378465571;5550.833474995757;5566.972165139148;5009.649324547247;5132.435432102466;5137.357830271216;5142.61430392722;5187.04039752647;6018.488428483541;6116.266048074171;6118.661318325914;6124.718826527842;6126.936481897893;5846.94153058464;5864.706764661835;5867.853303667443;5873.148393483007;5908.852278693067;6016.909746353721;6020.849478763066;6095.801078121753;6104.236970378703;6110.236220472441;5674.546036317002;5747.597668163188;5747.597668163356;5754.136879468113;5799.420057994167;5702.258706368146;5747.109198074305;5749.885002300014;5752;5753.769849205984;5484.725763711719;5587.832365029056;5596.832095037155;5616.213730077874;5619.2133101365025;5667.659940403589;5735.311762588349;5736.168255602831;5738.053221218453;5788.189653448437;5581.74882130297;5582.637128586629;5584.860378490408;5593;5594.908992746376;5578.3584887738425;5690.71546422669;5703.144528320785;5746.13807928814;5770.451807078321;5674.432556744293;5695.316562012585;5726.713664316851;5728.083506638918;5739.426057394227 05:44:52 INFO - 2015-11-26 05:44:52,650 DEBUG : BROWSER_OUTPUT: |1;ext.html;541.7953041293208;574.2649408756793;578.051994728645;588.2206076948042;595.8867815115125;31339;32036.67963320366;40103.79948100263;40519;40669.389959150634;42405.57594424055;42810.35784463236;42871.142577148436;42958.35562466565;42985.14029719404;7558.886616700754;7697.499662521918;8660.826783464312;8841.29269658429;8841.38110332277;10416.479176041206;10565.894341056606;10701.036906678397;10709.143268538537;10721.35671859691;10336.224783141257;10416.531256093494;10426.947865260663;10431.374117552934;10434.426106564137;7561.735339263127;7727.111382191008;7731.7680469586;10341.172706183524;10518.842217366746;10146.746331341701;10347.689569312857;10350.637727679496;10354.689359319233;10362.48187590625;39637;39873.60126398757;39951;40015.39976900349;40037.39943900844;3090.227443139215;3133.9843300783577;3192.4892017277357;3332.1836150143126;3589.6410358963894;29768.70231297681;30005.69994300051;30027;30227.546586801214;30752.231194220323;3815.5993620669706;3854.672352850011;3910.687145028391;3936.4306836145042;3981.880543583697;258953;263169;263249;263407.6829615859;263424;56576;57784.422155778746;59711.701441492514;60240.39759602348;60333.39666603278;56603;56654.716726416926;56672.43327566671;56941.14588281179;56961.71519142378;15509.224538773016;15703.68592628141;15720.842791572166;15746.76379854303;15754.842451575567;11709.824352634718;11780.469878855472;11795.941020294844;11831.763364732657;11834.940825295991;19036.238550458103;19113.853168809917;19122.33071842479;19147.61704765897;19172.233110675697;7768.53388796674;7971.202879711982;7973.641186146638;8050.396220283502;8069.475484093633;909.3225546967419;961.2598299309632;980.8724865767405;1016.1667432705111;1061.1881910338598;27764.444711105665;27858.442831143264;28024.579631305547;28049.719502805117;28210.576841347396;1021.1983592879702;1032.7521394865178;1063.1760385700989;1143.7369405036889;1159.9246049006788;14609;14770.704585908437;14828.072350594353;14871.702565948837;16564.83435165657;371233;374201;376528.11735941144;376601;377358;54679;55196.72401637966;55293.44706552963;55299;55306.17040744392;1339.6127681842045;1342.9597112086653;1349.1163288046346;1349.7165595224917;1364.1542243808901;28666.843307719846;30523.38953220879;32081.518777217894;32494.837525813164;32640.673593263764;49811.75094124506;50471.24293135679;50505.74747126241;50571.2414313793;50624;278304;282786;284693;285010;286631;38111.42832857565;39516.80241598774;41487.51074935513;46082.07835843331;46489.53510464852;43705.78147109372;44090.33864491971;44608.33087503755;44696.776516117214;45232;35435.46846797249;37759.43360849535;38141.48329096182;38832.41751373675;39080.218395632495;36430.453543196345;36829.07927301839;37853.621463785006;38001.42997854979;38144.42783358196;34944.30111397809;35656.64343356637;40148;40398.59601404066;40615;29345.85327073351;35499.64500354963;37137.44293835541;38240;38246.617533824305;25483.36291592725;26140.8692956534;26169.345766355233;26698.466030679665;26950.191494255203 05:44:52 INFO - 2015-11-26 05:44:52,650 DEBUG : BROWSER_OUTPUT: |2;jquery.html;337.9678930501603;338.75271052131944;340.490966005821;341.1488336600183;352.5082509898691;14052.578422647312;14487.420503179861;16157.43448979286;16305.673886522263;17305.22126504307;16064;16068.598285042879;16117.27472263748;16130.354785808553;16192.919035404835;4513.638908887289;5247.055530004598;5258.237555554442;5261.684578855286;5275.577953763709;3912.7456715313556;4022.3966405039187;5321.308229930123;5612.915806262909;5769.624974376673;5572.60991730579;5590.720463976805;5647.887042259153;5669.206311116447;5704.572157088235;5456.945430545684;5612.186232996233;5614.214010038578;5618.494335509783;5626.2967129108865;4912.631552633567;4918.385201849769;4925.556699896991;4936.33359496467;4954;18992.335268265684;19302.32441864528;19338.41984740446;19350.516237094045;19914.60170796576;2016.6773316269473;2026.7871873453223;2213.0373287619936;2242.159190303636;2462.470568827711;12724.681882952907;12891.419886105054;12906;13333.133346332457;13419.530316438975;1785.526835388623;1791.7491551182845;1813.202191035953;1854.3695143651223;1861.3764388929724;53126.73436632831;53560.464395355935;53993.730031349594;54339.728301358635;57656.71171644157;9325.160735533835;9329.580168892417;9403.106704863027;9483.66807161746;9524.04759524056;11916.225445346197;11946.641600751991;11951.521939122511;11974.940125299318;11976.221545599508;6679.899801502981;6913.170419549586;6915.89626155608;6938.514303998772;7056.223815380304;6782.559133656297;6855.5543889647015;6886.724531018703;6895.4138898194215;6939.722411103499;4099.057216840143;4140.937885931713;4156.147989662112;4180.728252663567;4182.644475219579;1638.8934719243211;1702.1999660159704;1715.613986852948;2944.558316252579;3040.3919216156855;836.5733475927199;894.9955250223837;907.3240435875183;973.571628483465;1000.6647772996128;14059.929700351433;16029.759553606706;16127.193640317937;16280.75578866318;16642.58393540171;905.366243629462;912.2018234045211;959.9376040557341;974.668612671695;1019.3323373190572;8170.42807003504;9311;9370.156685898302;9471.857922131174;9678.95160524193;333144;344830;386721;505370;513809;73855.63072184604;79917.60041199757;80172.19397321065;80680.59659701781;81444.59277703574;1082.32895604724;1099.4997276239292;1100.9504572294106;1102.0687519046394;1109.1847492093304;15409.460668876536;15429.691406172038;15452.84547154559;15649.921750391175;15898.52304430869;35505;35861.64138358583;36095.639043609226;36220.09449763777;36277.818610906776;45858.77070614626;48049.279260810414;50215;50472.24291635702;51078.48921510886;9246.815063698823;9564.187044101329;9597.23222142241;9604.135627793532;9610.615575376907;11213.495392707184;11266.887331126913;12079.75840483203;17276.568085797957;17581.648367032332;14148.292585370897;14249.715005700034;14344.713105738036;14451.27743612794;14677;13521.932390337985;13607.319634018457;13842.4463021478;14005;14022.649433764238;14152.080114792505;14203.928980355033;14337.139771613736;14469.782953255499;14543.272836357928;9253.953730231306;9412.623495060121;9518.95240523793;9620.663276785559;9643.758906027406;14345.569632911029;14554.12675239489;14598.708025839636;14704.705905882036;14940.7758883619 05:44:52 INFO - 2015-11-26 05:44:52,650 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1584;1626.2275419175894;1690.0704612463142;1735.1324337831084;1779.7508348831159;6698.3971442570155;7426.071741032371;7654.617269136549;7656;7660.4254680898875;7453.254674532557;7691.4615976881505;7779.611019449033;7817.92182078179;7830;1934.7001214811726;1983.1076015792878;1988.3438465306415;2247.6291411917014;2250.7636698146703;1976.980230197694;2202.273249827561;2246.5057687308768;2246.86518808872;2249.1902914950606;2207.249535158046;2239.787220214085;2245.4049676835652;2270.6821045053625;2280.053777682268;1913.6746753052014;1949.2008276606664;2186.8250539956844;2211.9115235390564;2214.977850221493;2159.5033142377183;2209.2488553891594;2210.823134149264;2213.424509627492;2219.4451387153213;7601.391888648895;7733.304002639733;7745.961270193669;7750.961245193738;7760.9223907761325;4599.701019433726;4686.789094490756;4688.695234809727;4693.037927224911;4697.436307643105;2993.176876358997;3006.744426723731;3016.306249562591;3020.4412183746076;3041.574179614856;977.9119879210834;979.5200351827624;989.4063561862897;1010.9848352274722;1029.763154474475;10519.158467322595;10535.999080087457;10558.208134389952;10577.682669519927;10582.417967011888;4145.046639272924;4180.519240287345;4231.7516332681935;4232.830686772556;4249.490061192677;9117.31620128493;9118.726438206864;9121.179093881583;9121.635134594542;9125.315601329794;4618;4630.236011058138;4676.111538807616;4686.250199968057;4705.153072446924;4275.337322714984;4276.144771045803;4277.03766652507;4278.122984788111;4286.314189729628;3733.9439908401396;3741.0460332615007;3757.4739536464917;3765.171662234304;3768.4158955361413;1195.2469943935266;1207.5169932027084;1208.2206976500283;1214.769193853165;1219.890209881115;1300.343326620051;1304.4977683591885;1337.7525157845635;1343.8656134386679;1344.300963498975;7208;7263.201047884729;7438.256174382626;7441.888371674429;7447.255274472618;465.74151346003293;475.66227978135913;476.8783960090155;477.1030462730045;478.75344197738195;5451.754671039813;5599.104143337128;5769.048107062372;5831.737571809279;5937.376575459601;8620.61207245663;8688.218060374471;8842.159994800484;8915.821683566292;8924.955375223082;8801.47191168532;8903.73288801337;8923.464592124363;8936.8659470108;8944.195022448012;7074.646267686595;7075.964620176866;7104;7150.678219480136;7162.534435261691;6930.168379794457;7071.151461824408;7086.929130708627;7099.290070992859;7109.8578028438105;8144.30773384269;8230.917690823255;8418.116097809887;8425.368097392597;8446.155384461505;8288;8476.957615212132;8553.486790792324;8676;8686.82626347482;6544.54188206821;6862.348076932683;6954.756583519755;6967.581945083311;6967.616781077089;7439.962800185965;7450.217727138789;7460.776176714708;7526.962365188139;7595.3164215220895;7072.504924655224;7079;7106.289371062852;7199.2440793715905;7220.638968051681;7028.051213086168;7032.894506582507;7087.964560177166;7101.325374089453;7168.4265258780215;7043.647817609201;7115;7121.323474269936;7126.144862616519;7167.104111986002;6558.868822623616;6599.571027883172;6601.306862779339;6609.933900660932;6611.33886611335;6317.810465686037;6670.633115178712;6701.698423570853;6709.630970296681;6718.966405167943 05:44:52 INFO - 2015-11-26 05:44:52,651 DEBUG : BROWSER_OUTPUT: |4;prototype.html;324.48083067092654;334.12959241176736;335.17714012100294;343.63574610912417;343.8469880902996;5878.764849406019;6011;6054.9999999999945;6067.817965461032;6076.301225359085;5783.190353350524;5914.615549989258;5943.613665111765;5973.193618861453;5998.760049598021;4559.042601053783;4571.4514258289055;4574.268117101265;4576.633869290466;4585.19759042168;4365.672574556921;4429.734215947037;4552.08958208358;4575.839845605405;4643.396358473394;4565.794539245725;4586.243269860485;4589.816407343719;4605.516420775821;4622.237330840408;4579.42757155354;4587.770611469413;4599.908001839961;4600.309953506967;4606.424196975378;4040.7979601020124;4043.4137050127565;4046.8381264749373;4047.1298670785923;4047.8583249586122;5599.944000559983;5645.350784659776;5670.404607516192;5682.801101961453;5689.544836413077;5352.491513306269;5359.330083739533;5366.014574607381;5369.140937450028;5370.8925821483745;6051.273847138327;6337.714802833883;6342.23893132827;6343.080253363237;6347.492200623939;4290.935635965463;4329.376483818568;4402.3836662867225;4488.685791994561;4489.685721999429;6594.604323740543;6599.868002639968;6609.041688955074;6616.801495955129;6626.801195964129;4478.888027799266;4487.528809475023;4491.910161796745;4574.382458368144;4584.839530616412;4394.450693663292;4416.6908316418185;4433.889152771207;4539.795709193094;4539.863804085882;5213.895722085537;5217.426083130853;5222.21666749983;5226.216067589816;5231.241469986907;6375.394337537927;6379.298277189506;6385.584936979081;6390.744370225232;6437.259715132726;1622.7322491788723;1642.0476123848139;1643.0141914851233;1643.1209303022824;1644.284736139783;1104.7017305327677;1105.6240878101485;1119.2221406122828;1131.2590253384046;1131.8754936956927;6158.876822463526;6161.4146656067605;6163;6165.969170154121;6170.290416602148;6599;6609.768658096944;6610;6616.503762217853;6626.105475760711;6007.219061521974;6033.672592029747;6145.784897528565;6164.845878853064;6170.598911070856;3560.537130173061;3593.047842321787;3595.8921232363073;3598.3522965866396;3599.4240921452442;6763.864722705617;6806.387425131663;6810.659467026629;6815.114035175396;6821.522493425512;6588.934110658928;6591.6374599397495;6638.203415590064;6672.833179170462;6720.193576770819;6776.119104516381;6779.389854912983;6779.6271205084195;6784.253732089466;6804.319568043156;6293.213348331458;6480.611163330215;6494.090827284279;6495.740170393131;6504.089427480062;6235.96882015587;6424.229092508929;6433.839154021187;6436.388543088399;6438.67806609677;6753.257141714309;6867.175938887365;6884.345987131214;6884.8967265490055;6885.139357580302;4628.60656844172;4632.212523871018;4638.397008388888;4644.6052085571755;4648.8140474382;6624.6025238485845;6640.468762499085;6642.070110184482;6643.468522518284;6647;6236.719347629459;6383.521235907233;6383.521235907233;6411.935880641134;6472.579282346633;6425.421712045938;6431.163948686641;6443.194600674916;6445.903311450238;6448.193975753031;6168.629882207082;6276.121343012073;6313.810585682437;6330.082138089859;6333.081703153109;6441.259255185713;6446.290908000023;6452.161219041494;6455.806325810233;6457.806265812033;6124.081387791867;6150.630962142107;6162.445379915829;6273.96863015682;6282.905756413749 05:44:52 INFO - 2015-11-26 05:44:52,652 DEBUG : BROWSER_OUTPUT: |5;yui.html;742.8848528478086;826.078922001968;847.1993965702412;849.9532525711084;855.2644725536038;12722.55471058512;13005.60983170504;13016.284104374256;13044.217346959178;13044.934775326134;12251.509939602405;12256.571020014302;12262.509499620004;12298.200616959892;12321.445534950926;678.3081257117736;684.1482354468693;800.0479429478916;814.975550733476;831.4678605692362;816.1878930464167;821.8890449789262;822.9341652667803;826.1655727714991;828.3911325175991;701.7298340139058;771.8996530451034;832.7335252719132;860.6944534690189;860.7503823891064;704.8484575816199;829.2660995019421;856.2293935458107;864.3733293362325;866.4584634603373;642.473171998961;643.8841008618447;645.1484041065795;645.6061802300593;645.7481582182952;12337.198082124632;12461.688457788538;12489.50041998319;12507;12508.81236781449;11023.61417350389;11270.323780573191;11953.581624643095;12150.270983741004;12497.93751031248;9844.852327215098;9997.700068997869;10088;10118.645847395306;10195.4392508412;3499.4750787382095;3509.877154299613;3549.112721819545;3561.0207193021865;3577.069961809922;47996;48446.515534844904;48490.51509484895;49129.26306105375;49173.50826491761;8905.554722263862;8968.551572421353;9063.093690631016;9101.68144114966;9192.908070919339;18589.256429742658;18599.34902278414;18693.719594206097;18708;18735.25058997652;6884.759033433806;7242.565446073147;7331.963340183265;7381.37258333037;7570.697172113164;4068.7355321903983;4151.813168407429;4157.376393540993;4172.395002724588;4217;3026.2888221267986;3059.4492991261786;3065.9540106898417;3094.90715278542;3120.8751649933747;521.4837311062097;532.0157708239802;535.0209117315304;536.975836087377;537.0976759044764;517.4682789958473;596.6241268001219;635.1837888313495;642.7782415066795;669.6350488983516;7107.360337569644;7197.424206063502;7247.818804529929;7399.334059934632;7500.887486687704;501.2306110120947;578.2309528327314;628.8239292997968;643.2056410333234;659.868026394723;3490.5636795400574;3720.8325625346924;3728.757630753992;3733.178700685899;3794.4687743715904;59106.40893591095;60572.697136514034;60783;60787.69606151941;60920;52398.47601524012;52414.47585524172;52789.2081618776;53158.20262696063;53923;47462.288065679044;47667.523324766305;48333.7916552089;48919.510804892205;48998.02003959901;7172.390346820579;7237.124731505196;7249.710011599477;7374.815629609088;7432.814179645336;35201.47197791984;35944.820275899496;36031.63968360283;36768.81615591905;37363;44809.327860081474;47138.76430617962;47403;47510.762446187546;48033;10546.78906421852;10806.513706883052;10843;10972.177086718368;11027.22809403334;11326.546938122383;11580.942095289469;11723.179377443497;11808.114391420506;11829.585964491202;10365.533550990374;10753.247272690836;11091.833622495507;11199.272047316897;11207.60773372928;10101.69694909154;10196.949015254877;10378.948105259426;10382.42896640692;10465.162786977176;10002.899971000488;10306.845397318897;10339.121174699934;10343.63797267092;10528.894711052792;8794.20852123312;8865.778355541162;9198.402103863227;9260.629574816932;9357.578908948977;7445.813854653677;7716.961415192888;7729;8039.356851451753;8400.579971001303 05:44:52 INFO - 2015-11-26 05:44:52,652 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:44:52 INFO - 2015-11-26 05:44:52,652 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:44:52 INFO - 2015-11-26 05:44:52,652 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1085 05:44:52 INFO - 2015-11-26 05:44:52,652 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:44:52 INFO - 2015-11-26 05:44:52,652 DEBUG : BROWSER_OUTPUT: __startTimestamp1448545492642__endTimestamp 05:44:52 INFO - 2015-11-26 05:44:52,652 DEBUG : BROWSER_OUTPUT: 05:44:52 INFO - 2015-11-26 05:44:52,652 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:44:52 INFO - 2015-11-26 05:44:52,653 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:44:52 INFO - 2015-11-26 05:44:52,653 DEBUG : BROWSER_OUTPUT: 05:44:52 INFO - 2015-11-26 05:44:52,653 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5436.10 Median:5594.91 stddev:608.86 (10.9%) stddev-sans-first:584.46 05:44:52 INFO - 2015-11-26 05:44:52,654 DEBUG : BROWSER_OUTPUT: Values: 3181.1 3207.4 3256.7 3257.3 3293.1 5236.8 5343.6 5456.6 5476.8 5480.9 5398.4 5407.7 5439.8 5495.0 5558.2 4908.2 4945.0 4977.8 5013.8 5044.1 4882.9 4973.1 4988.7 5025.7 5051.2 4841.5 4889.5 4933.2 4950.9 4956.7 4958.2 5005.5 5019.0 5026.0 5062.4 4773.5 4969.3 4974.2 4991.5 5062.3 5182.3 5244.3 5272.8 5288.3 5306.9 5926.6 5947.8 5950.3 5951.1 5952.4 5602.3 5776.2 5998.6 6015.6 6017.4 5420.6 5481.0 5495.9 5516.9 5564.1 5971.3 5976.9 5978.9 5981.8 6032.3 5609.9 5653.5 5814.7 5815.6 5823.5 5826.9 5842.4 5920.9 5936.4 5950.7 5861.7 5866.1 5867.0 5874.8 5921.2 5816.7 5861.6 5879.6 5899.2 5959.6 4384.0 4462.1 4471.4 4506.8 4535.9 4062.9 4067.5 4069.1 4084.1 4099.5 5356.6 5388.1 5579.8 5593.5 5593.5 5850.5 5902.7 5929.1 5937.3 5957.4 5537.6 5542.8 5544.9 5550.8 5567.0 5009.6 5132.4 5137.4 5142.6 5187.0 6018.5 6116.3 6118.7 6124.7 6126.9 5846.9 5864.7 5867.9 5873.1 5908.9 6016.9 6020.8 6095.8 6104.2 6110.2 5674.5 5747.6 5747.6 5754.1 5799.4 5702.3 5747.1 5749.9 5752.0 5753.8 5484.7 5587.8 5596.8 5616.2 5619.2 5667.7 5735.3 5736.2 5738.1 5788.2 5581.7 5582.6 5584.9 5593.0 5594.9 5578.4 5690.7 5703.1 5746.1 5770.5 5674.4 5695.3 5726.7 5728.1 5739.4 05:44:52 INFO - 2015-11-26 05:44:52,654 DEBUG : BROWSER_OUTPUT: 05:44:52 INFO - 2015-11-26 05:44:52,654 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48420.94 Median:20010.05 stddev:81363.25 (406.6%) stddev-sans-first:81512.08 05:44:52 INFO - 2015-11-26 05:44:52,654 DEBUG : BROWSER_OUTPUT: Values: 541.8 574.3 578.1 588.2 595.9 31339.0 32036.7 40103.8 40519.0 40669.4 42405.6 42810.4 42871.1 42958.4 42985.1 7558.9 7697.5 8660.8 8841.3 8841.4 10416.5 10565.9 10701.0 10709.1 10721.4 10336.2 10416.5 10426.9 10431.4 10434.4 7561.7 7727.1 7731.8 10341.2 10518.8 10146.7 10347.7 10350.6 10354.7 10362.5 39637.0 39873.6 39951.0 40015.4 40037.4 3090.2 3134.0 3192.5 3332.2 3589.6 29768.7 30005.7 30027.0 30227.5 30752.2 3815.6 3854.7 3910.7 3936.4 3981.9 258953.0 263169.0 263249.0 263407.7 263424.0 56576.0 57784.4 59711.7 60240.4 60333.4 56603.0 56654.7 56672.4 56941.1 56961.7 15509.2 15703.7 15720.8 15746.8 15754.8 11709.8 11780.5 11795.9 11831.8 11834.9 19036.2 19113.9 19122.3 19147.6 19172.2 7768.5 7971.2 7973.6 8050.4 8069.5 909.3 961.3 980.9 1016.2 1061.2 27764.4 27858.4 28024.6 28049.7 28210.6 1021.2 1032.8 1063.2 1143.7 1159.9 14609.0 14770.7 14828.1 14871.7 16564.8 371233.0 374201.0 376528.1 376601.0 377358.0 54679.0 55196.7 55293.4 55299.0 55306.2 1339.6 1343.0 1349.1 1349.7 1364.2 28666.8 30523.4 32081.5 32494.8 32640.7 49811.8 50471.2 50505.7 50571.2 50624.0 278304.0 282786.0 284693.0 285010.0 286631.0 38111.4 39516.8 41487.5 46082.1 46489.5 43705.8 44090.3 44608.3 44696.8 45232.0 35435.5 37759.4 38141.5 38832.4 39080.2 36430.5 36829.1 37853.6 38001.4 38144.4 34944.3 35656.6 40148.0 40398.6 40615.0 29345.9 35499.6 37137.4 38240.0 38246.6 25483.4 26140.9 26169.3 26698.5 26950.2 05:44:52 INFO - 2015-11-26 05:44:52,655 DEBUG : BROWSER_OUTPUT: 05:44:52 INFO - 2015-11-26 05:44:52,655 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25153.41 Median:35978.64 stddev:69574.35 (193.4%) stddev-sans-first:69744.57 05:44:52 INFO - 2015-11-26 05:44:52,655 DEBUG : BROWSER_OUTPUT: Values: 338.0 338.8 340.5 341.1 352.5 14052.6 14487.4 16157.4 16305.7 17305.2 16064.0 16068.6 16117.3 16130.4 16192.9 4513.6 5247.1 5258.2 5261.7 5275.6 3912.7 4022.4 5321.3 5612.9 5769.6 5572.6 5590.7 5647.9 5669.2 5704.6 5456.9 5612.2 5614.2 5618.5 5626.3 4912.6 4918.4 4925.6 4936.3 4954.0 18992.3 19302.3 19338.4 19350.5 19914.6 2016.7 2026.8 2213.0 2242.2 2462.5 12724.7 12891.4 12906.0 13333.1 13419.5 1785.5 1791.7 1813.2 1854.4 1861.4 53126.7 53560.5 53993.7 54339.7 57656.7 9325.2 9329.6 9403.1 9483.7 9524.0 11916.2 11946.6 11951.5 11974.9 11976.2 6679.9 6913.2 6915.9 6938.5 7056.2 6782.6 6855.6 6886.7 6895.4 6939.7 4099.1 4140.9 4156.1 4180.7 4182.6 1638.9 1702.2 1715.6 2944.6 3040.4 836.6 895.0 907.3 973.6 1000.7 14059.9 16029.8 16127.2 16280.8 16642.6 905.4 912.2 959.9 974.7 1019.3 8170.4 9311.0 9370.2 9471.9 9679.0 333144.0 344830.0 386721.0 505370.0 513809.0 73855.6 79917.6 80172.2 80680.6 81444.6 1082.3 1099.5 1101.0 1102.1 1109.2 15409.5 15429.7 15452.8 15649.9 15898.5 35505.0 35861.6 36095.6 36220.1 36277.8 45858.8 48049.3 50215.0 50472.2 51078.5 9246.8 9564.2 9597.2 9604.1 9610.6 11213.5 11266.9 12079.8 17276.6 17581.6 14148.3 14249.7 14344.7 14451.3 14677.0 13521.9 13607.3 13842.4 14005.0 14022.6 14152.1 14203.9 14337.1 14469.8 14543.3 9254.0 9412.6 9519.0 9620.7 9643.8 14345.6 14554.1 14598.7 14704.7 14940.8 05:44:52 INFO - 2015-11-26 05:44:52,655 DEBUG : BROWSER_OUTPUT: 05:44:52 INFO - 2015-11-26 05:44:52,655 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5398.60 Median:6600.44 stddev:2806.21 (42.5%) stddev-sans-first:2799.43 05:44:52 INFO - 2015-11-26 05:44:52,656 DEBUG : BROWSER_OUTPUT: Values: 1584.0 1626.2 1690.1 1735.1 1779.8 6698.4 7426.1 7654.6 7656.0 7660.4 7453.3 7691.5 7779.6 7817.9 7830.0 1934.7 1983.1 1988.3 2247.6 2250.8 1977.0 2202.3 2246.5 2246.9 2249.2 2207.2 2239.8 2245.4 2270.7 2280.1 1913.7 1949.2 2186.8 2211.9 2215.0 2159.5 2209.2 2210.8 2213.4 2219.4 7601.4 7733.3 7746.0 7751.0 7760.9 4599.7 4686.8 4688.7 4693.0 4697.4 2993.2 3006.7 3016.3 3020.4 3041.6 977.9 979.5 989.4 1011.0 1029.8 10519.2 10536.0 10558.2 10577.7 10582.4 4145.0 4180.5 4231.8 4232.8 4249.5 9117.3 9118.7 9121.2 9121.6 9125.3 4618.0 4630.2 4676.1 4686.3 4705.2 4275.3 4276.1 4277.0 4278.1 4286.3 3733.9 3741.0 3757.5 3765.2 3768.4 1195.2 1207.5 1208.2 1214.8 1219.9 1300.3 1304.5 1337.8 1343.9 1344.3 7208.0 7263.2 7438.3 7441.9 7447.3 465.7 475.7 476.9 477.1 478.8 5451.8 5599.1 5769.0 5831.7 5937.4 8620.6 8688.2 8842.2 8915.8 8925.0 8801.5 8903.7 8923.5 8936.9 8944.2 7074.6 7076.0 7104.0 7150.7 7162.5 6930.2 7071.2 7086.9 7099.3 7109.9 8144.3 8230.9 8418.1 8425.4 8446.2 8288.0 8477.0 8553.5 8676.0 8686.8 6544.5 6862.3 6954.8 6967.6 6967.6 7440.0 7450.2 7460.8 7527.0 7595.3 7072.5 7079.0 7106.3 7199.2 7220.6 7028.1 7032.9 7088.0 7101.3 7168.4 7043.6 7115.0 7121.3 7126.1 7167.1 6558.9 6599.6 6601.3 6609.9 6611.3 6317.8 6670.6 6701.7 6709.6 6719.0 05:44:52 INFO - 2015-11-26 05:44:52,656 DEBUG : BROWSER_OUTPUT: 05:44:52 INFO - 2015-11-26 05:44:52,656 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5325.16 Median:6061.41 stddev:1597.69 (26.4%) stddev-sans-first:1557.46 05:44:52 INFO - 2015-11-26 05:44:52,657 DEBUG : BROWSER_OUTPUT: Values: 324.5 334.1 335.2 343.6 343.8 5878.8 6011.0 6055.0 6067.8 6076.3 5783.2 5914.6 5943.6 5973.2 5998.8 4559.0 4571.5 4574.3 4576.6 4585.2 4365.7 4429.7 4552.1 4575.8 4643.4 4565.8 4586.2 4589.8 4605.5 4622.2 4579.4 4587.8 4599.9 4600.3 4606.4 4040.8 4043.4 4046.8 4047.1 4047.9 5599.9 5645.4 5670.4 5682.8 5689.5 5352.5 5359.3 5366.0 5369.1 5370.9 6051.3 6337.7 6342.2 6343.1 6347.5 4290.9 4329.4 4402.4 4488.7 4489.7 6594.6 6599.9 6609.0 6616.8 6626.8 4478.9 4487.5 4491.9 4574.4 4584.8 4394.5 4416.7 4433.9 4539.8 4539.9 5213.9 5217.4 5222.2 5226.2 5231.2 6375.4 6379.3 6385.6 6390.7 6437.3 1622.7 1642.0 1643.0 1643.1 1644.3 1104.7 1105.6 1119.2 1131.3 1131.9 6158.9 6161.4 6163.0 6166.0 6170.3 6599.0 6609.8 6610.0 6616.5 6626.1 6007.2 6033.7 6145.8 6164.8 6170.6 3560.5 3593.0 3595.9 3598.4 3599.4 6763.9 6806.4 6810.7 6815.1 6821.5 6588.9 6591.6 6638.2 6672.8 6720.2 6776.1 6779.4 6779.6 6784.3 6804.3 6293.2 6480.6 6494.1 6495.7 6504.1 6236.0 6424.2 6433.8 6436.4 6438.7 6753.3 6867.2 6884.3 6884.9 6885.1 4628.6 4632.2 4638.4 4644.6 4648.8 6624.6 6640.5 6642.1 6643.5 6647.0 6236.7 6383.5 6383.5 6411.9 6472.6 6425.4 6431.2 6443.2 6445.9 6448.2 6168.6 6276.1 6313.8 6330.1 6333.1 6441.3 6446.3 6452.2 6455.8 6457.8 6124.1 6150.6 6162.4 6274.0 6282.9 05:44:52 INFO - 2015-11-26 05:44:52,657 DEBUG : BROWSER_OUTPUT: 05:44:52 INFO - 2015-11-26 05:44:52,657 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13736.78 Median:49063.64 stddev:16692.37 (34.0%) stddev-sans-first:16710.68 05:44:52 INFO - 2015-11-26 05:44:52,657 DEBUG : BROWSER_OUTPUT: Values: 742.9 826.1 847.2 850.0 855.3 12722.6 13005.6 13016.3 13044.2 13044.9 12251.5 12256.6 12262.5 12298.2 12321.4 678.3 684.1 800.0 815.0 831.5 816.2 821.9 822.9 826.2 828.4 701.7 771.9 832.7 860.7 860.8 704.8 829.3 856.2 864.4 866.5 642.5 643.9 645.1 645.6 645.7 12337.2 12461.7 12489.5 12507.0 12508.8 11023.6 11270.3 11953.6 12150.3 12497.9 9844.9 9997.7 10088.0 10118.6 10195.4 3499.5 3509.9 3549.1 3561.0 3577.1 47996.0 48446.5 48490.5 49129.3 49173.5 8905.6 8968.6 9063.1 9101.7 9192.9 18589.3 18599.3 18693.7 18708.0 18735.3 6884.8 7242.6 7332.0 7381.4 7570.7 4068.7 4151.8 4157.4 4172.4 4217.0 3026.3 3059.4 3066.0 3094.9 3120.9 521.5 532.0 535.0 537.0 537.1 517.5 596.6 635.2 642.8 669.6 7107.4 7197.4 7247.8 7399.3 7500.9 501.2 578.2 628.8 643.2 659.9 3490.6 3720.8 3728.8 3733.2 3794.5 59106.4 60572.7 60783.0 60787.7 60920.0 52398.5 52414.5 52789.2 53158.2 53923.0 47462.3 47667.5 48333.8 48919.5 48998.0 7172.4 7237.1 7249.7 7374.8 7432.8 35201.5 35944.8 36031.6 36768.8 37363.0 44809.3 47138.8 47403.0 47510.8 48033.0 10546.8 10806.5 10843.0 10972.2 11027.2 11326.5 11580.9 11723.2 11808.1 11829.6 10365.5 10753.2 11091.8 11199.3 11207.6 10101.7 10196.9 10378.9 10382.4 10465.2 10002.9 10306.8 10339.1 10343.6 10528.9 8794.2 8865.8 9198.4 9260.6 9357.6 7445.8 7717.0 7729.0 8039.4 8400.6 05:44:52 INFO - 2015-11-26 05:44:52,657 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:44:52 INFO - 2015-11-26 05:44:52,657 DEBUG : BROWSER_OUTPUT: 05:44:53 INFO - 2015-11-26 05:44:53,368 INFO : Browser exited with error code: 0 05:44:53 INFO - 2015-11-26 05:44:53,389 INFO : Completed test dromaeo_css (00:18:37) 05:44:53 INFO - 2015-11-26 05:44:53,390 INFO : Starting test kraken 05:44:53 INFO - 2015-11-26 05:44:53,390 DEBUG : operating with platform_type : linux_ 05:44:53 INFO - 2015-11-26 05:44:53,390 INFO : Initialising browser for kraken test... 05:44:53 INFO - 2015-11-26 05:44:53,396 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkwssgg/profile http://localhost:36584/getInfo.html 05:44:57 INFO - 2015-11-26 05:44:57,277 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:44:57 INFO - 2015-11-26 05:44:57,277 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:44:57 INFO - 2015-11-26 05:44:57,277 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:44:57 INFO - 2015-11-26 05:44:57,277 DEBUG : BROWSER_OUTPUT: __metrics 05:44:57 INFO - 2015-11-26 05:44:57,438 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] 05:44:58 INFO - 2015-11-26 05:44:58,715 INFO : Browser initialized. 05:44:58 INFO - 2015-11-26 05:44:58,716 INFO : Running cycle 1/1 for kraken test... 05:44:58 INFO - 2015-11-26 05:44:58,716 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkwssgg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:45:10 INFO - 2015-11-26 05:45:10,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 141258752 05:45:10 INFO - 2015-11-26 05:45:10,484 DEBUG : BROWSER_OUTPUT: 05:45:12 INFO - 2015-11-26 05:45:12,963 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36584/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36584/tests/kraken/driver.html?testName=audio-beat-detection) 05:45:13 INFO - 2015-11-26 05:45:13,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 176332800 05:45:13 INFO - 2015-11-26 05:45:13,536 DEBUG : BROWSER_OUTPUT: 05:45:16 INFO - 2015-11-26 05:45:16,173 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36584/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36584/tests/kraken/driver.html?testName=audio-dft) 05:45:16 INFO - 2015-11-26 05:45:16,739 DEBUG : BROWSER_OUTPUT: RSS: Main: 165707776 05:45:16 INFO - 2015-11-26 05:45:16,740 DEBUG : BROWSER_OUTPUT: 05:45:19 INFO - 2015-11-26 05:45:19,681 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36584/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36584/tests/kraken/driver.html?testName=audio-fft) 05:45:20 INFO - 2015-11-26 05:45:20,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 149843968 05:45:20 INFO - 2015-11-26 05:45:20,247 DEBUG : BROWSER_OUTPUT: 05:45:22 INFO - 2015-11-26 05:45:22,225 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36584/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36584/tests/kraken/driver.html?testName=audio-oscillator) 05:45:22 INFO - 2015-11-26 05:45:22,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 152014848 05:45:22 INFO - 2015-11-26 05:45:22,791 DEBUG : BROWSER_OUTPUT: 05:45:24 INFO - 2015-11-26 05:45:24,984 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36584/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36584/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:45:25 INFO - 2015-11-26 05:45:25,546 DEBUG : BROWSER_OUTPUT: RSS: Main: 154710016 05:45:25 INFO - 2015-11-26 05:45:25,546 DEBUG : BROWSER_OUTPUT: 05:45:28 INFO - 2015-11-26 05:45:28,455 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36584/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36584/tests/kraken/driver.html?testName=imaging-darkroom) 05:45:29 INFO - 2015-11-26 05:45:29,029 DEBUG : BROWSER_OUTPUT: RSS: Main: 155856896 05:45:29 INFO - 2015-11-26 05:45:29,030 DEBUG : BROWSER_OUTPUT: 05:45:32 INFO - 2015-11-26 05:45:32,416 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36584/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36584/tests/kraken/driver.html?testName=imaging-desaturate) 05:45:32 INFO - 2015-11-26 05:45:32,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 155590656 05:45:32 INFO - 2015-11-26 05:45:32,989 DEBUG : BROWSER_OUTPUT: 05:45:35 INFO - 2015-11-26 05:45:35,731 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36584/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36584/tests/kraken/driver.html?testName=json-parse-financial) 05:45:36 INFO - 2015-11-26 05:45:36,300 DEBUG : BROWSER_OUTPUT: RSS: Main: 157216768 05:45:36 INFO - 2015-11-26 05:45:36,300 DEBUG : BROWSER_OUTPUT: 05:45:37 INFO - 2015-11-26 05:45:37,836 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36584/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36584/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:45:38 INFO - 2015-11-26 05:45:38,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 166658048 05:45:38 INFO - 2015-11-26 05:45:38,397 DEBUG : BROWSER_OUTPUT: 05:45:40 INFO - 2015-11-26 05:45:40,228 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36584/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36584/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:45:40 INFO - 2015-11-26 05:45:40,817 DEBUG : BROWSER_OUTPUT: RSS: Main: 164614144 05:45:40 INFO - 2015-11-26 05:45:40,817 DEBUG : BROWSER_OUTPUT: 05:45:42 INFO - 2015-11-26 05:45:42,882 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36584/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36584/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:45:43 INFO - 2015-11-26 05:45:43,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 170180608 05:45:43 INFO - 2015-11-26 05:45:43,463 DEBUG : BROWSER_OUTPUT: 05:45:45 INFO - 2015-11-26 05:45:45,879 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36584/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36584/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:45:46 INFO - 2015-11-26 05:45:46,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 175443968 05:45:46 INFO - 2015-11-26 05:45:46,460 DEBUG : BROWSER_OUTPUT: 05:45:49 INFO - 2015-11-26 05:45:49,016 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36584/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36584/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:45:49 INFO - 2015-11-26 05:45:49,582 DEBUG : BROWSER_OUTPUT: RSS: Main: 175337472 05:45:49 INFO - 2015-11-26 05:45:49,582 DEBUG : BROWSER_OUTPUT: 05:45:51 INFO - 2015-11-26 05:45:51,216 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36584/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36584/tests/kraken/driver.html?testName=ai-astar) 05:45:51 INFO - 2015-11-26 05:45:51,466 DEBUG : BROWSER_OUTPUT: RSS: Main: 235569152 05:45:51 INFO - 2015-11-26 05:45:51,466 DEBUG : BROWSER_OUTPUT: 05:45:51 INFO - 2015-11-26 05:45:51,469 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:45:51 INFO - 2015-11-26 05:45:51,470 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:45:51 INFO - 2015-11-26 05:45:51,470 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:45:51 INFO - 2015-11-26 05:45:51,470 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:45:51 INFO - 2015-11-26 05:45:51,470 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;112;104;111;111;113;101;112;113;105 05:45:51 INFO - 2015-11-26 05:45:51,470 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;133;162;160;126;162;150;127;162;126 05:45:51 INFO - 2015-11-26 05:45:51,470 DEBUG : BROWSER_OUTPUT: |2;audio-dft;165;167;162;163;163;163;167;167;162;165 05:45:51 INFO - 2015-11-26 05:45:51,470 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;73;87;92;72;74;77;115;91;72 05:45:51 INFO - 2015-11-26 05:45:51,470 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;136;95;95;96;137;93;93;132 05:45:51 INFO - 2015-11-26 05:45:51,471 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;112;112;111;110;111;111;110;110;110 05:45:51 INFO - 2015-11-26 05:45:51,471 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;145;146;146;145;146;145;147;145;145 05:45:51 INFO - 2015-11-26 05:45:51,471 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;95;96;95;95;96;96;96 05:45:51 INFO - 2015-11-26 05:45:51,471 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;57;58;57;57;56;57;59;58;57 05:45:51 INFO - 2015-11-26 05:45:51,471 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;71;70;71;71;71;70;71;70;71 05:45:51 INFO - 2015-11-26 05:45:51,471 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;94;85;85;93;84;86;86;87;86 05:45:51 INFO - 2015-11-26 05:45:51,471 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;116;120;113;123;121;116;133;118;130 05:45:51 INFO - 2015-11-26 05:45:51,472 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;150;150;151;148;139;152;150;146;135 05:45:51 INFO - 2015-11-26 05:45:51,472 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;65;64;66;65;66;65;68;66;65 05:45:51 INFO - 2015-11-26 05:45:51,472 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:45:51 INFO - 2015-11-26 05:45:51,472 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:45:51 INFO - 2015-11-26 05:45:51,472 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,905 05:45:51 INFO - 2015-11-26 05:45:51,472 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:45:51 INFO - 2015-11-26 05:45:51,472 DEBUG : BROWSER_OUTPUT: __startTimestamp1448545551467__endTimestamp 05:45:51 INFO - 2015-11-26 05:45:51,472 DEBUG : BROWSER_OUTPUT: 05:45:51 INFO - 2015-11-26 05:45:51,475 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:45:51 INFO - 2015-11-26 05:45:51,476 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:45:51 INFO - 2015-11-26 05:45:51,476 DEBUG : BROWSER_OUTPUT: 05:45:51 INFO - 2015-11-26 05:45:51,476 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.10 Median:111.50 stddev:4.25 (3.8%) stddev-sans-first:4.51 05:45:51 INFO - 2015-11-26 05:45:51,476 DEBUG : BROWSER_OUTPUT: Values: 109.0 112.0 104.0 111.0 111.0 113.0 101.0 112.0 113.0 105.0 05:45:51 INFO - 2015-11-26 05:45:51,476 DEBUG : BROWSER_OUTPUT: 05:45:51 INFO - 2015-11-26 05:45:51,476 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.90 Median:155.50 stddev:16.11 (10.4%) stddev-sans-first:16.98 05:45:51 INFO - 2015-11-26 05:45:51,476 DEBUG : BROWSER_OUTPUT: Values: 151.0 133.0 162.0 160.0 126.0 162.0 150.0 127.0 162.0 126.0 05:45:51 INFO - 2015-11-26 05:45:51,476 DEBUG : BROWSER_OUTPUT: 05:45:51 INFO - 2015-11-26 05:45:51,476 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.40 Median:165.00 stddev:2.07 (1.3%) stddev-sans-first:2.18 05:45:51 INFO - 2015-11-26 05:45:51,476 DEBUG : BROWSER_OUTPUT: Values: 165.0 167.0 162.0 163.0 163.0 163.0 167.0 167.0 162.0 165.0 05:45:51 INFO - 2015-11-26 05:45:51,476 DEBUG : BROWSER_OUTPUT: 05:45:51 INFO - 2015-11-26 05:45:51,476 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.40 Median:75.50 stddev:14.08 (18.6%) stddev-sans-first:14.32 05:45:51 INFO - 2015-11-26 05:45:51,476 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 87.0 92.0 72.0 74.0 77.0 115.0 91.0 72.0 05:45:51 INFO - 2015-11-26 05:45:51,476 DEBUG : BROWSER_OUTPUT: 05:45:51 INFO - 2015-11-26 05:45:51,477 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.30 Median:93.00 stddev:19.87 (21.4%) stddev-sans-first:20.49 05:45:51 INFO - 2015-11-26 05:45:51,477 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 136.0 95.0 95.0 96.0 137.0 93.0 93.0 132.0 05:45:51 INFO - 2015-11-26 05:45:51,477 DEBUG : BROWSER_OUTPUT: 05:45:51 INFO - 2015-11-26 05:45:51,477 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.80 Median:111.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 05:45:51 INFO - 2015-11-26 05:45:51,477 DEBUG : BROWSER_OUTPUT: Values: 111.0 112.0 112.0 111.0 110.0 111.0 111.0 110.0 110.0 110.0 05:45:51 INFO - 2015-11-26 05:45:51,477 DEBUG : BROWSER_OUTPUT: 05:45:51 INFO - 2015-11-26 05:45:51,477 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 05:45:51 INFO - 2015-11-26 05:45:51,477 DEBUG : BROWSER_OUTPUT: Values: 147.0 145.0 146.0 146.0 145.0 146.0 145.0 147.0 145.0 145.0 05:45:51 INFO - 2015-11-26 05:45:51,477 DEBUG : BROWSER_OUTPUT: 05:45:51 INFO - 2015-11-26 05:45:51,477 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 05:45:51 INFO - 2015-11-26 05:45:51,477 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 05:45:51 INFO - 2015-11-26 05:45:51,477 DEBUG : BROWSER_OUTPUT: 05:45:51 INFO - 2015-11-26 05:45:51,477 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.50 Median:57.50 stddev:0.97 (1.7%) stddev-sans-first:0.87 05:45:51 INFO - 2015-11-26 05:45:51,478 DEBUG : BROWSER_OUTPUT: Values: 59.0 57.0 58.0 57.0 57.0 56.0 57.0 59.0 58.0 57.0 05:45:51 INFO - 2015-11-26 05:45:51,478 DEBUG : BROWSER_OUTPUT: 05:45:51 INFO - 2015-11-26 05:45:51,478 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:71.00 stddev:0.52 (0.7%) stddev-sans-first:0.50 05:45:51 INFO - 2015-11-26 05:45:51,478 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 70.0 71.0 71.0 71.0 70.0 71.0 70.0 71.0 05:45:51 INFO - 2015-11-26 05:45:51,478 DEBUG : BROWSER_OUTPUT: 05:45:51 INFO - 2015-11-26 05:45:51,478 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:86.00 stddev:3.56 (4.1%) stddev-sans-first:3.61 05:45:51 INFO - 2015-11-26 05:45:51,478 DEBUG : BROWSER_OUTPUT: Values: 84.0 94.0 85.0 85.0 93.0 84.0 86.0 86.0 87.0 86.0 05:45:51 INFO - 2015-11-26 05:45:51,478 DEBUG : BROWSER_OUTPUT: 05:45:51 INFO - 2015-11-26 05:45:51,478 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:121.50 stddev:6.27 (5.2%) stddev-sans-first:6.64 05:45:51 INFO - 2015-11-26 05:45:51,478 DEBUG : BROWSER_OUTPUT: Values: 122.0 116.0 120.0 113.0 123.0 121.0 116.0 133.0 118.0 130.0 05:45:51 INFO - 2015-11-26 05:45:51,479 DEBUG : BROWSER_OUTPUT: 05:45:51 INFO - 2015-11-26 05:45:51,479 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.10 Median:150.00 stddev:5.95 (4.0%) stddev-sans-first:5.89 05:45:51 INFO - 2015-11-26 05:45:51,479 DEBUG : BROWSER_OUTPUT: Values: 140.0 150.0 150.0 151.0 148.0 139.0 152.0 150.0 146.0 135.0 05:45:51 INFO - 2015-11-26 05:45:51,479 DEBUG : BROWSER_OUTPUT: 05:45:51 INFO - 2015-11-26 05:45:51,479 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:2.02 (3.1%) stddev-sans-first:1.13 05:45:51 INFO - 2015-11-26 05:45:51,479 DEBUG : BROWSER_OUTPUT: Values: 71.0 65.0 64.0 66.0 65.0 66.0 65.0 68.0 66.0 65.0 05:45:51 INFO - 2015-11-26 05:45:51,479 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:45:51 INFO - 2015-11-26 05:45:51,479 DEBUG : BROWSER_OUTPUT: 05:45:52 INFO - 2015-11-26 05:45:52,284 INFO : Browser exited with error code: 0 05:45:52 INFO - 2015-11-26 05:45:52,338 INFO : Completed test kraken (00:00:58) 05:45:52 INFO - 2015-11-26 05:45:52,338 INFO : Starting test v8_7 05:45:52 INFO - 2015-11-26 05:45:52,338 DEBUG : operating with platform_type : linux_ 05:45:52 INFO - 2015-11-26 05:45:52,338 INFO : Initialising browser for v8_7 test... 05:45:52 INFO - 2015-11-26 05:45:52,344 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWber3N/profile http://localhost:36584/getInfo.html 05:45:56 INFO - 2015-11-26 05:45:56,201 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:45:56 INFO - 2015-11-26 05:45:56,202 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:45:56 INFO - 2015-11-26 05:45:56,202 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:45:56 INFO - 2015-11-26 05:45:56,202 DEBUG : BROWSER_OUTPUT: __metrics 05:45:56 INFO - 2015-11-26 05:45:56,291 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] 05:45:57 INFO - 2015-11-26 05:45:57,613 INFO : Browser initialized. 05:45:57 INFO - 2015-11-26 05:45:57,613 INFO : Running cycle 1/1 for v8_7 test... 05:45:57 INFO - 2015-11-26 05:45:57,613 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWber3N/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:46:09 INFO - 2015-11-26 05:46:09,283 DEBUG : BROWSER_OUTPUT: RSS: Main: 139591680 05:46:09 INFO - 2015-11-26 05:46:09,284 DEBUG : BROWSER_OUTPUT: 05:46:30 INFO - 2015-11-26 05:46:30,757 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36584/tests/v8_7/run.html (next: http://localhost:36584/tests/v8_7/run.html) 05:46:31 INFO - 2015-11-26 05:46:31,007 DEBUG : BROWSER_OUTPUT: RSS: Main: 616337408 05:46:31 INFO - 2015-11-26 05:46:31,007 DEBUG : BROWSER_OUTPUT: 05:46:31 INFO - 2015-11-26 05:46:31,007 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:46:31 INFO - 2015-11-26 05:46:31,007 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:46:31 INFO - 2015-11-26 05:46:31,007 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:46:31 INFO - 2015-11-26 05:46:31,008 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:46:31 INFO - 2015-11-26 05:46:31,008 DEBUG : BROWSER_OUTPUT: |0;Richards;166.16816218012627 05:46:31 INFO - 2015-11-26 05:46:31,008 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.81784531463083 05:46:31 INFO - 2015-11-26 05:46:31,009 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.4141069397042 05:46:31 INFO - 2015-11-26 05:46:31,009 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 05:46:31 INFO - 2015-11-26 05:46:31,009 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1096.4912280701753 05:46:31 INFO - 2015-11-26 05:46:31,009 DEBUG : BROWSER_OUTPUT: |5;Earley;780.0312012480499 05:46:31 INFO - 2015-11-26 05:46:31,010 DEBUG : BROWSER_OUTPUT: |6;Boyer;12304.878048780487 05:46:31 INFO - 2015-11-26 05:46:31,010 DEBUG : BROWSER_OUTPUT: |7;RegExp;25525 05:46:31 INFO - 2015-11-26 05:46:31,010 DEBUG : BROWSER_OUTPUT: |8;Splay;621.8905472636816 05:46:31 INFO - 2015-11-26 05:46:31,010 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 05:46:31 INFO - 2015-11-26 05:46:31,010 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:46:31 INFO - 2015-11-26 05:46:31,011 DEBUG : BROWSER_OUTPUT: __startTimestamp1448545591004__endTimestamp 05:46:31 INFO - 2015-11-26 05:46:31,011 DEBUG : BROWSER_OUTPUT: 05:46:31 INFO - 2015-11-26 05:46:31,011 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:46:31 INFO - 2015-11-26 05:46:31,011 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:46:31 INFO - 2015-11-26 05:46:31,012 DEBUG : BROWSER_OUTPUT: 05:46:31 INFO - 2015-11-26 05:46:31,012 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.17 Median:166.17 stddev:0.00 (0.0%) 05:46:31 INFO - 2015-11-26 05:46:31,012 DEBUG : BROWSER_OUTPUT: Values: 166.2 05:46:31 INFO - 2015-11-26 05:46:31,012 DEBUG : BROWSER_OUTPUT: 05:46:31 INFO - 2015-11-26 05:46:31,012 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.82 Median:194.82 stddev:0.00 (0.0%) 05:46:31 INFO - 2015-11-26 05:46:31,012 DEBUG : BROWSER_OUTPUT: Values: 194.8 05:46:31 INFO - 2015-11-26 05:46:31,012 DEBUG : BROWSER_OUTPUT: 05:46:31 INFO - 2015-11-26 05:46:31,012 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.41 Median:284.41 stddev:0.00 (0.0%) 05:46:31 INFO - 2015-11-26 05:46:31,012 DEBUG : BROWSER_OUTPUT: Values: 284.4 05:46:31 INFO - 2015-11-26 05:46:31,013 DEBUG : BROWSER_OUTPUT: 05:46:31 INFO - 2015-11-26 05:46:31,013 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 05:46:31 INFO - 2015-11-26 05:46:31,013 DEBUG : BROWSER_OUTPUT: Values: 5186.5 05:46:31 INFO - 2015-11-26 05:46:31,013 DEBUG : BROWSER_OUTPUT: 05:46:31 INFO - 2015-11-26 05:46:31,013 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1096.49 Median:1096.49 stddev:0.00 (0.0%) 05:46:31 INFO - 2015-11-26 05:46:31,013 DEBUG : BROWSER_OUTPUT: Values: 1096.5 05:46:31 INFO - 2015-11-26 05:46:31,013 DEBUG : BROWSER_OUTPUT: 05:46:31 INFO - 2015-11-26 05:46:31,013 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:780.03 Median:780.03 stddev:0.00 (0.0%) 05:46:31 INFO - 2015-11-26 05:46:31,013 DEBUG : BROWSER_OUTPUT: Values: 780.0 05:46:31 INFO - 2015-11-26 05:46:31,013 DEBUG : BROWSER_OUTPUT: 05:46:31 INFO - 2015-11-26 05:46:31,013 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12304.88 Median:12304.88 stddev:0.00 (0.0%) 05:46:31 INFO - 2015-11-26 05:46:31,013 DEBUG : BROWSER_OUTPUT: Values: 12304.9 05:46:31 INFO - 2015-11-26 05:46:31,013 DEBUG : BROWSER_OUTPUT: 05:46:31 INFO - 2015-11-26 05:46:31,013 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25525.00 Median:25525.00 stddev:0.00 (0.0%) 05:46:31 INFO - 2015-11-26 05:46:31,013 DEBUG : BROWSER_OUTPUT: Values: 25525.0 05:46:31 INFO - 2015-11-26 05:46:31,014 DEBUG : BROWSER_OUTPUT: 05:46:31 INFO - 2015-11-26 05:46:31,014 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:621.89 Median:621.89 stddev:0.00 (0.0%) 05:46:31 INFO - 2015-11-26 05:46:31,014 DEBUG : BROWSER_OUTPUT: Values: 621.9 05:46:31 INFO - 2015-11-26 05:46:31,014 DEBUG : BROWSER_OUTPUT: 05:46:31 INFO - 2015-11-26 05:46:31,014 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 05:46:31 INFO - 2015-11-26 05:46:31,014 DEBUG : BROWSER_OUTPUT: Values: 4830.9 05:46:31 INFO - 2015-11-26 05:46:31,014 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:46:31 INFO - 2015-11-26 05:46:31,014 DEBUG : BROWSER_OUTPUT: 05:46:31 INFO - 2015-11-26 05:46:31,832 INFO : Browser exited with error code: 0 05:46:31 INFO - 2015-11-26 05:46:31,847 INFO : Completed test v8_7 (00:00:39) 05:46:31 INFO - 2015-11-26 05:46:31,964 INFO : Completed test suite (00:20:15) 05:46:31 INFO - 2015-11-26 05:46:31,965 DEBUG : Working with test: dromaeo_css 05:46:31 INFO - 2015-11-26 05:46:31,965 DEBUG : Generating results file: dromaeo_css 05:46:31 INFO - 2015-11-26 05:46:31,966 DEBUG : Working with test: kraken 05:46:31 INFO - 2015-11-26 05:46:31,966 DEBUG : Generating results file: kraken 05:46:31 INFO - 2015-11-26 05:46:31,966 INFO : javascript benchmark 05:46:31 INFO - 2015-11-26 05:46:31,966 DEBUG : Working with test: v8_7 05:46:31 INFO - 2015-11-26 05:46:31,967 DEBUG : Generating results file: v8_7 05:46:31 INFO - 2015-11-26 05:46:31,967 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:46:32 INFO - 2015-11-26 05:46:32,025 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 05:46:32 INFO - 2015-11-26 05:46:32,026 DEBUG : process_Request line: dromaeo_css 6967.61 graph.html#tests=[[72,64,35]] 05:46:32 INFO - 2015-11-26 05:46:32,026 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:46:32 INFO - 2015-11-26 05:46:32,059 DEBUG : process_Request line: kraken 1508.70 graph.html#tests=[[232,64,35]] 05:46:32 INFO - 2015-11-26 05:46:32,059 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:46:32 INFO - 2015-11-26 05:46:32,100 DEBUG : process_Request line: v8_7 20934.73 graph.html#tests=[[230,64,35]] 05:46:32 INFO - 2015-11-26 05:46:32,101 INFO : javascript benchmark 05:46:32 INFO - 2015-11-26 05:46:32,104 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3181.1092893989685, 3207.3745619604188, 3256.6906143916335, 3257.283397652517, 3293.094399040263, 5236.764345604447, 5343.625946183769, 5456.618036737425, 5476.790642529065, 5480.890382192354, 5398.379186393566, 5407.729613519318, 5439.755211015504, 5494.972525137368, 5558.194061861028, 4908.239222920444, 4945.0, 4977.825776097838, 5013.799448022075, 5044.117279476095, 4882.926756098661, 4973.104841128596, 4988.700677959316, 5025.673331233476, 5051.166557518005, 4841.540053694911, 4889.486603906575, 4933.210686290212, 4950.925736113961, 4956.653034287583, 4958.231474121517, 5005.549500544968, 5018.996200759862, 5025.974870125626, 5062.443131255559, 4773.522647735199, 4969.304297398331, 4974.1543937530705, 4991.500849915015, 5062.265971434122, 5182.326297581328, 5244.292020577212, 5272.789088436458, 5288.286081379041, 5306.9120830230095, 5926.614770039977, 5947.762089516415, 5950.285965684102, 5951.137085122677, 5952.434518720715, 5602.327720673546, 5776.249087618583, 5998.610090344114, 6015.639061656315, 6017.428344307327, 5420.566354691615, 5481.040817856859, 5495.917561236504, 5516.91724624131, 5564.081926482166, 5971.343152253248, 5976.85057873548, 5978.910316345258, 5981.820545383645, 6032.336442991267, 5609.943900560942, 5653.491185793298, 5814.709264536757, 5815.563832712563, 5823.475887170091, 5826.941730582725, 5842.444967728059, 5920.8815823684145, 5936.436038576415, 5950.67271300074, 5861.736221870026, 5866.120081987736, 5867.0, 5874.794382196603, 5921.230240068763, 5816.651000939957, 5861.589688721749, 5879.617824841372, 5899.203607512931, 5959.612625179349, 4384.0, 4462.085272519126, 4471.441069866267, 4506.842260520866, 4535.886602834956, 4062.898427539335, 4067.5322337930925, 4069.104796944667, 4084.0606660467665, 4099.508059032935, 5356.625036247426, 5388.110961691277, 5579.804706835323, 5593.496585307342, 5593.524550413179, 5850.531957443394, 5902.675352855548, 5929.080992446177, 5937.317208521075, 5957.404259574095, 5537.556995440355, 5542.836004439032, 5544.861378465571, 5550.833474995757, 5566.972165139148, 5009.649324547247, 5132.435432102466, 5137.357830271216, 5142.61430392722, 5187.04039752647, 6018.488428483541, 6116.266048074171, 6118.661318325914, 6124.718826527842, 6126.936481897893, 5846.94153058464, 5864.706764661835, 5867.853303667443, 5873.148393483007, 5908.852278693067, 6016.909746353721, 6020.849478763066, 6095.801078121753, 6104.236970378703, 6110.236220472441, 5674.546036317002, 5747.597668163188, 5747.597668163356, 5754.136879468113, 5799.420057994167, 5702.258706368146, 5747.109198074305, 5749.885002300014, 5752.0, 5753.769849205984, 5484.725763711719, 5587.832365029056, 5596.832095037155, 5616.213730077874, 5619.2133101365025, 5667.659940403589, 5735.311762588349, 5736.168255602831, 5738.053221218453, 5788.189653448437, 5581.74882130297, 5582.637128586629, 5584.860378490408, 5593.0, 5594.908992746376, 5578.3584887738425, 5690.71546422669, 5703.144528320785, 5746.13807928814, 5770.451807078321, 5674.432556744293, 5695.316562012585, 5726.713664316851, 5728.083506638918, 5739.426057394227], "unit": "ms", "name": "dojo.html", "value": 5396.293714177095}, {"lowerIsBetter": false, "replicates": [541.7953041293208, 574.2649408756793, 578.051994728645, 588.2206076948042, 595.8867815115125, 31339.0, 32036.67963320366, 40103.79948100263, 40519.0, 40669.389959150634, 42405.57594424055, 42810.35784463236, 42871.142577148436, 42958.35562466565, 42985.14029719404, 7558.886616700754, 7697.499662521918, 8660.826783464312, 8841.29269658429, 8841.38110332277, 10416.479176041206, 10565.894341056606, 10701.036906678397, 10709.143268538537, 10721.35671859691, 10336.224783141257, 10416.531256093494, 10426.947865260663, 10431.374117552934, 10434.426106564137, 7561.735339263127, 7727.111382191008, 7731.7680469586, 10341.172706183524, 10518.842217366746, 10146.746331341701, 10347.689569312857, 10350.637727679496, 10354.689359319233, 10362.48187590625, 39637.0, 39873.60126398757, 39951.0, 40015.39976900349, 40037.39943900844, 3090.227443139215, 3133.9843300783577, 3192.4892017277357, 3332.1836150143126, 3589.6410358963894, 29768.70231297681, 30005.69994300051, 30027.0, 30227.546586801214, 30752.231194220323, 3815.5993620669706, 3854.672352850011, 3910.687145028391, 3936.4306836145042, 3981.880543583697, 258953.0, 263169.0, 263249.0, 263407.6829615859, 263424.0, 56576.0, 57784.422155778746, 59711.701441492514, 60240.39759602348, 60333.39666603278, 56603.0, 56654.716726416926, 56672.43327566671, 56941.14588281179, 56961.71519142378, 15509.224538773016, 15703.68592628141, 15720.842791572166, 15746.76379854303, 15754.842451575567, 11709.824352634718, 11780.469878855472, 11795.941020294844, 11831.763364732657, 11834.940825295991, 19036.238550458103, 19113.853168809917, 19122.33071842479, 19147.61704765897, 19172.233110675697, 7768.53388796674, 7971.202879711982, 7973.641186146638, 8050.396220283502, 8069.475484093633, 909.3225546967419, 961.2598299309632, 980.8724865767405, 1016.1667432705111, 1061.1881910338598, 27764.444711105665, 27858.442831143264, 28024.579631305547, 28049.719502805117, 28210.576841347396, 1021.1983592879702, 1032.7521394865178, 1063.1760385700989, 1143.7369405036889, 1159.9246049006788, 14609.0, 14770.704585908437, 14828.072350594353, 14871.702565948837, 16564.83435165657, 371233.0, 374201.0, 376528.11735941144, 376601.0, 377358.0, 54679.0, 55196.72401637966, 55293.44706552963, 55299.0, 55306.17040744392, 1339.6127681842045, 1342.9597112086653, 1349.1163288046346, 1349.7165595224917, 1364.1542243808901, 28666.843307719846, 30523.38953220879, 32081.518777217894, 32494.837525813164, 32640.673593263764, 49811.75094124506, 50471.24293135679, 50505.74747126241, 50571.2414313793, 50624.0, 278304.0, 282786.0, 284693.0, 285010.0, 286631.0, 38111.42832857565, 39516.80241598774, 41487.51074935513, 46082.07835843331, 46489.53510464852, 43705.78147109372, 44090.33864491971, 44608.33087503755, 44696.776516117214, 45232.0, 35435.46846797249, 37759.43360849535, 38141.48329096182, 38832.41751373675, 39080.218395632495, 36430.453543196345, 36829.07927301839, 37853.621463785006, 38001.42997854979, 38144.42783358196, 34944.30111397809, 35656.64343356637, 40148.0, 40398.59601404066, 40615.0, 29345.85327073351, 35499.64500354963, 37137.44293835541, 38240.0, 38246.617533824305, 25483.36291592725, 26140.8692956534, 26169.345766355233, 26698.466030679665, 26950.191494255203], "unit": "ms", "name": "ext.html", "value": 19194.638302864143}, {"lowerIsBetter": false, "replicates": [337.9678930501603, 338.75271052131944, 340.490966005821, 341.1488336600183, 352.5082509898691, 14052.578422647312, 14487.420503179861, 16157.43448979286, 16305.673886522263, 17305.22126504307, 16064.0, 16068.598285042879, 16117.27472263748, 16130.354785808553, 16192.919035404835, 4513.638908887289, 5247.055530004598, 5258.237555554442, 5261.684578855286, 5275.577953763709, 3912.7456715313556, 4022.3966405039187, 5321.308229930123, 5612.915806262909, 5769.624974376673, 5572.60991730579, 5590.720463976805, 5647.887042259153, 5669.206311116447, 5704.572157088235, 5456.945430545684, 5612.186232996233, 5614.214010038578, 5618.494335509783, 5626.2967129108865, 4912.631552633567, 4918.385201849769, 4925.556699896991, 4936.33359496467, 4954.0, 18992.335268265684, 19302.32441864528, 19338.41984740446, 19350.516237094045, 19914.60170796576, 2016.6773316269473, 2026.7871873453223, 2213.0373287619936, 2242.159190303636, 2462.470568827711, 12724.681882952907, 12891.419886105054, 12906.0, 13333.133346332457, 13419.530316438975, 1785.526835388623, 1791.7491551182845, 1813.202191035953, 1854.3695143651223, 1861.3764388929724, 53126.73436632831, 53560.464395355935, 53993.730031349594, 54339.728301358635, 57656.71171644157, 9325.160735533835, 9329.580168892417, 9403.106704863027, 9483.66807161746, 9524.04759524056, 11916.225445346197, 11946.641600751991, 11951.521939122511, 11974.940125299318, 11976.221545599508, 6679.899801502981, 6913.170419549586, 6915.89626155608, 6938.514303998772, 7056.223815380304, 6782.559133656297, 6855.5543889647015, 6886.724531018703, 6895.4138898194215, 6939.722411103499, 4099.057216840143, 4140.937885931713, 4156.147989662112, 4180.728252663567, 4182.644475219579, 1638.8934719243211, 1702.1999660159704, 1715.613986852948, 2944.558316252579, 3040.3919216156855, 836.5733475927199, 894.9955250223837, 907.3240435875183, 973.571628483465, 1000.6647772996128, 14059.929700351433, 16029.759553606706, 16127.193640317937, 16280.75578866318, 16642.58393540171, 905.366243629462, 912.2018234045211, 959.9376040557341, 974.668612671695, 1019.3323373190572, 8170.42807003504, 9311.0, 9370.156685898302, 9471.857922131174, 9678.95160524193, 333144.0, 344830.0, 386721.0, 505370.0, 513809.0, 73855.63072184604, 79917.60041199757, 80172.19397321065, 80680.59659701781, 81444.59277703574, 1082.32895604724, 1099.4997276239292, 1100.9504572294106, 1102.0687519046394, 1109.1847492093304, 15409.460668876536, 15429.691406172038, 15452.84547154559, 15649.921750391175, 15898.52304430869, 35505.0, 35861.64138358583, 36095.639043609226, 36220.09449763777, 36277.818610906776, 45858.77070614626, 48049.279260810414, 50215.0, 50472.24291635702, 51078.48921510886, 9246.815063698823, 9564.187044101329, 9597.23222142241, 9604.135627793532, 9610.615575376907, 11213.495392707184, 11266.887331126913, 12079.75840483203, 17276.568085797957, 17581.648367032332, 14148.292585370897, 14249.715005700034, 14344.713105738036, 14451.27743612794, 14677.0, 13521.932390337985, 13607.319634018457, 13842.4463021478, 14005.0, 14022.649433764238, 14152.080114792505, 14203.928980355033, 14337.139771613736, 14469.782953255499, 14543.272836357928, 9253.953730231306, 9412.623495060121, 9518.95240523793, 9620.663276785559, 9643.758906027406, 14345.569632911029, 14554.12675239489, 14598.708025839636, 14704.705905882036, 14940.7758883619], "unit": "ms", "name": "jquery.html", "value": 8680.089141674825}, {"lowerIsBetter": false, "replicates": [1584.0, 1626.2275419175894, 1690.0704612463142, 1735.1324337831084, 1779.7508348831159, 6698.3971442570155, 7426.071741032371, 7654.617269136549, 7656.0, 7660.4254680898875, 7453.254674532557, 7691.4615976881505, 7779.611019449033, 7817.92182078179, 7830.0, 1934.7001214811726, 1983.1076015792878, 1988.3438465306415, 2247.6291411917014, 2250.7636698146703, 1976.980230197694, 2202.273249827561, 2246.5057687308768, 2246.86518808872, 2249.1902914950606, 2207.249535158046, 2239.787220214085, 2245.4049676835652, 2270.6821045053625, 2280.053777682268, 1913.6746753052014, 1949.2008276606664, 2186.8250539956844, 2211.9115235390564, 2214.977850221493, 2159.5033142377183, 2209.2488553891594, 2210.823134149264, 2213.424509627492, 2219.4451387153213, 7601.391888648895, 7733.304002639733, 7745.961270193669, 7750.961245193738, 7760.9223907761325, 4599.701019433726, 4686.789094490756, 4688.695234809727, 4693.037927224911, 4697.436307643105, 2993.176876358997, 3006.744426723731, 3016.306249562591, 3020.4412183746076, 3041.574179614856, 977.9119879210834, 979.5200351827624, 989.4063561862897, 1010.9848352274722, 1029.763154474475, 10519.158467322595, 10535.999080087457, 10558.208134389952, 10577.682669519927, 10582.417967011888, 4145.046639272924, 4180.519240287345, 4231.7516332681935, 4232.830686772556, 4249.490061192677, 9117.31620128493, 9118.726438206864, 9121.179093881583, 9121.635134594542, 9125.315601329794, 4618.0, 4630.236011058138, 4676.111538807616, 4686.250199968057, 4705.153072446924, 4275.337322714984, 4276.144771045803, 4277.03766652507, 4278.122984788111, 4286.314189729628, 3733.9439908401396, 3741.0460332615007, 3757.4739536464917, 3765.171662234304, 3768.4158955361413, 1195.2469943935266, 1207.5169932027084, 1208.2206976500283, 1214.769193853165, 1219.890209881115, 1300.343326620051, 1304.4977683591885, 1337.7525157845635, 1343.8656134386679, 1344.300963498975, 7208.0, 7263.201047884729, 7438.256174382626, 7441.888371674429, 7447.255274472618, 465.74151346003293, 475.66227978135913, 476.8783960090155, 477.1030462730045, 478.75344197738195, 5451.754671039813, 5599.104143337128, 5769.048107062372, 5831.737571809279, 5937.376575459601, 8620.61207245663, 8688.218060374471, 8842.159994800484, 8915.821683566292, 8924.955375223082, 8801.47191168532, 8903.73288801337, 8923.464592124363, 8936.8659470108, 8944.195022448012, 7074.646267686595, 7075.964620176866, 7104.0, 7150.678219480136, 7162.534435261691, 6930.168379794457, 7071.151461824408, 7086.929130708627, 7099.290070992859, 7109.8578028438105, 8144.30773384269, 8230.917690823255, 8418.116097809887, 8425.368097392597, 8446.155384461505, 8288.0, 8476.957615212132, 8553.486790792324, 8676.0, 8686.82626347482, 6544.54188206821, 6862.348076932683, 6954.756583519755, 6967.581945083311, 6967.616781077089, 7439.962800185965, 7450.217727138789, 7460.776176714708, 7526.962365188139, 7595.3164215220895, 7072.504924655224, 7079.0, 7106.289371062852, 7199.2440793715905, 7220.638968051681, 7028.051213086168, 7032.894506582507, 7087.964560177166, 7101.325374089453, 7168.4265258780215, 7043.647817609201, 7115.0, 7121.323474269936, 7126.144862616519, 7167.104111986002, 6558.868822623616, 6599.571027883172, 6601.306862779339, 6609.933900660932, 6611.33886611335, 6317.810465686037, 6670.633115178712, 6701.698423570853, 6709.630970296681, 6718.966405167943], "unit": "ms", "name": "mootools.html", "value": 4364.065820193916}, {"lowerIsBetter": false, "replicates": [324.48083067092654, 334.12959241176736, 335.17714012100294, 343.63574610912417, 343.8469880902996, 5878.764849406019, 6011.0, 6054.9999999999945, 6067.817965461032, 6076.301225359085, 5783.190353350524, 5914.615549989258, 5943.613665111765, 5973.193618861453, 5998.760049598021, 4559.042601053783, 4571.4514258289055, 4574.268117101265, 4576.633869290466, 4585.19759042168, 4365.672574556921, 4429.734215947037, 4552.08958208358, 4575.839845605405, 4643.396358473394, 4565.794539245725, 4586.243269860485, 4589.816407343719, 4605.516420775821, 4622.237330840408, 4579.42757155354, 4587.770611469413, 4599.908001839961, 4600.309953506967, 4606.424196975378, 4040.7979601020124, 4043.4137050127565, 4046.8381264749373, 4047.1298670785923, 4047.8583249586122, 5599.944000559983, 5645.350784659776, 5670.404607516192, 5682.801101961453, 5689.544836413077, 5352.491513306269, 5359.330083739533, 5366.014574607381, 5369.140937450028, 5370.8925821483745, 6051.273847138327, 6337.714802833883, 6342.23893132827, 6343.080253363237, 6347.492200623939, 4290.935635965463, 4329.376483818568, 4402.3836662867225, 4488.685791994561, 4489.685721999429, 6594.604323740543, 6599.868002639968, 6609.041688955074, 6616.801495955129, 6626.801195964129, 4478.888027799266, 4487.528809475023, 4491.910161796745, 4574.382458368144, 4584.839530616412, 4394.450693663292, 4416.6908316418185, 4433.889152771207, 4539.795709193094, 4539.863804085882, 5213.895722085537, 5217.426083130853, 5222.21666749983, 5226.216067589816, 5231.241469986907, 6375.394337537927, 6379.298277189506, 6385.584936979081, 6390.744370225232, 6437.259715132726, 1622.7322491788723, 1642.0476123848139, 1643.0141914851233, 1643.1209303022824, 1644.284736139783, 1104.7017305327677, 1105.6240878101485, 1119.2221406122828, 1131.2590253384046, 1131.8754936956927, 6158.876822463526, 6161.4146656067605, 6163.0, 6165.969170154121, 6170.290416602148, 6599.0, 6609.768658096944, 6610.0, 6616.503762217853, 6626.105475760711, 6007.219061521974, 6033.672592029747, 6145.784897528565, 6164.845878853064, 6170.598911070856, 3560.537130173061, 3593.047842321787, 3595.8921232363073, 3598.3522965866396, 3599.4240921452442, 6763.864722705617, 6806.387425131663, 6810.659467026629, 6815.114035175396, 6821.522493425512, 6588.934110658928, 6591.6374599397495, 6638.203415590064, 6672.833179170462, 6720.193576770819, 6776.119104516381, 6779.389854912983, 6779.6271205084195, 6784.253732089466, 6804.319568043156, 6293.213348331458, 6480.611163330215, 6494.090827284279, 6495.740170393131, 6504.089427480062, 6235.96882015587, 6424.229092508929, 6433.839154021187, 6436.388543088399, 6438.67806609677, 6753.257141714309, 6867.175938887365, 6884.345987131214, 6884.8967265490055, 6885.139357580302, 4628.60656844172, 4632.212523871018, 4638.397008388888, 4644.6052085571755, 4648.8140474382, 6624.6025238485845, 6640.468762499085, 6642.070110184482, 6643.468522518284, 6647.0, 6236.719347629459, 6383.521235907233, 6383.521235907233, 6411.935880641134, 6472.579282346633, 6425.421712045938, 6431.163948686641, 6443.194600674916, 6445.903311450238, 6448.193975753031, 6168.629882207082, 6276.121343012073, 6313.810585682437, 6330.082138089859, 6333.081703153109, 6441.259255185713, 6446.290908000023, 6452.161219041494, 6455.806325810233, 6457.806265812033, 6124.081387791867, 6150.630962142107, 6162.445379915829, 6273.96863015682, 6282.905756413749], "unit": "ms", "name": "prototype.html", "value": 4808.801513678935}, {"lowerIsBetter": false, "replicates": [742.8848528478086, 826.078922001968, 847.1993965702412, 849.9532525711084, 855.2644725536038, 12722.55471058512, 13005.60983170504, 13016.284104374256, 13044.217346959178, 13044.934775326134, 12251.509939602405, 12256.571020014302, 12262.509499620004, 12298.200616959892, 12321.445534950926, 678.3081257117736, 684.1482354468693, 800.0479429478916, 814.975550733476, 831.4678605692362, 816.1878930464167, 821.8890449789262, 822.9341652667803, 826.1655727714991, 828.3911325175991, 701.7298340139058, 771.8996530451034, 832.7335252719132, 860.6944534690189, 860.7503823891064, 704.8484575816199, 829.2660995019421, 856.2293935458107, 864.3733293362325, 866.4584634603373, 642.473171998961, 643.8841008618447, 645.1484041065795, 645.6061802300593, 645.7481582182952, 12337.198082124632, 12461.688457788538, 12489.50041998319, 12507.0, 12508.81236781449, 11023.61417350389, 11270.323780573191, 11953.581624643095, 12150.270983741004, 12497.93751031248, 9844.852327215098, 9997.700068997869, 10088.0, 10118.645847395306, 10195.4392508412, 3499.4750787382095, 3509.877154299613, 3549.112721819545, 3561.0207193021865, 3577.069961809922, 47996.0, 48446.515534844904, 48490.51509484895, 49129.26306105375, 49173.50826491761, 8905.554722263862, 8968.551572421353, 9063.093690631016, 9101.68144114966, 9192.908070919339, 18589.256429742658, 18599.34902278414, 18693.719594206097, 18708.0, 18735.25058997652, 6884.759033433806, 7242.565446073147, 7331.963340183265, 7381.37258333037, 7570.697172113164, 4068.7355321903983, 4151.813168407429, 4157.376393540993, 4172.395002724588, 4217.0, 3026.2888221267986, 3059.4492991261786, 3065.9540106898417, 3094.90715278542, 3120.8751649933747, 521.4837311062097, 532.0157708239802, 535.0209117315304, 536.975836087377, 537.0976759044764, 517.4682789958473, 596.6241268001219, 635.1837888313495, 642.7782415066795, 669.6350488983516, 7107.360337569644, 7197.424206063502, 7247.818804529929, 7399.334059934632, 7500.887486687704, 501.2306110120947, 578.2309528327314, 628.8239292997968, 643.2056410333234, 659.868026394723, 3490.5636795400574, 3720.8325625346924, 3728.757630753992, 3733.178700685899, 3794.4687743715904, 59106.40893591095, 60572.697136514034, 60783.0, 60787.69606151941, 60920.0, 52398.47601524012, 52414.47585524172, 52789.2081618776, 53158.20262696063, 53923.0, 47462.288065679044, 47667.523324766305, 48333.7916552089, 48919.510804892205, 48998.02003959901, 7172.390346820579, 7237.124731505196, 7249.710011599477, 7374.815629609088, 7432.814179645336, 35201.47197791984, 35944.820275899496, 36031.63968360283, 36768.81615591905, 37363.0, 44809.327860081474, 47138.76430617962, 47403.0, 47510.762446187546, 48033.0, 10546.78906421852, 10806.513706883052, 10843.0, 10972.177086718368, 11027.22809403334, 11326.546938122383, 11580.942095289469, 11723.179377443497, 11808.114391420506, 11829.585964491202, 10365.533550990374, 10753.247272690836, 11091.833622495507, 11199.272047316897, 11207.60773372928, 10101.69694909154, 10196.949015254877, 10378.948105259426, 10382.42896640692, 10465.162786977176, 10002.899971000488, 10306.845397318897, 10339.121174699934, 10343.63797267092, 10528.894711052792, 8794.20852123312, 8865.778355541162, 9198.402103863227, 9260.629574816932, 9357.578908948977, 7445.813854653677, 7716.961415192888, 7729.0, 8039.356851451753, 8400.579971001303], "unit": "ms", "name": "yui.html", "value": 6063.671043693429}], "name": "dromaeo_css", "value": 6967.612856385322}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 104.0, 111.0, 111.0, 113.0, 101.0, 112.0, 113.0, 105.0], "unit": "ms", "name": "ai-astar", "value": 109.1}, {"lowerIsBetter": true, "replicates": [151.0, 133.0, 162.0, 160.0, 126.0, 162.0, 150.0, 127.0, 162.0, 126.0], "unit": "ms", "name": "audio-beat-detection", "value": 145.9}, {"lowerIsBetter": true, "replicates": [165.0, 167.0, 162.0, 163.0, 163.0, 163.0, 167.0, 167.0, 162.0, 165.0], "unit": "ms", "name": "audio-dft", "value": 164.4}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 87.0, 92.0, 72.0, 74.0, 77.0, 115.0, 91.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 82.4}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 136.0, 95.0, 95.0, 96.0, 137.0, 93.0, 93.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 106.3}, {"lowerIsBetter": true, "replicates": [111.0, 112.0, 112.0, 111.0, 110.0, 111.0, 111.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.8}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 147.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 58.0, 57.0, 57.0, 56.0, 57.0, 59.0, 58.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 70.0, 71.0, 71.0, 71.0, 70.0, 71.0, 70.0, 71.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 70.6}, {"lowerIsBetter": true, "replicates": [84.0, 94.0, 85.0, 85.0, 93.0, 84.0, 86.0, 86.0, 87.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.0}, {"lowerIsBetter": true, "replicates": [122.0, 116.0, 120.0, 113.0, 123.0, 121.0, 116.0, 133.0, 118.0, 130.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.2}, {"lowerIsBetter": true, "replicates": [140.0, 150.0, 150.0, 151.0, 148.0, 139.0, 152.0, 150.0, 146.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.1}, {"lowerIsBetter": true, "replicates": [71.0, 65.0, 64.0, 66.0, 65.0, 66.0, 65.0, 68.0, 66.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.1}], "name": "kraken", "value": 1508.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.16816218012627], "unit": "score", "name": "Richards", "value": 212.4474360000001}, {"lowerIsBetter": false, "replicates": [194.81784531463083], "unit": "score", "name": "DeltaBlue", "value": 339.383694}, {"lowerIsBetter": false, "replicates": [284.4141069397042], "unit": "score", "name": "Encrypt", "value": 935.8923959999998}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1096.4912280701753], "unit": "score", "name": "RayTrace", "value": 674.869968}, {"lowerIsBetter": false, "replicates": [780.0312012480499], "unit": "score", "name": "Earley", "value": 854.4055660000001}, {"lowerIsBetter": false, "replicates": [12304.878048780487], "unit": "score", "name": "Boyer", "value": 54.16250346878094}, {"lowerIsBetter": false, "replicates": [25525.0], "unit": "score", "name": "RegExp", "value": 35.689911851126354}, {"lowerIsBetter": false, "replicates": [621.8905472636816], "unit": "score", "name": "Splay", "value": 131.03752799999995}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20934.730303425746}]} 05:46:32 INFO - RETURN: dromaeo_css: 6967.61 05:46:32 INFO - RETURN: kraken: 1508.70 05:46:32 INFO - RETURN: v8_7: 20934.73 05:46:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20934.73"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1508.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6967.61"}}} 05:46:32 INFO - Return code: 0 05:46:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:46:32 INFO - # TBPL SUCCESS # 05:46:32 INFO - Running post-action listener: _resource_record_post_action 05:46:32 INFO - Running post-run listener: _resource_record_post_run 05:46:33 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 10280960; Write bytes: 409755648; Read time: 2924; Write time: 365724 05:46:33 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 13406208; Read time: 0; Write time: 1792 05:46:33 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 8544256; Write bytes: 396349440; Read time: 2884; Write time: 363932 05:46:33 INFO - Running post-run listener: _upload_blobber_files 05:46:33 INFO - Blob upload gear active. 05:46:33 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:46:33 INFO - Copying logs to upload dir... 05:46:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1265.229513 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-11-26 05:46:33.360900) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-26 05:46:33.364672) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448540767.538764-668980821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009946 build_url: 'https://queue.taskcluster.net/v1/task/9dmDTOjHSimAMxcUnF7awQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-26 05:46:33.416416) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 05:46:33.416787) ========= 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=70a720fcaf18edea6683c2dc000001ad-1448540767.538764-668980821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004562 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-26 05:46:33.468050) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 05:46:33.468434) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-26 05:46:33.468729) ========= ========= Total master_lag: 0.21 =========