builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1448320464.01 results: success (0) buildid: 20151123133014 builduid: 2902d5fbd99143ec9086663755a10e4d revision: 18a0a55c668d781d45dbc96b9eda68cc9a5b207e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 15:14:24.006020) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 15:14:24.006659) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 15:14:24.007193) ========= 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=5804b9f07a53938c557deee7000001c5-1448317651.642415-413582922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006318 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 15:14:24.028042) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 15:14:24.028367) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 15:14:24.055809) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:14:24.056176) ========= 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=5804b9f07a53938c557deee7000001c5-1448317651.642415-413582922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004618 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:14:24.105009) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 15:14:24.105337) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 15:14:24.105735) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:14:24.106101) ========= 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=5804b9f07a53938c557deee7000001c5-1448317651.642415-413582922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 15:14:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2015-11-23 15:14:25 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.191193 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:14:24.311125) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:14:24.311484) ========= 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=5804b9f07a53938c557deee7000001c5-1448317651.642415-413582922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019323 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:14:24.361268) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 15:14:24.361660) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 18a0a55c668d781d45dbc96b9eda68cc9a5b207e --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/mozilla-inbound --rev 18a0a55c668d781d45dbc96b9eda68cc9a5b207e --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=5804b9f07a53938c557deee7000001c5-1448317651.642415-413582922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 15:14:25,780 truncating revision to first 12 chars 2015-11-23 15:14:25,780 Setting DEBUG logging. 2015-11-23 15:14:25,780 attempt 1/10 2015-11-23 15:14:25,781 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/18a0a55c668d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 15:14:26,569 unpacking tar archive at: mozilla-inbound-18a0a55c668d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.090048 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 15:14:25.466454) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 15:14:25.466819) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 15:14:25.475992) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 15:14:25.476356) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 15:14:25.476811) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2015-11-23 15:14:25.477210) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5804b9f07a53938c557deee7000001c5-1448317651.642415-413582922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:14:26 INFO - MultiFileLogger online at 20151123 15:14:26 in /builds/slave/test-pgo 15:14:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 15:14:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:14:26 INFO - {'append_to_log': False, 15:14:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:14:26 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:14:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:14:26 INFO - 'branch': 'Mozilla-Inbound', 15:14:26 INFO - 'buildbot_json_path': 'buildprops.json', 15:14:26 INFO - 'config_files': ('talos/linux_config.py',), 15:14:26 INFO - 'default_actions': ('clobber', 15:14:26 INFO - 'read-buildbot-config', 15:14:26 INFO - 'download-and-extract', 15:14:26 INFO - 'populate-webroot', 15:14:26 INFO - 'create-virtualenv', 15:14:26 INFO - 'install', 15:14:26 INFO - 'run-tests'), 15:14:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:14:26 INFO - 'download_minidump_stackwalk': True, 15:14:26 INFO - 'download_symbols': 'ondemand', 15:14:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:14:26 INFO - 'tooltool.py': '/tools/tooltool.py', 15:14:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:14:26 INFO - '/tools/misc-python/virtualenv.py')}, 15:14:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:14:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:14:26 INFO - 'installer_path': 'installer.exe', 15:14:26 INFO - 'log_level': 'info', 15:14:26 INFO - 'log_name': 'talos', 15:14:26 INFO - 'log_to_console': True, 15:14:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:14:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:14:26 INFO - 'opt_config_files': (), 15:14:26 INFO - 'pip_index': False, 15:14:26 INFO - 'sps_profile': False, 15:14:26 INFO - 'sps_profile_interval': 0, 15:14:26 INFO - 'suite': 'dromaeojs-e10s', 15:14:26 INFO - 'system_bits': '64', 15:14:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:14:26 INFO - 'title': 'talos-linux64-ix-061', 15:14:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:14:26 INFO - 'use_talos_json': True, 15:14:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:14:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:14:26 INFO - 'work_dir': 'build'} 15:14:26 INFO - ##### 15:14:26 INFO - ##### Running clobber step. 15:14:26 INFO - ##### 15:14:26 INFO - Running pre-action listener: _resource_record_pre_action 15:14:26 INFO - Running main action method: clobber 15:14:26 INFO - rmtree: /builds/slave/test-pgo/build 15:14:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:14:27 INFO - Running post-action listener: _resource_record_post_action 15:14:27 INFO - ##### 15:14:27 INFO - ##### Running read-buildbot-config step. 15:14:27 INFO - ##### 15:14:27 INFO - Running pre-action listener: _resource_record_pre_action 15:14:27 INFO - Running main action method: read_buildbot_config 15:14:27 INFO - Using buildbot properties: 15:14:27 INFO - { 15:14:27 INFO - "properties": { 15:14:27 INFO - "buildnumber": 204, 15:14:27 INFO - "product": "firefox", 15:14:27 INFO - "script_repo_revision": "production", 15:14:27 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 15:14:27 INFO - "repository": "", 15:14:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 15:14:27 INFO - "buildid": "20151123133014", 15:14:27 INFO - "slavename": "talos-linux64-ix-061", 15:14:27 INFO - "pgo_build": "True", 15:14:27 INFO - "basedir": "/builds/slave/test-pgo", 15:14:27 INFO - "project": "", 15:14:27 INFO - "platform": "ubuntu64_hw", 15:14:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:14:27 INFO - "slavebuilddir": "test", 15:14:27 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 15:14:27 INFO - "branch": "mozilla-inbound", 15:14:27 INFO - "repo_path": "integration/mozilla-inbound", 15:14:27 INFO - "stage_platform": "linux64-pgo", 15:14:27 INFO - "builduid": "2902d5fbd99143ec9086663755a10e4d", 15:14:27 INFO - "revision": "18a0a55c668d781d45dbc96b9eda68cc9a5b207e" 15:14:27 INFO - }, 15:14:27 INFO - "sourcestamp": { 15:14:27 INFO - "repository": "", 15:14:27 INFO - "hasPatch": false, 15:14:27 INFO - "project": "", 15:14:27 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 15:14:27 INFO - "changes": [ 15:14:27 INFO - { 15:14:27 INFO - "category": null, 15:14:27 INFO - "files": [ 15:14:27 INFO - { 15:14:27 INFO - "url": null, 15:14:27 INFO - "name": "https://queue.taskcluster.net/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 15:14:27 INFO - } 15:14:27 INFO - ], 15:14:27 INFO - "repository": "", 15:14:27 INFO - "rev": "18a0a55c668d781d45dbc96b9eda68cc9a5b207e", 15:14:27 INFO - "who": "sendchange", 15:14:27 INFO - "when": 1448320365, 15:14:27 INFO - "number": 6697418, 15:14:27 INFO - "comments": "", 15:14:27 INFO - "project": "", 15:14:27 INFO - "at": "Mon 23 Nov 2015 15:12:45", 15:14:27 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 15:14:27 INFO - "revlink": "", 15:14:27 INFO - "properties": [ 15:14:27 INFO - [ 15:14:27 INFO - "buildid", 15:14:27 INFO - "20151123133014", 15:14:27 INFO - "Change" 15:14:27 INFO - ], 15:14:27 INFO - [ 15:14:27 INFO - "builduid", 15:14:27 INFO - "2902d5fbd99143ec9086663755a10e4d", 15:14:27 INFO - "Change" 15:14:27 INFO - ], 15:14:27 INFO - [ 15:14:27 INFO - "pgo_build", 15:14:27 INFO - "True", 15:14:27 INFO - "Change" 15:14:27 INFO - ] 15:14:27 INFO - ], 15:14:27 INFO - "revision": "18a0a55c668d781d45dbc96b9eda68cc9a5b207e" 15:14:27 INFO - } 15:14:27 INFO - ], 15:14:27 INFO - "revision": "18a0a55c668d781d45dbc96b9eda68cc9a5b207e" 15:14:27 INFO - } 15:14:27 INFO - } 15:14:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 15:14:27 INFO - Running post-action listener: _resource_record_post_action 15:14:27 INFO - ##### 15:14:27 INFO - ##### Running download-and-extract step. 15:14:27 INFO - ##### 15:14:27 INFO - Running pre-action listener: _resource_record_pre_action 15:14:27 INFO - Running main action method: download_and_extract 15:14:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:14:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:27 INFO - https://queue.taskcluster.net/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:14:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/test_packages.json 15:14:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/test_packages.json 15:14:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:14:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:14:28 INFO - Downloaded 1302 bytes. 15:14:28 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:14:28 INFO - Using the following test package requirements: 15:14:28 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:14:28 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:14:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:14:28 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:14:28 INFO - u'jsshell-linux-x86_64.zip'], 15:14:28 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:14:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:14:28 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:14:28 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:14:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:14:28 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:14:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:14:28 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:14:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:14:28 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:14:28 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:14:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:14:28 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:28 INFO - https://queue.taskcluster.net/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:14:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:14:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:14:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:14:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:14:29 INFO - Downloaded 22526939 bytes. 15:14:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 15:14:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:14:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:14:30 INFO - Return code: 0 15:14:30 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:14: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')]} 15:14:30 INFO - https://queue.taskcluster.net/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:14:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:14:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:14:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:14:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:14:31 INFO - Downloaded 22526939 bytes. 15:14: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 15:14:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:14: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 15:14:32 INFO - Return code: 0 15:14: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')]} 15:14:32 INFO - https://queue.taskcluster.net/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:14:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:14:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:14:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:14:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:14:33 INFO - Downloaded 11131678 bytes. 15:14:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 15:14:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:14:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 15:14:33 INFO - Return code: 0 15:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:33 INFO - https://queue.taskcluster.net/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:14:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:14:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:14:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:14:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:14:35 INFO - Downloaded 57536964 bytes. 15:14:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:14:35 INFO - mkdir: /builds/slave/test-pgo/properties 15:14:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:14:35 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:14:35 INFO - Contents: 15:14:35 INFO - build_url:https://queue.taskcluster.net/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:14:35 INFO - Running post-action listener: _resource_record_post_action 15:14:35 INFO - Running post-action listener: set_extra_try_arguments 15:14:35 INFO - ##### 15:14:35 INFO - ##### Running populate-webroot step. 15:14:35 INFO - ##### 15:14:35 INFO - Running pre-action listener: _resource_record_pre_action 15:14:35 INFO - Running main action method: populate_webroot 15:14:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:14:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:14:35 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:14:35 INFO - '../fennec_ids.txt'], 15:14:35 INFO - 'tests': ['tcheck2']}, 15:14:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:14:35 INFO - '--tppagecycles', 15:14:35 INFO - '7'], 15:14:35 INFO - 'tests': ['tsvgm']}}, 15:14:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:14:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:14:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:14:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:14:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:14:35 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:14:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:14:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:35 INFO - 'talos_options': ['--e10s'], 15:14:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:14:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:35 INFO - 'tests': ['damp', 'tps']}, 15:14:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:35 INFO - 'talos_options': ['--e10s'], 15:14:35 INFO - 'tests': ['damp', 'tps']}, 15:14:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:14:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:14:35 INFO - 'other': {'tests': ['a11yr', 15:14:35 INFO - 'ts_paint', 15:14:35 INFO - 'tpaint', 15:14:35 INFO - 'sessionrestore', 15:14:35 INFO - 'sessionrestore_no_auto_restore']}, 15:14:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:14:35 INFO - 'tests': ['a11yr', 15:14:35 INFO - 'ts_paint', 15:14:35 INFO - 'tpaint', 15:14:35 INFO - 'sessionrestore', 15:14:35 INFO - 'sessionrestore_no_auto_restore']}, 15:14:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:14:35 INFO - 'tests': ['a11yr', 15:14:35 INFO - 'ts_paint', 15:14:35 INFO - 'tpaint', 15:14:35 INFO - 'sessionrestore', 15:14:35 INFO - 'sessionrestore_no_auto_restore']}, 15:14:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:14:35 INFO - 'tests': ['a11yr', 15:14:35 INFO - 'ts_paint', 15:14:35 INFO - 'tpaint', 15:14:35 INFO - 'sessionrestore', 15:14:35 INFO - 'sessionrestore_no_auto_restore']}, 15:14:35 INFO - 'other_l64': {'tests': ['a11yr', 15:14:35 INFO - 'ts_paint', 15:14:35 INFO - 'tpaint', 15:14:35 INFO - 'sessionrestore', 15:14:35 INFO - 'sessionrestore_no_auto_restore']}, 15:14:35 INFO - 'other_nol64': {'tests': ['a11yr', 15:14:35 INFO - 'ts_paint', 15:14:35 INFO - 'tpaint', 15:14:35 INFO - 'sessionrestore', 15:14:35 INFO - 'sessionrestore_no_auto_restore']}, 15:14:35 INFO - 'svgr': {'tests': ['tsvgx', 15:14:35 INFO - 'tsvgr_opacity', 15:14:35 INFO - 'tart', 15:14:35 INFO - 'tscrollx', 15:14:35 INFO - 'cart']}, 15:14:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:14:35 INFO - 'tests': ['tsvgx', 15:14:35 INFO - 'tsvgr_opacity', 15:14:35 INFO - 'tart', 15:14:35 INFO - 'tscrollx', 15:14:35 INFO - 'cart']}, 15:14:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:35 INFO - 'tests': ['tp5o']}, 15:14:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:35 INFO - 'talos_options': ['--e10s'], 15:14:35 INFO - 'tests': ['tp5o']}, 15:14:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:35 INFO - 'talos_options': ['--xperf_path', 15:14:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:14:35 INFO - 'tests': ['tp5n']}, 15:14:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:14:35 INFO - 'talos_options': ['--e10s', 15:14:35 INFO - '--xperf_path', 15:14:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:14:35 INFO - 'tests': ['tp5n']}}, 15:14:35 INFO - 'talos.zip': {'path': '', 15:14:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:14:35 INFO - Running post-action listener: _resource_record_post_action 15:14:35 INFO - ##### 15:14:35 INFO - ##### Running create-virtualenv step. 15:14:35 INFO - ##### 15:14:35 INFO - Running pre-action listener: _resource_record_pre_action 15:14:35 INFO - Running main action method: create_virtualenv 15:14:35 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:14:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 15:14:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:14:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:14:35 INFO - Using real prefix '/usr' 15:14:35 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:14:35 INFO - Installing distribute.............................................................................................................................................................................................done. 15:14:37 INFO - Installing pip.................done. 15:14:37 INFO - Return code: 0 15:14:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:37 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 0x1a8a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb5c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d44e50>, '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 0x1d45d50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d461e0>, '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': '5804b9f07a53938c557deee7000001c5-1448317651.642415-413582922', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:14:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 15:14:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:14:37 INFO - Using env: {'DISPLAY': ':0', 15:14:37 INFO - 'HOME': '/home/cltbld', 15:14:37 INFO - 'LANG': 'en_US.UTF-8', 15:14:37 INFO - 'LANGUAGE': 'en_US:en', 15:14:37 INFO - 'LOGNAME': 'cltbld', 15:14:37 INFO - 'MAIL': '/var/mail/cltbld', 15:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:37 INFO - 'MOZ_NO_REMOTE': '1', 15:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:37 INFO - 'NO_EM_RESTART': '1', 15:14:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:14:37 INFO - 'PWD': '/builds/slave/test-pgo', 15:14:37 INFO - 'SHELL': '/bin/bash', 15:14:37 INFO - 'SHLVL': '1', 15:14:37 INFO - 'TERM': 'linux', 15:14:37 INFO - 'TMOUT': '86400', 15:14:37 INFO - 'USER': 'cltbld', 15:14:37 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448317651.642415-413582922', 15:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:37 INFO - '_': '/tools/buildbot/bin/python'} 15:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:14:38 INFO - Cleaning up... 15:14:38 INFO - Return code: 0 15:14:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:38 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 0x1a8a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb5c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d44e50>, '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 0x1d45d50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d461e0>, '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': '5804b9f07a53938c557deee7000001c5-1448317651.642415-413582922', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:14:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 15:14:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:14:38 INFO - Using env: {'DISPLAY': ':0', 15:14:38 INFO - 'HOME': '/home/cltbld', 15:14:38 INFO - 'LANG': 'en_US.UTF-8', 15:14:38 INFO - 'LANGUAGE': 'en_US:en', 15:14:38 INFO - 'LOGNAME': 'cltbld', 15:14:38 INFO - 'MAIL': '/var/mail/cltbld', 15:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:38 INFO - 'MOZ_NO_REMOTE': '1', 15:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:38 INFO - 'NO_EM_RESTART': '1', 15:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:14:38 INFO - 'PWD': '/builds/slave/test-pgo', 15:14:38 INFO - 'SHELL': '/bin/bash', 15:14:38 INFO - 'SHLVL': '1', 15:14:38 INFO - 'TERM': 'linux', 15:14:38 INFO - 'TMOUT': '86400', 15:14:38 INFO - 'USER': 'cltbld', 15:14:38 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448317651.642415-413582922', 15:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:38 INFO - '_': '/tools/buildbot/bin/python'} 15:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:38 INFO - Downloading/unpacking psutil>=0.7.1 15:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:39 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 15:14:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:14:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:14:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:14:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:14:40 INFO - Installing collected packages: psutil 15:14:40 INFO - Running setup.py install for psutil 15:14:40 INFO - building 'psutil._psutil_linux' extension 15:14:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:14:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:14:40 INFO - building 'psutil._psutil_posix' extension 15:14:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:14:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:14:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:14:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:14:40 INFO - Successfully installed psutil 15:14:40 INFO - Cleaning up... 15:14:40 INFO - Return code: 0 15:14:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:40 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 0x1a8a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb5c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d44e50>, '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 0x1d45d50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d461e0>, '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': '5804b9f07a53938c557deee7000001c5-1448317651.642415-413582922', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:14:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 15:14:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:14:40 INFO - Using env: {'DISPLAY': ':0', 15:14:40 INFO - 'HOME': '/home/cltbld', 15:14:40 INFO - 'LANG': 'en_US.UTF-8', 15:14:40 INFO - 'LANGUAGE': 'en_US:en', 15:14:40 INFO - 'LOGNAME': 'cltbld', 15:14:40 INFO - 'MAIL': '/var/mail/cltbld', 15:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:40 INFO - 'MOZ_NO_REMOTE': '1', 15:14:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:40 INFO - 'NO_EM_RESTART': '1', 15:14:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:14:40 INFO - 'PWD': '/builds/slave/test-pgo', 15:14:40 INFO - 'SHELL': '/bin/bash', 15:14:40 INFO - 'SHLVL': '1', 15:14:40 INFO - 'TERM': 'linux', 15:14:40 INFO - 'TMOUT': '86400', 15:14:40 INFO - 'USER': 'cltbld', 15:14:40 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448317651.642415-413582922', 15:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:40 INFO - '_': '/tools/buildbot/bin/python'} 15:14:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:14:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:14:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:14:42 INFO - Installing collected packages: mozsystemmonitor 15:14:42 INFO - Running setup.py install for mozsystemmonitor 15:14:42 INFO - Successfully installed mozsystemmonitor 15:14:42 INFO - Cleaning up... 15:14:42 INFO - Return code: 0 15:14:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:42 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 0x1a8a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb5c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d44e50>, '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 0x1d45d50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d461e0>, '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': '5804b9f07a53938c557deee7000001c5-1448317651.642415-413582922', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:14:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 15:14:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:14:42 INFO - Using env: {'DISPLAY': ':0', 15:14:42 INFO - 'HOME': '/home/cltbld', 15:14:42 INFO - 'LANG': 'en_US.UTF-8', 15:14:42 INFO - 'LANGUAGE': 'en_US:en', 15:14:42 INFO - 'LOGNAME': 'cltbld', 15:14:42 INFO - 'MAIL': '/var/mail/cltbld', 15:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:42 INFO - 'MOZ_NO_REMOTE': '1', 15:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:42 INFO - 'NO_EM_RESTART': '1', 15:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:14:42 INFO - 'PWD': '/builds/slave/test-pgo', 15:14:42 INFO - 'SHELL': '/bin/bash', 15:14:42 INFO - 'SHLVL': '1', 15:14:42 INFO - 'TERM': 'linux', 15:14:42 INFO - 'TMOUT': '86400', 15:14:42 INFO - 'USER': 'cltbld', 15:14:42 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448317651.642415-413582922', 15:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:42 INFO - '_': '/tools/buildbot/bin/python'} 15:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:42 INFO - Downloading/unpacking blobuploader==1.2.4 15:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:44 INFO - Downloading blobuploader-1.2.4.tar.gz 15:14:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:14:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:14:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:14:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:14:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:45 INFO - Downloading docopt-0.6.1.tar.gz 15:14:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:14:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:14:45 INFO - Installing collected packages: blobuploader, requests, docopt 15:14:45 INFO - Running setup.py install for blobuploader 15:14:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:14:45 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:14:45 INFO - Running setup.py install for requests 15:14:45 INFO - Running setup.py install for docopt 15:14:45 INFO - Successfully installed blobuploader requests docopt 15:14:45 INFO - Cleaning up... 15:14:45 INFO - Return code: 0 15:14:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:45 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 0x1a8a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb5c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d44e50>, '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 0x1d45d50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d461e0>, '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': '5804b9f07a53938c557deee7000001c5-1448317651.642415-413582922', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:14:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 15:14:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:14:45 INFO - Using env: {'DISPLAY': ':0', 15:14:45 INFO - 'HOME': '/home/cltbld', 15:14:45 INFO - 'LANG': 'en_US.UTF-8', 15:14:45 INFO - 'LANGUAGE': 'en_US:en', 15:14:45 INFO - 'LOGNAME': 'cltbld', 15:14:45 INFO - 'MAIL': '/var/mail/cltbld', 15:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:45 INFO - 'MOZ_NO_REMOTE': '1', 15:14:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:45 INFO - 'NO_EM_RESTART': '1', 15:14:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:14:45 INFO - 'PWD': '/builds/slave/test-pgo', 15:14:45 INFO - 'SHELL': '/bin/bash', 15:14:45 INFO - 'SHLVL': '1', 15:14:45 INFO - 'TERM': 'linux', 15:14:45 INFO - 'TMOUT': '86400', 15:14:45 INFO - 'USER': 'cltbld', 15:14:45 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448317651.642415-413582922', 15:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:45 INFO - '_': '/tools/buildbot/bin/python'} 15:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:14:46 INFO - Running setup.py (path:/tmp/pip-OaOi0T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:14:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:14:46 INFO - Running setup.py (path:/tmp/pip-NF4b5d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:14:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:14:46 INFO - Running setup.py (path:/tmp/pip-8sZGHG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:14:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:14:46 INFO - Running setup.py (path:/tmp/pip-MWCeoh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:14:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:14:46 INFO - Running setup.py (path:/tmp/pip-52rIU5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:14:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:14:46 INFO - Running setup.py (path:/tmp/pip-gIFUmm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:14:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:14:46 INFO - Running setup.py (path:/tmp/pip-eMOFdP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:14:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:14:46 INFO - Running setup.py (path:/tmp/pip-glQnjl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:14:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:14:46 INFO - Running setup.py (path:/tmp/pip-4NOb_F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:14:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:14:46 INFO - Running setup.py (path:/tmp/pip-CPKZR5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:14:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:14:46 INFO - Running setup.py (path:/tmp/pip-LK7aeF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:14:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:14:46 INFO - Running setup.py (path:/tmp/pip-ACTBzU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:14:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:14:46 INFO - Running setup.py (path:/tmp/pip-vl2wbS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:14:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:14:47 INFO - Running setup.py (path:/tmp/pip-61JX6v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:14:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:14:47 INFO - Running setup.py (path:/tmp/pip-aeKIrg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:14:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:14:47 INFO - Running setup.py (path:/tmp/pip-TSuj5I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:14:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:14:47 INFO - Running setup.py (path:/tmp/pip-l1MtV_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:14:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:14:47 INFO - Running setup.py install for manifestparser 15:14:47 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:14:47 INFO - Running setup.py install for mozcrash 15:14:47 INFO - Running setup.py install for mozdebug 15:14:47 INFO - Running setup.py install for mozdevice 15:14:47 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:14:47 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:14:47 INFO - Running setup.py install for mozfile 15:14:47 INFO - Running setup.py install for mozhttpd 15:14:47 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:14:47 INFO - Running setup.py install for mozinfo 15:14:48 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:14:48 INFO - Running setup.py install for mozInstall 15:14:48 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:14:48 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:14:48 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:14:48 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:14:48 INFO - Running setup.py install for mozleak 15:14:48 INFO - Running setup.py install for mozlog 15:14:48 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:14:48 INFO - Running setup.py install for moznetwork 15:14:48 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:14:48 INFO - Running setup.py install for mozprocess 15:14:48 INFO - Running setup.py install for mozprofile 15:14:48 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:14:48 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:14:48 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:14:48 INFO - Running setup.py install for mozrunner 15:14:48 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:14:48 INFO - Running setup.py install for mozscreenshot 15:14:48 INFO - Running setup.py install for moztest 15:14:49 INFO - Running setup.py install for mozversion 15:14:49 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:14:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:14:49 INFO - Cleaning up... 15:14:49 INFO - Return code: 0 15:14:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:49 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 0x1a8a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb5c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d44e50>, '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 0x1d45d50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d461e0>, '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': '5804b9f07a53938c557deee7000001c5-1448317651.642415-413582922', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:14:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 15:14:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:14:49 INFO - Using env: {'DISPLAY': ':0', 15:14:49 INFO - 'HOME': '/home/cltbld', 15:14:49 INFO - 'LANG': 'en_US.UTF-8', 15:14:49 INFO - 'LANGUAGE': 'en_US:en', 15:14:49 INFO - 'LOGNAME': 'cltbld', 15:14:49 INFO - 'MAIL': '/var/mail/cltbld', 15:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:49 INFO - 'MOZ_NO_REMOTE': '1', 15:14:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:49 INFO - 'NO_EM_RESTART': '1', 15:14:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:14:49 INFO - 'PWD': '/builds/slave/test-pgo', 15:14:49 INFO - 'SHELL': '/bin/bash', 15:14:49 INFO - 'SHLVL': '1', 15:14:49 INFO - 'TERM': 'linux', 15:14:49 INFO - 'TMOUT': '86400', 15:14:49 INFO - 'USER': 'cltbld', 15:14:49 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448317651.642415-413582922', 15:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:49 INFO - '_': '/tools/buildbot/bin/python'} 15:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:14:49 INFO - Running setup.py (path:/tmp/pip-dHcaCg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 15:14:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:14:49 INFO - Running setup.py (path:/tmp/pip-e21uN6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:14:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:14:49 INFO - Running setup.py (path:/tmp/pip-EmyN3u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 15:14:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:14:49 INFO - Running setup.py (path:/tmp/pip-ZaJ5i5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:14:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:14:49 INFO - Running setup.py (path:/tmp/pip-q7oFUt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 15:14:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:14:49 INFO - Running setup.py (path:/tmp/pip-H4EVRv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 15:14:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:14:49 INFO - Running setup.py (path:/tmp/pip-1nbS90-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 15:14:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:14:49 INFO - Running setup.py (path:/tmp/pip-pzr6MY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:14:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 15:14:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:14:49 INFO - Running setup.py (path:/tmp/pip-0uC66X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 15:14:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:14:50 INFO - Running setup.py (path:/tmp/pip-_RXJ6q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:14:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:14:50 INFO - Running setup.py (path:/tmp/pip-7Gr2S8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 15:14:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:14:50 INFO - Running setup.py (path:/tmp/pip-SE75si-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 15:14:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:14:50 INFO - Running setup.py (path:/tmp/pip-_CkXH9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 15:14:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:14:50 INFO - Running setup.py (path:/tmp/pip-xFnSxo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 15:14:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:14:50 INFO - Running setup.py (path:/tmp/pip-bvZ93u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 15:14:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:14:50 INFO - Running setup.py (path:/tmp/pip-cxHYf9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 15:14:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:14:50 INFO - Running setup.py (path:/tmp/pip-yVQ5pW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 15:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 15:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:14:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:14: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 15:14: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 15:14: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 15:14: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 15:14: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 15:14: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 15:14:52 INFO - Downloading blessings-1.5.1.tar.gz 15:14:52 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 15:14:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:14:52 INFO - Installing collected packages: blessings 15:14:52 INFO - Running setup.py install for blessings 15:14:52 INFO - Successfully installed blessings 15:14:52 INFO - Cleaning up... 15:14:52 INFO - Return code: 0 15:14:52 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:14:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:14:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:14:52 INFO - Reading from file tmpfile_stdout 15:14:52 INFO - Current package versions: 15:14:52 INFO - argparse == 1.2.1 15:14:52 INFO - blessings == 1.5.1 15:14:52 INFO - blobuploader == 1.2.4 15:14:52 INFO - docopt == 0.6.1 15:14:52 INFO - manifestparser == 1.1 15:14:52 INFO - mozInstall == 1.12 15:14:52 INFO - mozcrash == 0.16 15:14:52 INFO - mozdebug == 0.1 15:14:52 INFO - mozdevice == 0.47 15:14:52 INFO - mozfile == 1.2 15:14:52 INFO - mozhttpd == 0.7 15:14:52 INFO - mozinfo == 0.9 15:14:52 INFO - mozleak == 0.1 15:14:52 INFO - mozlog == 3.1 15:14:52 INFO - moznetwork == 0.27 15:14:52 INFO - mozprocess == 0.22 15:14:52 INFO - mozprofile == 0.27 15:14:52 INFO - mozrunner == 6.11 15:14:52 INFO - mozscreenshot == 0.1 15:14:52 INFO - mozsystemmonitor == 0.0 15:14:52 INFO - moztest == 0.7 15:14:52 INFO - mozversion == 1.4 15:14:52 INFO - psutil == 3.1.1 15:14:52 INFO - requests == 1.2.3 15:14:52 INFO - wsgiref == 0.1.2 15:14:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:52 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 0x1a8a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb5c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d44e50>, '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 0x1d45d50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d461e0>, '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': '5804b9f07a53938c557deee7000001c5-1448317651.642415-413582922', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:14:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 15:14:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:14:52 INFO - Using env: {'DISPLAY': ':0', 15:14:52 INFO - 'HOME': '/home/cltbld', 15:14:52 INFO - 'LANG': 'en_US.UTF-8', 15:14:52 INFO - 'LANGUAGE': 'en_US:en', 15:14:52 INFO - 'LOGNAME': 'cltbld', 15:14:52 INFO - 'MAIL': '/var/mail/cltbld', 15:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:52 INFO - 'MOZ_NO_REMOTE': '1', 15:14:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:52 INFO - 'NO_EM_RESTART': '1', 15:14:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:14:52 INFO - 'PWD': '/builds/slave/test-pgo', 15:14:52 INFO - 'SHELL': '/bin/bash', 15:14:52 INFO - 'SHLVL': '1', 15:14:52 INFO - 'TERM': 'linux', 15:14:52 INFO - 'TMOUT': '86400', 15:14:52 INFO - 'USER': 'cltbld', 15:14:52 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448317651.642415-413582922', 15:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:52 INFO - '_': '/tools/buildbot/bin/python'} 15:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 15:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 15:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 15:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 15:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 15:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 15:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 15:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 15:14:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:14:52 INFO - Cleaning up... 15:14:52 INFO - Return code: 0 15:14:52 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:52 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 0x1a8a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cb5c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d44e50>, '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 0x1d45d50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d461e0>, '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': '5804b9f07a53938c557deee7000001c5-1448317651.642415-413582922', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:14:52 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 15:14:52 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 15:14:52 INFO - Using env: {'DISPLAY': ':0', 15:14:52 INFO - 'HOME': '/home/cltbld', 15:14:52 INFO - 'LANG': 'en_US.UTF-8', 15:14:52 INFO - 'LANGUAGE': 'en_US:en', 15:14:52 INFO - 'LOGNAME': 'cltbld', 15:14:52 INFO - 'MAIL': '/var/mail/cltbld', 15:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:52 INFO - 'MOZ_NO_REMOTE': '1', 15:14:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:52 INFO - 'NO_EM_RESTART': '1', 15:14:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:14:52 INFO - 'PWD': '/builds/slave/test-pgo', 15:14:52 INFO - 'SHELL': '/bin/bash', 15:14:52 INFO - 'SHLVL': '1', 15:14:52 INFO - 'TERM': 'linux', 15:14:52 INFO - 'TMOUT': '86400', 15:14:52 INFO - 'USER': 'cltbld', 15:14:52 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448317651.642415-413582922', 15:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:52 INFO - '_': '/tools/buildbot/bin/python'} 15:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:53 INFO - Downloading/unpacking jsonschema 15:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:14:54 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 15:14:54 INFO - Downloading/unpacking functools32 (from jsonschema) 15:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:55 INFO - Downloading functools32-3.2.3-2.tar.gz 15:14:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 15:14:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:14:55 INFO - warning: no files found matching '*.txt' 15:14:55 INFO - no previously-included directories found matching 'build' 15:14:55 INFO - no previously-included directories found matching 'dist' 15:14:55 INFO - no previously-included directories found matching '.git*' 15:14:55 INFO - Installing collected packages: jsonschema, functools32 15:14:55 INFO - Running setup.py install for functools32 15:14:55 INFO - warning: no files found matching '*.txt' 15:14:55 INFO - no previously-included directories found matching 'build' 15:14:55 INFO - no previously-included directories found matching 'dist' 15:14:55 INFO - no previously-included directories found matching '.git*' 15:14:55 INFO - Successfully installed jsonschema functools32 15:14:55 INFO - Cleaning up... 15:14:55 INFO - Return code: 0 15:14:55 INFO - Running post-action listener: _resource_record_post_action 15:14:55 INFO - Running post-action listener: _start_resource_monitoring 15:14:55 INFO - Starting resource monitoring. 15:14:55 INFO - ##### 15:14:55 INFO - ##### Running install step. 15:14:55 INFO - ##### 15:14:55 INFO - Running pre-action listener: _resource_record_pre_action 15:14:55 INFO - Running main action method: install 15:14:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:14:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:14:55 INFO - Reading from file tmpfile_stdout 15:14:55 INFO - Detecting whether we're running mozinstall >=1.0... 15:14:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:14:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:14:55 INFO - Reading from file tmpfile_stdout 15:14:55 INFO - Output received: 15:14:55 INFO - Usage: mozinstall [options] installer 15:14:55 INFO - Options: 15:14:55 INFO - -h, --help show this help message and exit 15:14:55 INFO - -d DEST, --destination=DEST 15:14:55 INFO - Directory to install application into. [default: 15:14:55 INFO - "/builds/slave/test-pgo"] 15:14:55 INFO - --app=APP Application being installed. [default: firefox] 15:14:55 INFO - mkdir: /builds/slave/test-pgo/build/application 15:14:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 15:14:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 15:15:10 INFO - Reading from file tmpfile_stdout 15:15:10 INFO - Output received: 15:15:10 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:15:10 INFO - Running post-action listener: _resource_record_post_action 15:15:10 INFO - ##### 15:15:10 INFO - ##### Running run-tests step. 15:15:10 INFO - ##### 15:15:10 INFO - Running pre-action listener: _resource_record_pre_action 15:15:10 INFO - Running main action method: run_tests 15:15:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:15:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:15:10 INFO - Python 2.7.3 15:15:10 INFO - Return code: 0 15:15:10 INFO - grabbing minidump binary from tooltool 15:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:15:10 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 0x1d44e50>, '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 0x1d45d50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d461e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:15:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 15:15:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:15:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:15:10 INFO - Return code: 0 15:15:10 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:15:10 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:15:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:15:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:15:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:15:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 15:15:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost 15:15:10 INFO - Using env: {'DISPLAY': ':0', 15:15:10 INFO - 'HOME': '/home/cltbld', 15:15:10 INFO - 'LANG': 'en_US.UTF-8', 15:15:10 INFO - 'LANGUAGE': 'en_US:en', 15:15:10 INFO - 'LOGNAME': 'cltbld', 15:15:10 INFO - 'MAIL': '/var/mail/cltbld', 15:15:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:15:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:15:10 INFO - 'MOZ_NO_REMOTE': '1', 15:15:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:15:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:15:10 INFO - 'NO_EM_RESTART': '1', 15:15:10 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:15:10 INFO - 'PWD': '/builds/slave/test-pgo', 15:15:10 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:15:10 INFO - 'SHELL': '/bin/bash', 15:15:10 INFO - 'SHLVL': '1', 15:15:10 INFO - 'TERM': 'linux', 15:15:10 INFO - 'TMOUT': '86400', 15:15:10 INFO - 'USER': 'cltbld', 15:15:10 INFO - 'XDG_SESSION_COOKIE': '5804b9f07a53938c557deee7000001c5-1448317651.642415-413582922', 15:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:15:10 INFO - '_': '/tools/buildbot/bin/python'} 15:15:10 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost'] with output_timeout 3600 15:15:10 INFO - mozversion INFO | application_buildid: 20151123133014 15:15:10 INFO - mozversion INFO | application_changeset: 18a0a55c668d781d45dbc96b9eda68cc9a5b207e 15:15:10 INFO - mozversion INFO | application_display_name: Nightly 15:15:10 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:15:10 INFO - mozversion INFO | application_name: Firefox 15:15:10 INFO - mozversion INFO | application_remotingname: firefox 15:15:10 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:15:10 INFO - mozversion INFO | application_vendor: Mozilla 15:15:10 INFO - mozversion INFO | application_version: 45.0a1 15:15:10 INFO - mozversion INFO | platform_buildid: 20151123133014 15:15:10 INFO - mozversion INFO | platform_changeset: 18a0a55c668d781d45dbc96b9eda68cc9a5b207e 15:15:10 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:15:10 INFO - mozversion INFO | platform_version: 45.0a1 15:15:10 INFO - 2015-11-23 15:15:10,342 DEBUG : using testdate: 1448320510 15:15:10 INFO - 2015-11-23 15:15:10,342 DEBUG : actual date: 1448320510 15:15:10 INFO - 2015-11-23 15:15:10,421 INFO : starting webserver on 'localhost:40365' 15:15:10 INFO - 2015-11-23 15:15:10,422 INFO : Starting test suite talos-linux64-ix-061.e 15:15:10 INFO - 2015-11-23 15:15:10,423 INFO : Starting test dromaeo_css 15:15:10 INFO - 2015-11-23 15:15:10,423 DEBUG : operating with platform_type : linux_ 15:15:10 INFO - 2015-11-23 15:15:10,424 INFO : Initialising browser for dromaeo_css test... 15:15:10 INFO - 2015-11-23 15:15:10,491 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxUB_kJ/profile http://localhost:40365/getInfo.html 15:15:15 INFO - 2015-11-23 15:15:15,049 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:15:15 INFO - 2015-11-23 15:15:15,049 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:15:15 INFO - 2015-11-23 15:15:15,049 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:15:15 INFO - 2015-11-23 15:15:15,049 DEBUG : BROWSER_OUTPUT: __metrics 15:15:16 INFO - 2015-11-23 15:15:16,113 INFO : Browser initialized. 15:15:16 INFO - 2015-11-23 15:15:16,114 INFO : Running cycle 1/1 for dromaeo_css test... 15:15:16 INFO - 2015-11-23 15:15:16,114 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxUB_kJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:15:27 INFO - 2015-11-23 15:15:27,942 DEBUG : BROWSER_OUTPUT: RSS: Main: 140009472 15:15:27 INFO - 2015-11-23 15:15:27,943 DEBUG : BROWSER_OUTPUT: 15:16:17 INFO - 2015-11-23 15:16:17,565 DEBUG : BROWSER_OUTPUT: 1448320577562 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:18:26 INFO - 2015-11-23 15:18:26,638 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40365/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40365/tests/dromaeo/cssquery-ext.html) 15:18:27 INFO - 2015-11-23 15:18:27,789 DEBUG : BROWSER_OUTPUT: RSS: Main: 147988480 15:18:27 INFO - 2015-11-23 15:18:27,789 DEBUG : BROWSER_OUTPUT: 15:21:29 INFO - 2015-11-23 15:21:29,699 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40365/tests/dromaeo/cssquery-ext.html (next: http://localhost:40365/tests/dromaeo/cssquery-jquery.html) 15:21:30 INFO - 2015-11-23 15:21:30,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 142114816 15:21:30 INFO - 2015-11-23 15:21:30,280 DEBUG : BROWSER_OUTPUT: 15:24:31 INFO - 2015-11-23 15:24:31,891 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40365/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40365/tests/dromaeo/cssquery-mootools.html) 15:24:32 INFO - 2015-11-23 15:24:32,481 DEBUG : BROWSER_OUTPUT: RSS: Main: 143314944 15:24:32 INFO - 2015-11-23 15:24:32,481 DEBUG : BROWSER_OUTPUT: 15:27:34 INFO - 2015-11-23 15:27:34,131 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40365/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40365/tests/dromaeo/cssquery-prototype.html) 15:27:34 INFO - 2015-11-23 15:27:34,718 DEBUG : BROWSER_OUTPUT: RSS: Main: 141750272 15:27:34 INFO - 2015-11-23 15:27:34,718 DEBUG : BROWSER_OUTPUT: 15:30:37 INFO - 2015-11-23 15:30:37,019 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40365/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40365/tests/dromaeo/cssquery-yui.html) 15:30:37 INFO - 2015-11-23 15:30:37,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 142778368 15:30:37 INFO - 2015-11-23 15:30:37,621 DEBUG : BROWSER_OUTPUT: 15:33:39 INFO - 2015-11-23 15:33:39,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40365/tests/dromaeo/cssquery-yui.html (next: http://localhost:40365/tests/dromaeo/cssquery-dojo.html) 15:33:40 INFO - 2015-11-23 15:33:40,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 145084416 15:33:40 INFO - 2015-11-23 15:33:40,115 DEBUG : BROWSER_OUTPUT: 15:33:40 INFO - 2015-11-23 15:33:40,116 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:33:40 INFO - 2015-11-23 15:33:40,117 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:33:40 INFO - 2015-11-23 15:33:40,117 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:33:40 INFO - 2015-11-23 15:33:40,117 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:33:40 INFO - 2015-11-23 15:33:40,118 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3208.5668434761305;3262.853171607279;3282.8686852525902;3299.65353637868;3311.834408279585;5160.716160611165;5382.2464854920345;5400.270963419937;5404.945950540494;5425.593080518957;5242.082635538775;5271.182966640177;5361.329833770778;5420.512153906147;5487.176923461483;4863.732494712789;4915.410150781893;4987.052460032601;4997.575206107485;5020.046191223656;4885.291632713254;4899.387576552931;4925.802967881281;4967.478414766451;5027.245913113025;4737.336772851803;4814.5907597853875;4929.876753081166;4994.650374473788;5019.447860735335;4949.579285760715;4957.3059771632;5002.824901128443;5030.622703297231;5036.924446133311;4955.801767929279;4965.0069986002945;4977.7262250576205;4986.2769898364895;5000.899982000376;5057.4689657585795;5109;5217.3999990000875;5230.843074707765;5327.440618735016;5776.220210271602;5789.16057171712;5790.565707571906;5808.2449281593545;5902.793402230945;5857.76568937242;5862.530997520188;5864.091065884794;5873.882522349571;5877.382874798127;5219.478052194788;5352.652077614943;5357.544608708265;5447.101228297287;5507.7246137692955;5887.411258874078;5921.3190483094995;5948.345681974979;5957.195778569924;5966.075258334965;5476.17857321405;5749.683767392834;5758.337791154071;5761.962846687637;5774.451427114417;5718.7426565804635;5823.213866128103;5933.139694744238;5939.07944268639;5990.520758339322;5855.502282306052;5910.34986151523;5913.793017244376;5930.110483427434;5951.077582974646;5635.098384258499;5759.7408116634015;5869.4717475427415;5919.55603329752;5922.851928701731;4483.461984561874;4542.818287268472;4543.45478542577;4575.679702420799;4585.472670642852;4011.2980228460488;4021.0148513614354;4025.255327764373;4027.718059735849;4052.5339585947404;5360.731963401892;5431.293931788842;5453.345598528202;5557.055300598908;5568.248286481355;5801.564882633735;5833.183354330397;5855.03391940325;5875.11873219012;5986.07215881539;5521.5306698930235;5578.163275508625;5584.357798853102;5587.552995760329;5602.831915042555;4921.138800709861;5017.172166592544;5033.7734801934;5119.360079990001;5130.589552835764;5988.640681559121;5994.310654274815;6017.398260174035;6041.516678665696;6056.939430605726;5838.824835254949;5866.472017518444;5874.324452687995;5885.47030767233;5895.380984996514;5875.559333049953;5984.521238301013;6034.758609655741;6074.787382441594;6104.337893874237;5621.831345059655;5663.461971112738;5670.177824215548;5679.659220446786;5736;5833.533317334518;5837.416258374129;5842.883142337045;5861.6189947653265;5864.765409383577;5450.5912056595125;5579.581531385081;5608.85977850557;5720.141978703228;5733.111367738007;5624.971875140598;5658.915116273177;5662.377138514677;5705.914411283917;5829.271341082364;5544.805931792368;5565.916511252253;5609.158626205938;5611.466910643482;5614.943850561442;5439.646422982493;5521.641093328921;5705.971470142623;5791.797287094932;5814.592978491634;5569.693666848362;5588.692621905834;5604.243427137284;5605.215269862141;5639.661620302795 15:33:40 INFO - 2015-11-23 15:33:40,122 DEBUG : BROWSER_OUTPUT: |1;ext.html;552.9498889163169;588.3733823477995;590.6249531547469;595.1013968906949;596.8063872255487;40495.79752101239;41026.17947641053;41130.17739645209;41143.58856411435;41280.58719412805;42342;42836.35745463821;42836.78581607088;43218.56781432185;43259.13481730364;8681.826363472743;8898.466092034467;8904.777380565472;8972.147645973622;8973.685920992766;8740.300775937909;8885.822283554357;8888.333374996868;8888.822223555557;8893.021767605558;8850.291976641853;8931;8937.419067760575;8940.821183576325;8946.41848279863;8791.912080879174;8819.735407937804;8849.292056635519;8889.555522223927;8906.33202509811;8713.869291960626;8820.558972051436;8837.779055523599;8868;8901.910980890172;39339.213215735814;40240;40265.79867100675;40290.59709402898;40371.59628403737;3152.36952609479;3470.2192006798523;3526;3731.1418373773913;3990.74060186087;29752.55371169434;29789.70210297891;30399;30528.389432211454;31417;3707.1288247261873;3725.068732816796;3920;3983.5418926823495;4024;269319;271572;272055.999999998;272393;272531;60188.39811601828;61143.38856611377;61198.38801612016;61308.69345653243;61329.38670613237;65132;71036.64481677559;71801;71980.64009679918;72715.63642181756;14419.711605767827;14505.709885802225;14537.273136343141;14538.418463261563;14558.563243102724;11379.658610241706;11479.655610331703;11489.712757181138;11522.423878806027;11529.481173347052;20988.265410710857;21016.78983210179;21019.369418917457;21204.939753012288;21297.36107916765;7892.4869883457395;7980.526036928571;8034.799130021679;8084.151164127799;8130.3495720342235;860.7589874835056;881.6120906800987;891.3804905590553;946.1437399153776;1022.5194158745378;28454.288642784097;29136.27159321034;32511;33517.16207094842;33805.66194338025;1009.7929924365487;1055.303499690216;1076.2251179150999;1084.6637542361893;1102.6195962392962;15127.924360378347;15206.239688015556;15238.3904643813;15330.463433779763;15404.92297538505;379187;386751;387976;389299;389478;53103.203451948255;53713.731431343374;54103.671706263405;54253.45746542484;54351;1327.150623600896;1354.2619272496513;1354.6613346663335;1354.8780609744972;1461.0211158523814;28019;28533.42933141284;28582;28853.134405967856;29331.26671833136;47873.04253914972;49189.754051229516;49262;49295.26057109218;49349;287658;288102;288425;288784;288973;42445.363319549615;46528;46618.06763864771;47385.28922066241;47517.76241118772;44114.779426102665;44448.77775611101;44733.77633111813;44899.551004490844;45102.54897451115;37224;37585.2482950334;38566.035849103995;38672.22655546817;39107.80446097751;37579.81210093932;37930;38821.6117838818;39174.60825391824;39211.41182882316;36741.26517469582;37040.44439333466;37423;37474.625253747115;37654.435183472815;32800.671993279764;34238.65761342454;34302.65697342995;34604.30791384209;34628.480572790926;25934.740652593988;26201.379282793045;26450.867745661148;26460.206193814218;26642.333941651614 15:33:40 INFO - 2015-11-23 15:33:40,123 DEBUG : BROWSER_OUTPUT: |2;jquery.html;343.1147639091145;360.8574613027852;362.217609962481;363.01803621204647;364.3605472395945;16811.159442027896;17364.565885852844;17517.124143792793;18094.457166285;18297.17662705178;13806.102603330777;16183;16189.35242590295;16318.102504362256;16436.506904792874;4818.108649899762;4913.336699545569;4939.234418665094;4957.281194226835;4957.5042495750495;4844.733539655317;4863.36776219091;4944;4956.231784073457;4958.206686930092;4327.870163895088;5216.400113986883;5316.601254905878;5331.067063263933;5370;5292.973535132319;5308;5320.467953204688;5324.840254792362;5327.786888524454;5161.767720452551;5360.705161216131;5367.865803354908;5370.624056316059;5376.784928602851;14822;20397.694034589495;20681;21604.135834566598;21608;2085.2180432337873;2103.5897999890026;2157.8273738100916;2184.0826852721734;2215.944601384962;9691.70924872255;9843.852342214872;10064.647737329231;11433.14251431146;13181.670458238621;1781.8930864148192;1825.1604262039477;1851.3520267906124;1868.0566314011337;1917.1851962915705;63045;63336.683316583585;63773.362266377204;65213.347866521675;66853;10163.28856980019;10245.231607629457;10410.115140213014;10450.895491044992;10462.372257664565;13458.93270533641;13529.18824870511;13597.252151131584;13641.181529108286;13648.795268070988;6972.477064220204;7227.602481863443;7386.926130738624;7464.664090115958;7617.085949686073;7324.926750732425;7397.334239918433;7407.2592740725495;7407.481476296607;7412.110546734426;4449.57729015743;4548.6133678637025;4555.589996900295;4560.247559152769;4565.360849481075;1816.9545761355807;1817.2276782367442;1827.8903265803829;1840.4110684581074;1843.3732530939544;384.55583800710224;388.2952441318997;397.2254104496244;407.3502763092862;410.7720215280488;10311;10406.947965260277;10464.21518386124;10593.470326483644;10626.521806518725;424.7706238631166;427.32269353075725;430.6619303846528;444.38896517288725;451.95932366086555;5650.886982260332;5672.631278966854;5674.602777805597;5692.857678558069;5701.116326969326;510954;529541;534566;546342;548170;80118;80714;80770.59614702007;81234;81711.59144204241;461.53846153846155;462.88196509889764;468.43553518011396;470.1654563150435;472.93142494338815;10113.19094472455;10133.847992279974;10136.391816491034;10243.7439064024;10345.275830691779;36038.639613603526;36125;36876.26247475089;37610.81194594119;38285.808570958085;46160.53839461562;46699.76650116728;48776.75611621919;51140;52890.73554632202;8636.524991125549;9406.05939406054;9824.115829575372;9843.753906152404;9903.356281841658;16661.263858203667;16847.241874115938;17133.74299385535;17298.394556190473;17582.032988185772;11357.943210283896;11738.295702257892;13813.171209727449;14248.928755356157;14777.630559236106;13803.447862085404;13981.930090349482;14001.22993235382;14314.284285785878;14396.784048239075;14311.499097531536;14353.067050641675;14434.855651443771;14645.267736612914;14764.261786910396;8643.092475290256;8925;8964.506952117696;8981.281497480317;9035;11920.284782913053;14248.64378390507;14490;14545;14729.92635036818 15:33:40 INFO - 2015-11-23 15:33:40,125 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1496.5659958612002;1653.8098118716348;1724.7844019497568;1724.9396271130506;1745.8865173763697;6884.3115688431135;6963.199232088311;7475.401967842573;7773.999999999993;7877.80305492363;7405.148407933089;7557.50876193047;7592.430567707416;7609.429292803048;7614.4669873108905;2265.8640481571074;2304.481491664379;2317.9884100579557;2318.53629274145;2322.8025617822423;2257.3792207143;2275.283285764987;2278.977210227893;2287.8512896661664;2302.7121609798774;2226.109556177526;2236.1502629000956;2237.093976939342;2260.9886950565224;2267.546490701858;2254.1096266974455;2286.1198438601177;2314.9652755208685;2319.9652005219937;2323.035940084863;2307.86152830829;2332.102140675852;2338.4504641409253;2340.8829558522007;2341.2390972933863;7731.7680469586;7773.611319434006;7789.06531216252;7790.649420776079;7825.882611760828;4662.393888794435;4748.477667456577;4781.091592597395;4789.114013907439;4789.760511974422;2979.016924414938;2995.1314118905493;3056.9388612227854;3076.5385192221124;3093.767967402431;988.6687959533565;1000.4047591682937;1902.5529000684828;1909.5035290824485;1913.6938089905548;10649.57401703931;10678.305910115818;10735.087517560938;10752.462376881125;10805.243632945698;4047.8785636430953;4083.6120568546535;4105.322621767375;4134.64855487281;4190.832366705358;8706.825863482694;8710.346723995726;8711.21599056088;8722.520261385685;8727;4683.906321873544;4684.110019096361;4685.789139488731;4697.6241900647865;4722;4247.936280955788;4304.763238021939;4340.262155433584;4351.086271882877;4364.672649551233;3684.2631473704832;3761.774293542396;3765.058735316171;3767.9246415072093;3786.5456145262747;1237.0907383073434;1245.8380410546752;1246.0965799795258;1246.401727170963;1249.981265268803;944.1596978688972;944.7496413450441;948.3266880514774;961.8605302231138;1075.4945175767377;7224.024756657889;7242.275772422821;7278.636068196569;7283;7333.376662983599;475.57911248545287;480.3779106057664;495.92561115832194;496.3225197605243;503.94960503950045;5698.572607054488;5766.740496677659;5789.623674461147;5815.156802263648;5830.533557315404;9351.485668288173;9399.91900931388;9407;9477.099675530813;9486.146246837818;9141.634334626673;9317.767055823659;9386.765330866647;9397.57710903011;9405.623775048922;7260.782176534713;7324.597147156957;7331.8900216496795;7356.37470814976;7411.370033547101;6645.60126392418;7038.3665470107935;7066.293370663098;7083.645817708991;7084.539504932163;8130.268275855202;8224.958875205586;8246.134155913544;8256.917430825615;8264.380171487042;8360.28937540316;8377.45546539473;8393.412461127662;8400.117987611213;8441.66233350659;6666.566673166229;6924.307569243036;6931.44548436134;6955.269696681978;7021.648917554;7445.367143792838;7446.4042876568665;7463.290987356192;7489.8876516851205;7508.849823003618;6913.308669133247;7024.016637670628;7118.9644051779405;7172.103487064117;7208.4593655475;6979.720811167496;7011.123609548807;7015.228324884157;7034.226235114235;7073.186583542958;6957.37383635455;7045.612491313027;7049.7885063448175;7060.470464715064;7081.681324340314;6158.414950579688;6199.380061993765;6207.968960155351;6223.595466294676;6234.875302493834;6270.0908368287255;6281.968590157203;6326.9683651581445;6349.619022858643;6423 15:33:40 INFO - 2015-11-23 15:33:40,128 DEBUG : BROWSER_OUTPUT: |4;prototype.html;338.8813915129705;341.2288228603356;346.11740062839783;349.0784329370461;352.8253514510318;6222.533310001751;6227.937720622793;6287.559870809046;6303.054541818724;6386.808395748123;6173.629582225059;6182.938170618292;6184.907226391608;6213.596116252441;6226.315105338409;4741.099191153687;4752.881177970552;4763.90472190556;4773.976130119345;4776.8566942991765;4777.90444191116;4780.259059845712;4794.137055330039;4794.568488836004;4795.616350691954;4550.476695180064;4604.3323718060865;4644.72131672099;4663.044075964436;4694.29585562165;4669.41632295963;4675.555822196886;4675.81296748128;4694;4702.882427939329;4071.75569465833;4093.3246014407587;4093.6315731584004;4099.528554216274;4105.055837157471;5831.329397119343;5847.327557330919;5860.681346696959;5876.55925805562;5876.55925805562;5261.289725886994;5434.619576629638;5448.673079615236;5508.3114610673665;5508.6970216638065;6556.049372840911;6565.868682626368;6582.703778329987;6583.177102862142;6584.209894812653;4431.335299705038;4455.554444555551;4456.465224173087;4459.977700111511;4467.106578684244;6718;6793.932060679429;6811.761588344434;6845.726170953156;6853.314668533157;4661;4672.462666793363;4677.111348843709;4677.2750223715375;4678.204705200124;4713.245880659147;4733.905321893543;4735;4737.218358970731;4748.145333839942;5498.917516237259;5523.7238138092935;5525.4474552544425;5527.751251193706;5528.115501519818;6495.577787443801;6646.235682896432;6660.9000864987065;6668.633225172565;6670.299618540081;1618.6924484348172;1635.9427420040242;1645.4569991902642;1648.7444446110633;1648.934042638305;1046.3042077018697;1052.921030922684;1055.37205362809;1071.0253669161182;1103.624767579027;6409.711562979677;6436.645984470805;6440.291567927524;6464.062710906892;6467.805965821033;6811.148606424197;6843.794686159324;6849.520533562702;6849.794506164823;6869.141357330333;6315.210598675166;6433.260175079832;6442.61344319333;6483.513736469689;6485.6108633482145;3701.8149092545264;3714.5542534895444;3724.72064595151;3731.1418373774186;3733.197362567061;7116.857662846714;7129.037579926748;7135.7859264221115;7142.607156606333;7150.892736608955;6911.481638877004;7010.719571217196;7017.719291228395;7085.610291433917;7091.6454177290925;7141.9285807142305;7142.142942846892;7149.106361704891;7149.7497587584185;7162.570245785269;6800.115984921928;6862.588244705334;6864.897026544706;6869.793906182823;6871.3472220141;6682.498812588978;6777.322267773183;6825.35159159879;6827.078344423439;6828.146481689789;7066.823329416806;7120.145582530129;7130.896385566167;7135.714571417086;7137.393321567725;4612.7001744886475;4656.278276867091;4672.74299913508;4684.953150468452;4685.273782563708;6613.66931653425;6871.347222013901;6876.896846547205;6885.173779146535;6893.862122757417;6696.263411024686;6705.195376554844;6706.295838937037;6707.463402927851;6707.8993815091835;6633.336666333328;6657.40083392497;6673.599584024974;6675.766348177791;6677.599344039373;6251.187345645037;6546.279909210079;6600.504962127764;6601.933980660132;6615.305392933865;6684.298148694317;6740.62926539045;6749.156355455568;6755.392014718699;6766.458683305422;6348.301686814539;6585.1439312889015;6587.571807832475;6592.67036648156;6596.868062638624 15:33:40 INFO - 2015-11-23 15:33:40,129 DEBUG : BROWSER_OUTPUT: |5;yui.html;773.6982576795051;816.6855760532197;830.7715378270975;832.1096426823294;854.58552601988;13262.801057984138;13380.59858204253;13539.864601353984;13597.864021359783;14396.568102956902;13510.93244533776;13586.116902401336;13598.252096134733;13607.795883061763;13638.522651707191;787.7518581646791;810.2100452059254;814.5886327404652;814.8777683347515;817.0154963269247;794.7417089445953;803.2931020701803;809.4333966223637;810.8175660476375;812.0580127052621;845.5518575155178;846.272205902923;846.289117141601;848.8090179709578;851.4423052900361;843.0852525010371;843.6372359885247;845.0788640381983;847.1274587175219;849.235687880906;621.2110619513193;621.9315875253764;622.2595111816969;624.3444383397415;626.3016736338994;13557.389917453738;13608.863911360859;13698.794518082237;13705.246211458365;13710.588682339545;11636.941815290955;11759.7060073498;12181;12253;12265.08011899111;10264.74338141545;10428.21788365868;10494.52774625136;10598.682039538826;10932.836007459815;3470.8946367477874;3506.789592624425;3532.258225772591;3553.662402071799;3579.0873327301633;49098.26352604749;49112.754436227944;49570.7521462394;49643.25535116976;49784.25323620148;9492.90507094934;9676.70969870905;9839.754006149904;9871.180496747173;10076.949615251877;17389.304427822746;17565.121743912754;17610;17612.823871761375;17632.090705033526;6752.3922846944015;7059.92940070603;7214.74748383804;7238.674259658328;7419.629018549051;3908.5309762828642;3926.1166237596885;3932.508436445444;3982.542007669097;4026.6778657707314;2845.701201373867;2859.3280579063903;2877.741003309712;2889.436559870847;2891.6385451818524;541.934967803866;545.6044367833289;549.9780008799603;553.3608681972329;553.7037684838673;604.4046614085123;633.8700566383973;646.4470200973659;662.8342914271432;679.3877540855403;8398.179997819223;8702.434341767765;8723.258523025486;8773.517456539825;8905.73282801517;622.6762083716533;643.5655932245716;669.397542212013;716.8351279205812;723.5043994863536;4079.449274347925;4091.672666186698;4121.835126594962;4191.91616167675;4261.936070958938;57997.71001144967;62335.688321558104;62639.6868015657;62666.37333626606;62672.68663656653;54768.17847732287;55308;55498.44501555013;55942.720286398304;56466;46902.76548617235;47121.76439117782;49604;50009.49990500121;50150.247746283836;8788.868166977372;8929;9115.817683646423;9208.263338932735;9214.631414743335;33406.83296583501;34191.31617367688;34199.65800342064;34464.65535344614;34676.306473869874;42867.785661071495;46602.48360541484;47008.29487557621;47313.52686473229;47515.28727069166;11016.339019658846;11120.832312607059;11341.376224307412;11361.832182265514;11517.193796434169;11830.645080647595;11955.581554645545;12383.938080309901;12570.1200915935;12676.366181690693;11163.609273675382;11302;11374.601888933848;11730.19946689917;11745;10932.180086493387;11420;11506.194566380273;11817.704557386134;11942;10692.358458492516;10754.89245107539;10813.459327033774;10947.83578246343;11140.220184587;9209.731752963195;9443.480608566595;9454.95272523633;9473.66842160521;10159.695209143738;8377.204165604258;8387.41288109851;8917.554122293988;9073.77315567116;9503.382280151767 15:33:40 INFO - 2015-11-23 15:33:40,130 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:33:40 INFO - 2015-11-23 15:33:40,130 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:33:40 INFO - 2015-11-23 15:33:40,130 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,316 15:33:40 INFO - 2015-11-23 15:33:40,130 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:33:40 INFO - 2015-11-23 15:33:40,130 DEBUG : BROWSER_OUTPUT: __startTimestamp1448321620115__endTimestamp 15:33:40 INFO - 2015-11-23 15:33:40,131 DEBUG : BROWSER_OUTPUT: 15:33:40 INFO - 2015-11-23 15:33:40,131 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:33:40 INFO - 2015-11-23 15:33:40,131 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:33:40 INFO - 2015-11-23 15:33:40,131 DEBUG : BROWSER_OUTPUT: 15:33:40 INFO - 2015-11-23 15:33:40,131 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5405.48 Median:5588.69 stddev:597.46 (10.7%) stddev-sans-first:573.90 15:33:40 INFO - 2015-11-23 15:33:40,131 DEBUG : BROWSER_OUTPUT: Values: 3208.6 3262.9 3282.9 3299.7 3311.8 5160.7 5382.2 5400.3 5404.9 5425.6 5242.1 5271.2 5361.3 5420.5 5487.2 4863.7 4915.4 4987.1 4997.6 5020.0 4885.3 4899.4 4925.8 4967.5 5027.2 4737.3 4814.6 4929.9 4994.7 5019.4 4949.6 4957.3 5002.8 5030.6 5036.9 4955.8 4965.0 4977.7 4986.3 5000.9 5057.5 5109.0 5217.4 5230.8 5327.4 5776.2 5789.2 5790.6 5808.2 5902.8 5857.8 5862.5 5864.1 5873.9 5877.4 5219.5 5352.7 5357.5 5447.1 5507.7 5887.4 5921.3 5948.3 5957.2 5966.1 5476.2 5749.7 5758.3 5762.0 5774.5 5718.7 5823.2 5933.1 5939.1 5990.5 5855.5 5910.3 5913.8 5930.1 5951.1 5635.1 5759.7 5869.5 5919.6 5922.9 4483.5 4542.8 4543.5 4575.7 4585.5 4011.3 4021.0 4025.3 4027.7 4052.5 5360.7 5431.3 5453.3 5557.1 5568.2 5801.6 5833.2 5855.0 5875.1 5986.1 5521.5 5578.2 5584.4 5587.6 5602.8 4921.1 5017.2 5033.8 5119.4 5130.6 5988.6 5994.3 6017.4 6041.5 6056.9 5838.8 5866.5 5874.3 5885.5 5895.4 5875.6 5984.5 6034.8 6074.8 6104.3 5621.8 5663.5 5670.2 5679.7 5736.0 5833.5 5837.4 5842.9 5861.6 5864.8 5450.6 5579.6 5608.9 5720.1 5733.1 5625.0 5658.9 5662.4 5705.9 5829.3 5544.8 5565.9 5609.2 5611.5 5614.9 5439.6 5521.6 5706.0 5791.8 5814.6 5569.7 5588.7 5604.2 5605.2 5639.7 15:33:40 INFO - 2015-11-23 15:33:40,132 DEBUG : BROWSER_OUTPUT: 15:33:40 INFO - 2015-11-23 15:33:40,132 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49635.50 Median:21547.30 stddev:83794.67 (388.9%) stddev-sans-first:83948.70 15:33:40 INFO - 2015-11-23 15:33:40,133 DEBUG : BROWSER_OUTPUT: Values: 552.9 588.4 590.6 595.1 596.8 40495.8 41026.2 41130.2 41143.6 41280.6 42342.0 42836.4 42836.8 43218.6 43259.1 8681.8 8898.5 8904.8 8972.1 8973.7 8740.3 8885.8 8888.3 8888.8 8893.0 8850.3 8931.0 8937.4 8940.8 8946.4 8791.9 8819.7 8849.3 8889.6 8906.3 8713.9 8820.6 8837.8 8868.0 8901.9 39339.2 40240.0 40265.8 40290.6 40371.6 3152.4 3470.2 3526.0 3731.1 3990.7 29752.6 29789.7 30399.0 30528.4 31417.0 3707.1 3725.1 3920.0 3983.5 4024.0 269319.0 271572.0 272056.0 272393.0 272531.0 60188.4 61143.4 61198.4 61308.7 61329.4 65132.0 71036.6 71801.0 71980.6 72715.6 14419.7 14505.7 14537.3 14538.4 14558.6 11379.7 11479.7 11489.7 11522.4 11529.5 20988.3 21016.8 21019.4 21204.9 21297.4 7892.5 7980.5 8034.8 8084.2 8130.3 860.8 881.6 891.4 946.1 1022.5 28454.3 29136.3 32511.0 33517.2 33805.7 1009.8 1055.3 1076.2 1084.7 1102.6 15127.9 15206.2 15238.4 15330.5 15404.9 379187.0 386751.0 387976.0 389299.0 389478.0 53103.2 53713.7 54103.7 54253.5 54351.0 1327.2 1354.3 1354.7 1354.9 1461.0 28019.0 28533.4 28582.0 28853.1 29331.3 47873.0 49189.8 49262.0 49295.3 49349.0 287658.0 288102.0 288425.0 288784.0 288973.0 42445.4 46528.0 46618.1 47385.3 47517.8 44114.8 44448.8 44733.8 44899.6 45102.5 37224.0 37585.2 38566.0 38672.2 39107.8 37579.8 37930.0 38821.6 39174.6 39211.4 36741.3 37040.4 37423.0 37474.6 37654.4 32800.7 34238.7 34302.7 34604.3 34628.5 25934.7 26201.4 26450.9 26460.2 26642.3 15:33:40 INFO - 2015-11-23 15:33:40,133 DEBUG : BROWSER_OUTPUT: 15:33:40 INFO - 2015-11-23 15:33:40,133 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28427.13 Median:402.29 stddev:87449.79 (21738.1%) stddev-sans-first:87669.68 15:33:40 INFO - 2015-11-23 15:33:40,135 DEBUG : BROWSER_OUTPUT: Values: 343.1 360.9 362.2 363.0 364.4 16811.2 17364.6 17517.1 18094.5 18297.2 13806.1 16183.0 16189.4 16318.1 16436.5 4818.1 4913.3 4939.2 4957.3 4957.5 4844.7 4863.4 4944.0 4956.2 4958.2 4327.9 5216.4 5316.6 5331.1 5370.0 5293.0 5308.0 5320.5 5324.8 5327.8 5161.8 5360.7 5367.9 5370.6 5376.8 14822.0 20397.7 20681.0 21604.1 21608.0 2085.2 2103.6 2157.8 2184.1 2215.9 9691.7 9843.9 10064.6 11433.1 13181.7 1781.9 1825.2 1851.4 1868.1 1917.2 63045.0 63336.7 63773.4 65213.3 66853.0 10163.3 10245.2 10410.1 10450.9 10462.4 13458.9 13529.2 13597.3 13641.2 13648.8 6972.5 7227.6 7386.9 7464.7 7617.1 7324.9 7397.3 7407.3 7407.5 7412.1 4449.6 4548.6 4555.6 4560.2 4565.4 1817.0 1817.2 1827.9 1840.4 1843.4 384.6 388.3 397.2 407.4 410.8 10311.0 10406.9 10464.2 10593.5 10626.5 424.8 427.3 430.7 444.4 452.0 5650.9 5672.6 5674.6 5692.9 5701.1 510954.0 529541.0 534566.0 546342.0 548170.0 80118.0 80714.0 80770.6 81234.0 81711.6 461.5 462.9 468.4 470.2 472.9 10113.2 10133.8 10136.4 10243.7 10345.3 36038.6 36125.0 36876.3 37610.8 38285.8 46160.5 46699.8 48776.8 51140.0 52890.7 8636.5 9406.1 9824.1 9843.8 9903.4 16661.3 16847.2 17133.7 17298.4 17582.0 11357.9 11738.3 13813.2 14248.9 14777.6 13803.4 13981.9 14001.2 14314.3 14396.8 14311.5 14353.1 14434.9 14645.3 14764.3 8643.1 8925.0 8964.5 8981.3 9035.0 11920.3 14248.6 14490.0 14545.0 14729.9 15:33:40 INFO - 2015-11-23 15:33:40,135 DEBUG : BROWSER_OUTPUT: 15:33:40 INFO - 2015-11-23 15:33:40,135 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5417.68 Median:6276.03 stddev:2790.97 (44.5%) stddev-sans-first:2783.24 15:33:40 INFO - 2015-11-23 15:33:40,136 DEBUG : BROWSER_OUTPUT: Values: 1496.6 1653.8 1724.8 1724.9 1745.9 6884.3 6963.2 7475.4 7774.0 7877.8 7405.1 7557.5 7592.4 7609.4 7614.5 2265.9 2304.5 2318.0 2318.5 2322.8 2257.4 2275.3 2279.0 2287.9 2302.7 2226.1 2236.2 2237.1 2261.0 2267.5 2254.1 2286.1 2315.0 2320.0 2323.0 2307.9 2332.1 2338.5 2340.9 2341.2 7731.8 7773.6 7789.1 7790.6 7825.9 4662.4 4748.5 4781.1 4789.1 4789.8 2979.0 2995.1 3056.9 3076.5 3093.8 988.7 1000.4 1902.6 1909.5 1913.7 10649.6 10678.3 10735.1 10752.5 10805.2 4047.9 4083.6 4105.3 4134.6 4190.8 8706.8 8710.3 8711.2 8722.5 8727.0 4683.9 4684.1 4685.8 4697.6 4722.0 4247.9 4304.8 4340.3 4351.1 4364.7 3684.3 3761.8 3765.1 3767.9 3786.5 1237.1 1245.8 1246.1 1246.4 1250.0 944.2 944.7 948.3 961.9 1075.5 7224.0 7242.3 7278.6 7283.0 7333.4 475.6 480.4 495.9 496.3 503.9 5698.6 5766.7 5789.6 5815.2 5830.5 9351.5 9399.9 9407.0 9477.1 9486.1 9141.6 9317.8 9386.8 9397.6 9405.6 7260.8 7324.6 7331.9 7356.4 7411.4 6645.6 7038.4 7066.3 7083.6 7084.5 8130.3 8225.0 8246.1 8256.9 8264.4 8360.3 8377.5 8393.4 8400.1 8441.7 6666.6 6924.3 6931.4 6955.3 7021.6 7445.4 7446.4 7463.3 7489.9 7508.8 6913.3 7024.0 7119.0 7172.1 7208.5 6979.7 7011.1 7015.2 7034.2 7073.2 6957.4 7045.6 7049.8 7060.5 7081.7 6158.4 6199.4 6208.0 6223.6 6234.9 6270.1 6282.0 6327.0 6349.6 6423.0 15:33:40 INFO - 2015-11-23 15:33:40,137 DEBUG : BROWSER_OUTPUT: 15:33:40 INFO - 2015-11-23 15:33:40,137 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5537.29 Median:6331.76 stddev:1694.87 (26.8%) stddev-sans-first:1654.11 15:33:40 INFO - 2015-11-23 15:33:40,138 DEBUG : BROWSER_OUTPUT: Values: 338.9 341.2 346.1 349.1 352.8 6222.5 6227.9 6287.6 6303.1 6386.8 6173.6 6182.9 6184.9 6213.6 6226.3 4741.1 4752.9 4763.9 4774.0 4776.9 4777.9 4780.3 4794.1 4794.6 4795.6 4550.5 4604.3 4644.7 4663.0 4694.3 4669.4 4675.6 4675.8 4694.0 4702.9 4071.8 4093.3 4093.6 4099.5 4105.1 5831.3 5847.3 5860.7 5876.6 5876.6 5261.3 5434.6 5448.7 5508.3 5508.7 6556.0 6565.9 6582.7 6583.2 6584.2 4431.3 4455.6 4456.5 4460.0 4467.1 6718.0 6793.9 6811.8 6845.7 6853.3 4661.0 4672.5 4677.1 4677.3 4678.2 4713.2 4733.9 4735.0 4737.2 4748.1 5498.9 5523.7 5525.4 5527.8 5528.1 6495.6 6646.2 6660.9 6668.6 6670.3 1618.7 1635.9 1645.5 1648.7 1648.9 1046.3 1052.9 1055.4 1071.0 1103.6 6409.7 6436.6 6440.3 6464.1 6467.8 6811.1 6843.8 6849.5 6849.8 6869.1 6315.2 6433.3 6442.6 6483.5 6485.6 3701.8 3714.6 3724.7 3731.1 3733.2 7116.9 7129.0 7135.8 7142.6 7150.9 6911.5 7010.7 7017.7 7085.6 7091.6 7141.9 7142.1 7149.1 7149.7 7162.6 6800.1 6862.6 6864.9 6869.8 6871.3 6682.5 6777.3 6825.4 6827.1 6828.1 7066.8 7120.1 7130.9 7135.7 7137.4 4612.7 4656.3 4672.7 4685.0 4685.3 6613.7 6871.3 6876.9 6885.2 6893.9 6696.3 6705.2 6706.3 6707.5 6707.9 6633.3 6657.4 6673.6 6675.8 6677.6 6251.2 6546.3 6600.5 6601.9 6615.3 6684.3 6740.6 6749.2 6755.4 6766.5 6348.3 6585.1 6587.6 6592.7 6596.9 15:33:40 INFO - 2015-11-23 15:33:40,138 DEBUG : BROWSER_OUTPUT: 15:33:40 INFO - 2015-11-23 15:33:40,139 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14125.92 Median:49341.75 stddev:16850.03 (34.1%) stddev-sans-first:16867.47 15:33:40 INFO - 2015-11-23 15:33:40,140 DEBUG : BROWSER_OUTPUT: Values: 773.7 816.7 830.8 832.1 854.6 13262.8 13380.6 13539.9 13597.9 14396.6 13510.9 13586.1 13598.3 13607.8 13638.5 787.8 810.2 814.6 814.9 817.0 794.7 803.3 809.4 810.8 812.1 845.6 846.3 846.3 848.8 851.4 843.1 843.6 845.1 847.1 849.2 621.2 621.9 622.3 624.3 626.3 13557.4 13608.9 13698.8 13705.2 13710.6 11636.9 11759.7 12181.0 12253.0 12265.1 10264.7 10428.2 10494.5 10598.7 10932.8 3470.9 3506.8 3532.3 3553.7 3579.1 49098.3 49112.8 49570.8 49643.3 49784.3 9492.9 9676.7 9839.8 9871.2 10076.9 17389.3 17565.1 17610.0 17612.8 17632.1 6752.4 7059.9 7214.7 7238.7 7419.6 3908.5 3926.1 3932.5 3982.5 4026.7 2845.7 2859.3 2877.7 2889.4 2891.6 541.9 545.6 550.0 553.4 553.7 604.4 633.9 646.4 662.8 679.4 8398.2 8702.4 8723.3 8773.5 8905.7 622.7 643.6 669.4 716.8 723.5 4079.4 4091.7 4121.8 4191.9 4261.9 57997.7 62335.7 62639.7 62666.4 62672.7 54768.2 55308.0 55498.4 55942.7 56466.0 46902.8 47121.8 49604.0 50009.5 50150.2 8788.9 8929.0 9115.8 9208.3 9214.6 33406.8 34191.3 34199.7 34464.7 34676.3 42867.8 46602.5 47008.3 47313.5 47515.3 11016.3 11120.8 11341.4 11361.8 11517.2 11830.6 11955.6 12383.9 12570.1 12676.4 11163.6 11302.0 11374.6 11730.2 11745.0 10932.2 11420.0 11506.2 11817.7 11942.0 10692.4 10754.9 10813.5 10947.8 11140.2 9209.7 9443.5 9455.0 9473.7 10159.7 8377.2 8387.4 8917.6 9073.8 9503.4 15:33:40 INFO - 2015-11-23 15:33:40,140 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:33:40 INFO - 2015-11-23 15:33:40,140 DEBUG : BROWSER_OUTPUT: 15:33:40 INFO - 2015-11-23 15:33:40,733 INFO : Browser exited with error code: 0 15:33:40 INFO - 2015-11-23 15:33:40,755 INFO : Completed test dromaeo_css (00:18:30) 15:33:40 INFO - 2015-11-23 15:33:40,755 INFO : Starting test kraken 15:33:40 INFO - 2015-11-23 15:33:40,755 DEBUG : operating with platform_type : linux_ 15:33:40 INFO - 2015-11-23 15:33:40,755 INFO : Initialising browser for kraken test... 15:33:40 INFO - 2015-11-23 15:33:40,761 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8Qrqrz/profile http://localhost:40365/getInfo.html 15:33:44 INFO - 2015-11-23 15:33:44,897 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:33:44 INFO - 2015-11-23 15:33:44,897 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:33:44 INFO - 2015-11-23 15:33:44,897 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:33:44 INFO - 2015-11-23 15:33:44,898 DEBUG : BROWSER_OUTPUT: __metrics 15:33:45 INFO - 2015-11-23 15:33:45,889 INFO : Browser initialized. 15:33:45 INFO - 2015-11-23 15:33:45,890 INFO : Running cycle 1/1 for kraken test... 15:33:45 INFO - 2015-11-23 15:33:45,890 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8Qrqrz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:33:57 INFO - 2015-11-23 15:33:57,700 DEBUG : BROWSER_OUTPUT: RSS: Main: 140537856 15:33:57 INFO - 2015-11-23 15:33:57,700 DEBUG : BROWSER_OUTPUT: 15:34:00 INFO - 2015-11-23 15:34:00,195 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40365/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40365/tests/kraken/driver.html?testName=audio-beat-detection) 15:34:00 INFO - 2015-11-23 15:34:00,801 DEBUG : BROWSER_OUTPUT: RSS: Main: 143339520 15:34:00 INFO - 2015-11-23 15:34:00,801 DEBUG : BROWSER_OUTPUT: 15:34:03 INFO - 2015-11-23 15:34:03,419 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40365/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40365/tests/kraken/driver.html?testName=audio-dft) 15:34:04 INFO - 2015-11-23 15:34:04,008 DEBUG : BROWSER_OUTPUT: RSS: Main: 142647296 15:34:04 INFO - 2015-11-23 15:34:04,008 DEBUG : BROWSER_OUTPUT: 15:34:06 INFO - 2015-11-23 15:34:06,846 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40365/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40365/tests/kraken/driver.html?testName=audio-fft) 15:34:07 INFO - 2015-11-23 15:34:07,428 DEBUG : BROWSER_OUTPUT: RSS: Main: 137326592 15:34:07 INFO - 2015-11-23 15:34:07,429 DEBUG : BROWSER_OUTPUT: 15:34:09 INFO - 2015-11-23 15:34:09,446 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40365/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40365/tests/kraken/driver.html?testName=audio-oscillator) 15:34:10 INFO - 2015-11-23 15:34:10,031 DEBUG : BROWSER_OUTPUT: RSS: Main: 138956800 15:34:10 INFO - 2015-11-23 15:34:10,032 DEBUG : BROWSER_OUTPUT: 15:34:12 INFO - 2015-11-23 15:34:12,252 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40365/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40365/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:34:12 INFO - 2015-11-23 15:34:12,834 DEBUG : BROWSER_OUTPUT: RSS: Main: 139673600 15:34:12 INFO - 2015-11-23 15:34:12,834 DEBUG : BROWSER_OUTPUT: 15:34:15 INFO - 2015-11-23 15:34:15,820 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40365/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40365/tests/kraken/driver.html?testName=imaging-darkroom) 15:34:16 INFO - 2015-11-23 15:34:16,405 DEBUG : BROWSER_OUTPUT: RSS: Main: 140615680 15:34:16 INFO - 2015-11-23 15:34:16,406 DEBUG : BROWSER_OUTPUT: 15:34:19 INFO - 2015-11-23 15:34:19,780 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40365/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40365/tests/kraken/driver.html?testName=imaging-desaturate) 15:34:20 INFO - 2015-11-23 15:34:20,366 DEBUG : BROWSER_OUTPUT: RSS: Main: 140775424 15:34:20 INFO - 2015-11-23 15:34:20,366 DEBUG : BROWSER_OUTPUT: 15:34:23 INFO - 2015-11-23 15:34:23,206 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40365/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40365/tests/kraken/driver.html?testName=json-parse-financial) 15:34:23 INFO - 2015-11-23 15:34:23,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 140529664 15:34:23 INFO - 2015-11-23 15:34:23,799 DEBUG : BROWSER_OUTPUT: 15:34:25 INFO - 2015-11-23 15:34:25,394 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40365/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40365/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:34:25 INFO - 2015-11-23 15:34:25,967 DEBUG : BROWSER_OUTPUT: RSS: Main: 139550720 15:34:25 INFO - 2015-11-23 15:34:25,967 DEBUG : BROWSER_OUTPUT: 15:34:27 INFO - 2015-11-23 15:34:27,790 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40365/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40365/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:34:28 INFO - 2015-11-23 15:34:28,403 DEBUG : BROWSER_OUTPUT: RSS: Main: 139833344 15:34:28 INFO - 2015-11-23 15:34:28,404 DEBUG : BROWSER_OUTPUT: 15:34:30 INFO - 2015-11-23 15:34:30,467 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40365/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40365/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:34:31 INFO - 2015-11-23 15:34:31,060 DEBUG : BROWSER_OUTPUT: RSS: Main: 139792384 15:34:31 INFO - 2015-11-23 15:34:31,061 DEBUG : BROWSER_OUTPUT: 15:34:33 INFO - 2015-11-23 15:34:33,525 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40365/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40365/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:34:34 INFO - 2015-11-23 15:34:34,127 DEBUG : BROWSER_OUTPUT: RSS: Main: 139558912 15:34:34 INFO - 2015-11-23 15:34:34,127 DEBUG : BROWSER_OUTPUT: 15:34:36 INFO - 2015-11-23 15:34:36,763 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40365/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40365/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:34:37 INFO - 2015-11-23 15:34:37,345 DEBUG : BROWSER_OUTPUT: RSS: Main: 140587008 15:34:37 INFO - 2015-11-23 15:34:37,345 DEBUG : BROWSER_OUTPUT: 15:34:39 INFO - 2015-11-23 15:34:39,026 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40365/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40365/tests/kraken/driver.html?testName=ai-astar) 15:34:39 INFO - 2015-11-23 15:34:39,276 DEBUG : BROWSER_OUTPUT: RSS: Main: 140906496 15:34:39 INFO - 2015-11-23 15:34:39,276 DEBUG : BROWSER_OUTPUT: 15:34:39 INFO - 2015-11-23 15:34:39,277 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:34:39 INFO - 2015-11-23 15:34:39,277 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:34:39 INFO - 2015-11-23 15:34:39,277 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:34:39 INFO - 2015-11-23 15:34:39,277 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:34:39 INFO - 2015-11-23 15:34:39,277 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;107;114;112;111;124;111;109;111;109 15:34:39 INFO - 2015-11-23 15:34:39,278 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;124;150;160;125;149;148;129;173;127 15:34:39 INFO - 2015-11-23 15:34:39,278 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;163;162;162;161;162;161;163;170;162 15:34:39 INFO - 2015-11-23 15:34:39,278 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;72;73;72;76;72;72;71;137;72 15:34:39 INFO - 2015-11-23 15:34:39,278 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;138;92;92;93;145;94;93;141 15:34:39 INFO - 2015-11-23 15:34:39,279 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;111;113;110;110;110;110;109;110;111 15:34:39 INFO - 2015-11-23 15:34:39,280 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;147;146;147;147;147;147;147;146 15:34:39 INFO - 2015-11-23 15:34:39,280 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;96;97;97;96;96 15:34:39 INFO - 2015-11-23 15:34:39,280 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;62;64;63;64;63;62;63;64;64 15:34:39 INFO - 2015-11-23 15:34:39,280 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;68;70;69;69;68;68;69 15:34:39 INFO - 2015-11-23 15:34:39,280 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;94;86;87;88;86;86;85;87;87 15:34:39 INFO - 2015-11-23 15:34:39,280 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;129;122;118;129;121;120;128;122;119 15:34:39 INFO - 2015-11-23 15:34:39,280 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;158;151;151;163;152;151;160;152;152 15:34:39 INFO - 2015-11-23 15:34:39,281 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;73;72;67;67;66;72;67;68;68 15:34:39 INFO - 2015-11-23 15:34:39,281 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:34:39 INFO - 2015-11-23 15:34:39,281 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:34:39 INFO - 2015-11-23 15:34:39,281 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,706 15:34:39 INFO - 2015-11-23 15:34:39,281 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:34:39 INFO - 2015-11-23 15:34:39,281 DEBUG : BROWSER_OUTPUT: __startTimestamp1448321679276__endTimestamp 15:34:39 INFO - 2015-11-23 15:34:39,281 DEBUG : BROWSER_OUTPUT: 15:34:39 INFO - 2015-11-23 15:34:39,285 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:34:39 INFO - 2015-11-23 15:34:39,285 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:34:39 INFO - 2015-11-23 15:34:39,285 DEBUG : BROWSER_OUTPUT: 15:34:39 INFO - 2015-11-23 15:34:39,285 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.90 Median:111.00 stddev:4.65 (4.2%) stddev-sans-first:4.92 15:34:39 INFO - 2015-11-23 15:34:39,285 DEBUG : BROWSER_OUTPUT: Values: 111.0 107.0 114.0 112.0 111.0 124.0 111.0 109.0 111.0 109.0 15:34:39 INFO - 2015-11-23 15:34:39,285 DEBUG : BROWSER_OUTPUT: 15:34:39 INFO - 2015-11-23 15:34:39,285 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.40 Median:149.50 stddev:17.23 (11.5%) stddev-sans-first:17.45 15:34:39 INFO - 2015-11-23 15:34:39,285 DEBUG : BROWSER_OUTPUT: Values: 159.0 124.0 150.0 160.0 125.0 149.0 148.0 129.0 173.0 127.0 15:34:39 INFO - 2015-11-23 15:34:39,286 DEBUG : BROWSER_OUTPUT: 15:34:39 INFO - 2015-11-23 15:34:39,286 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.00 Median:162.50 stddev:2.62 (1.6%) stddev-sans-first:2.76 15:34:39 INFO - 2015-11-23 15:34:39,286 DEBUG : BROWSER_OUTPUT: Values: 164.0 163.0 162.0 162.0 161.0 162.0 161.0 163.0 170.0 162.0 15:34:39 INFO - 2015-11-23 15:34:39,286 DEBUG : BROWSER_OUTPUT: 15:34:39 INFO - 2015-11-23 15:34:39,286 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.10 Median:72.00 stddev:20.39 (28.3%) stddev-sans-first:21.55 15:34:39 INFO - 2015-11-23 15:34:39,286 DEBUG : BROWSER_OUTPUT: Values: 74.0 72.0 73.0 72.0 76.0 72.0 72.0 71.0 137.0 72.0 15:34:39 INFO - 2015-11-23 15:34:39,286 DEBUG : BROWSER_OUTPUT: 15:34:39 INFO - 2015-11-23 15:34:39,286 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.40 Median:93.00 stddev:23.48 (25.2%) stddev-sans-first:24.32 15:34:39 INFO - 2015-11-23 15:34:39,287 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 138.0 92.0 92.0 93.0 145.0 94.0 93.0 141.0 15:34:39 INFO - 2015-11-23 15:34:39,287 DEBUG : BROWSER_OUTPUT: 15:34:39 INFO - 2015-11-23 15:34:39,287 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.50 Median:110.50 stddev:1.08 (1.0%) stddev-sans-first:1.13 15:34:39 INFO - 2015-11-23 15:34:39,287 DEBUG : BROWSER_OUTPUT: Values: 111.0 111.0 113.0 110.0 110.0 110.0 110.0 109.0 110.0 111.0 15:34:39 INFO - 2015-11-23 15:34:39,287 DEBUG : BROWSER_OUTPUT: 15:34:39 INFO - 2015-11-23 15:34:39,287 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 15:34:39 INFO - 2015-11-23 15:34:39,287 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 147.0 146.0 147.0 147.0 147.0 147.0 147.0 146.0 15:34:39 INFO - 2015-11-23 15:34:39,287 DEBUG : BROWSER_OUTPUT: 15:34:39 INFO - 2015-11-23 15:34:39,287 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:34:39 INFO - 2015-11-23 15:34:39,287 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 96.0 97.0 97.0 96.0 96.0 15:34:39 INFO - 2015-11-23 15:34:39,288 DEBUG : BROWSER_OUTPUT: 15:34:39 INFO - 2015-11-23 15:34:39,288 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:63.20 Median:63.50 stddev:0.79 (1.2%) stddev-sans-first:0.83 15:34:39 INFO - 2015-11-23 15:34:39,288 DEBUG : BROWSER_OUTPUT: Values: 63.0 62.0 64.0 63.0 64.0 63.0 62.0 63.0 64.0 64.0 15:34:39 INFO - 2015-11-23 15:34:39,288 DEBUG : BROWSER_OUTPUT: 15:34:39 INFO - 2015-11-23 15:34:39,288 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 15:34:39 INFO - 2015-11-23 15:34:39,288 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 68.0 70.0 69.0 69.0 68.0 68.0 69.0 15:34:39 INFO - 2015-11-23 15:34:39,288 DEBUG : BROWSER_OUTPUT: 15:34:39 INFO - 2015-11-23 15:34:39,288 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:87.00 stddev:2.71 (3.1%) stddev-sans-first:2.65 15:34:39 INFO - 2015-11-23 15:34:39,288 DEBUG : BROWSER_OUTPUT: Values: 84.0 94.0 86.0 87.0 88.0 86.0 86.0 85.0 87.0 87.0 15:34:39 INFO - 2015-11-23 15:34:39,288 DEBUG : BROWSER_OUTPUT: 15:34:39 INFO - 2015-11-23 15:34:39,288 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.80 Median:122.00 stddev:4.24 (3.5%) stddev-sans-first:4.37 15:34:39 INFO - 2015-11-23 15:34:39,288 DEBUG : BROWSER_OUTPUT: Values: 120.0 129.0 122.0 118.0 129.0 121.0 120.0 128.0 122.0 119.0 15:34:39 INFO - 2015-11-23 15:34:39,288 DEBUG : BROWSER_OUTPUT: 15:34:39 INFO - 2015-11-23 15:34:39,288 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.00 Median:152.00 stddev:6.31 (4.1%) stddev-sans-first:4.61 15:34:39 INFO - 2015-11-23 15:34:39,289 DEBUG : BROWSER_OUTPUT: Values: 140.0 158.0 151.0 151.0 163.0 152.0 151.0 160.0 152.0 152.0 15:34:39 INFO - 2015-11-23 15:34:39,289 DEBUG : BROWSER_OUTPUT: 15:34:39 INFO - 2015-11-23 15:34:39,289 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:68.00 stddev:2.58 (3.8%) stddev-sans-first:2.67 15:34:39 INFO - 2015-11-23 15:34:39,289 DEBUG : BROWSER_OUTPUT: Values: 67.0 73.0 72.0 67.0 67.0 66.0 72.0 67.0 68.0 68.0 15:34:39 INFO - 2015-11-23 15:34:39,289 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:34:39 INFO - 2015-11-23 15:34:39,289 DEBUG : BROWSER_OUTPUT: 15:34:40 INFO - 2015-11-23 15:34:40,161 INFO : Browser exited with error code: 0 15:34:40 INFO - 2015-11-23 15:34:40,212 INFO : Completed test kraken (00:00:59) 15:34:40 INFO - 2015-11-23 15:34:40,212 INFO : Starting test v8_7 15:34:40 INFO - 2015-11-23 15:34:40,212 DEBUG : operating with platform_type : linux_ 15:34:40 INFO - 2015-11-23 15:34:40,213 INFO : Initialising browser for v8_7 test... 15:34:40 INFO - 2015-11-23 15:34:40,219 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpChhsP9/profile http://localhost:40365/getInfo.html 15:34:44 INFO - 2015-11-23 15:34:44,599 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:34:44 INFO - 2015-11-23 15:34:44,599 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:34:44 INFO - 2015-11-23 15:34:44,599 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:34:44 INFO - 2015-11-23 15:34:44,599 DEBUG : BROWSER_OUTPUT: __metrics 15:34:45 INFO - 2015-11-23 15:34:45,657 INFO : Browser initialized. 15:34:45 INFO - 2015-11-23 15:34:45,658 INFO : Running cycle 1/1 for v8_7 test... 15:34:45 INFO - 2015-11-23 15:34:45,658 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpChhsP9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:34:57 INFO - 2015-11-23 15:34:57,483 DEBUG : BROWSER_OUTPUT: RSS: Main: 142594048 15:34:57 INFO - 2015-11-23 15:34:57,484 DEBUG : BROWSER_OUTPUT: 15:35:18 INFO - 2015-11-23 15:35:18,887 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40365/tests/v8_7/run.html (next: http://localhost:40365/tests/v8_7/run.html) 15:35:19 INFO - 2015-11-23 15:35:19,137 DEBUG : BROWSER_OUTPUT: RSS: Main: 139038720 15:35:19 INFO - 2015-11-23 15:35:19,137 DEBUG : BROWSER_OUTPUT: 15:35:19 INFO - 2015-11-23 15:35:19,137 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:35:19 INFO - 2015-11-23 15:35:19,137 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:35:19 INFO - 2015-11-23 15:35:19,137 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:35:19 INFO - 2015-11-23 15:35:19,138 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:35:19 INFO - 2015-11-23 15:35:19,138 DEBUG : BROWSER_OUTPUT: |0;Richards;167.7008217340265 15:35:19 INFO - 2015-11-23 15:35:19,138 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.30099269526127 15:35:19 INFO - 2015-11-23 15:35:19,138 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.6291446085261 15:35:19 INFO - 2015-11-23 15:35:19,138 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5278.9473684210525 15:35:19 INFO - 2015-11-23 15:35:19,138 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1077.502691065662 15:35:19 INFO - 2015-11-23 15:35:19,138 DEBUG : BROWSER_OUTPUT: |5;Earley;748.502994011976 15:35:19 INFO - 2015-11-23 15:35:19,139 DEBUG : BROWSER_OUTPUT: |6;Boyer;12219.512195121952 15:35:19 INFO - 2015-11-23 15:35:19,139 DEBUG : BROWSER_OUTPUT: |7;RegExp;25923.076923076922 15:35:19 INFO - 2015-11-23 15:35:19,139 DEBUG : BROWSER_OUTPUT: |8;Splay;567.2149744753261 15:35:19 INFO - 2015-11-23 15:35:19,139 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 15:35:19 INFO - 2015-11-23 15:35:19,139 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:35:19 INFO - 2015-11-23 15:35:19,139 DEBUG : BROWSER_OUTPUT: __startTimestamp1448321719134__endTimestamp 15:35:19 INFO - 2015-11-23 15:35:19,140 DEBUG : BROWSER_OUTPUT: 15:35:19 INFO - 2015-11-23 15:35:19,140 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:35:19 INFO - 2015-11-23 15:35:19,140 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:35:19 INFO - 2015-11-23 15:35:19,140 DEBUG : BROWSER_OUTPUT: 15:35:19 INFO - 2015-11-23 15:35:19,140 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.70 Median:167.70 stddev:0.00 (0.0%) 15:35:19 INFO - 2015-11-23 15:35:19,140 DEBUG : BROWSER_OUTPUT: Values: 167.7 15:35:19 INFO - 2015-11-23 15:35:19,140 DEBUG : BROWSER_OUTPUT: 15:35:19 INFO - 2015-11-23 15:35:19,141 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.30 Median:187.30 stddev:0.00 (0.0%) 15:35:19 INFO - 2015-11-23 15:35:19,141 DEBUG : BROWSER_OUTPUT: Values: 187.3 15:35:19 INFO - 2015-11-23 15:35:19,141 DEBUG : BROWSER_OUTPUT: 15:35:19 INFO - 2015-11-23 15:35:19,141 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.63 Median:278.63 stddev:0.00 (0.0%) 15:35:19 INFO - 2015-11-23 15:35:19,141 DEBUG : BROWSER_OUTPUT: Values: 278.6 15:35:19 INFO - 2015-11-23 15:35:19,141 DEBUG : BROWSER_OUTPUT: 15:35:19 INFO - 2015-11-23 15:35:19,141 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5278.95 Median:5278.95 stddev:0.00 (0.0%) 15:35:19 INFO - 2015-11-23 15:35:19,141 DEBUG : BROWSER_OUTPUT: Values: 5278.9 15:35:19 INFO - 2015-11-23 15:35:19,142 DEBUG : BROWSER_OUTPUT: 15:35:19 INFO - 2015-11-23 15:35:19,142 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1077.50 Median:1077.50 stddev:0.00 (0.0%) 15:35:19 INFO - 2015-11-23 15:35:19,142 DEBUG : BROWSER_OUTPUT: Values: 1077.5 15:35:19 INFO - 2015-11-23 15:35:19,142 DEBUG : BROWSER_OUTPUT: 15:35:19 INFO - 2015-11-23 15:35:19,142 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:748.50 Median:748.50 stddev:0.00 (0.0%) 15:35:19 INFO - 2015-11-23 15:35:19,142 DEBUG : BROWSER_OUTPUT: Values: 748.5 15:35:19 INFO - 2015-11-23 15:35:19,142 DEBUG : BROWSER_OUTPUT: 15:35:19 INFO - 2015-11-23 15:35:19,142 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 15:35:19 INFO - 2015-11-23 15:35:19,142 DEBUG : BROWSER_OUTPUT: Values: 12219.5 15:35:19 INFO - 2015-11-23 15:35:19,143 DEBUG : BROWSER_OUTPUT: 15:35:19 INFO - 2015-11-23 15:35:19,143 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25923.08 Median:25923.08 stddev:0.00 (0.0%) 15:35:19 INFO - 2015-11-23 15:35:19,143 DEBUG : BROWSER_OUTPUT: Values: 25923.1 15:35:19 INFO - 2015-11-23 15:35:19,143 DEBUG : BROWSER_OUTPUT: 15:35:19 INFO - 2015-11-23 15:35:19,143 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:567.21 Median:567.21 stddev:0.00 (0.0%) 15:35:19 INFO - 2015-11-23 15:35:19,143 DEBUG : BROWSER_OUTPUT: Values: 567.2 15:35:19 INFO - 2015-11-23 15:35:19,143 DEBUG : BROWSER_OUTPUT: 15:35:19 INFO - 2015-11-23 15:35:19,143 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 15:35:19 INFO - 2015-11-23 15:35:19,143 DEBUG : BROWSER_OUTPUT: Values: 4826.9 15:35:19 INFO - 2015-11-23 15:35:19,144 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:35:19 INFO - 2015-11-23 15:35:19,144 DEBUG : BROWSER_OUTPUT: 15:35:19 INFO - 2015-11-23 15:35:19,993 INFO : Browser exited with error code: 0 15:35:20 INFO - 2015-11-23 15:35:20,005 INFO : Completed test v8_7 (00:00:39) 15:35:20 INFO - 2015-11-23 15:35:20,170 INFO : Completed test suite (00:20:09) 15:35:20 INFO - 2015-11-23 15:35:20,170 DEBUG : Working with test: dromaeo_css 15:35:20 INFO - 2015-11-23 15:35:20,171 DEBUG : Generating results file: dromaeo_css 15:35:20 INFO - 2015-11-23 15:35:20,172 DEBUG : Working with test: kraken 15:35:20 INFO - 2015-11-23 15:35:20,172 DEBUG : Generating results file: kraken 15:35:20 INFO - 2015-11-23 15:35:20,172 INFO : javascript benchmark 15:35:20 INFO - 2015-11-23 15:35:20,172 DEBUG : Working with test: v8_7 15:35:20 INFO - 2015-11-23 15:35:20,172 DEBUG : Generating results file: v8_7 15:35:20 INFO - 2015-11-23 15:35:20,173 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:35:20 INFO - 2015-11-23 15:35:20,309 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 15:35:20 INFO - 2015-11-23 15:35:20,309 DEBUG : process_Request line: dromaeo_css 6964.40 graph.html#tests=[[72,63,43]] 15:35:20 INFO - 2015-11-23 15:35:20,309 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:35:20 INFO - 2015-11-23 15:35:20,419 DEBUG : process_Request line: kraken 1522.60 graph.html#tests=[[232,63,43]] 15:35:20 INFO - 2015-11-23 15:35:20,419 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:35:20 INFO - 2015-11-23 15:35:20,531 DEBUG : process_Request line: v8_7 21308.06 graph.html#tests=[[230,63,43]] 15:35:20 INFO - 2015-11-23 15:35:20,533 INFO : javascript benchmark 15:35:20 INFO - 2015-11-23 15:35:20,536 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3208.5668434761305, 3262.853171607279, 3282.8686852525902, 3299.65353637868, 3311.834408279585, 5160.716160611165, 5382.2464854920345, 5400.270963419937, 5404.945950540494, 5425.593080518957, 5242.082635538775, 5271.182966640177, 5361.329833770778, 5420.512153906147, 5487.176923461483, 4863.732494712789, 4915.410150781893, 4987.052460032601, 4997.575206107485, 5020.046191223656, 4885.291632713254, 4899.387576552931, 4925.802967881281, 4967.478414766451, 5027.245913113025, 4737.336772851803, 4814.5907597853875, 4929.876753081166, 4994.650374473788, 5019.447860735335, 4949.579285760715, 4957.3059771632, 5002.824901128443, 5030.622703297231, 5036.924446133311, 4955.801767929279, 4965.0069986002945, 4977.7262250576205, 4986.2769898364895, 5000.899982000376, 5057.4689657585795, 5109.0, 5217.3999990000875, 5230.843074707765, 5327.440618735016, 5776.220210271602, 5789.16057171712, 5790.565707571906, 5808.2449281593545, 5902.793402230945, 5857.76568937242, 5862.530997520188, 5864.091065884794, 5873.882522349571, 5877.382874798127, 5219.478052194788, 5352.652077614943, 5357.544608708265, 5447.101228297287, 5507.7246137692955, 5887.411258874078, 5921.3190483094995, 5948.345681974979, 5957.195778569924, 5966.075258334965, 5476.17857321405, 5749.683767392834, 5758.337791154071, 5761.962846687637, 5774.451427114417, 5718.7426565804635, 5823.213866128103, 5933.139694744238, 5939.07944268639, 5990.520758339322, 5855.502282306052, 5910.34986151523, 5913.793017244376, 5930.110483427434, 5951.077582974646, 5635.098384258499, 5759.7408116634015, 5869.4717475427415, 5919.55603329752, 5922.851928701731, 4483.461984561874, 4542.818287268472, 4543.45478542577, 4575.679702420799, 4585.472670642852, 4011.2980228460488, 4021.0148513614354, 4025.255327764373, 4027.718059735849, 4052.5339585947404, 5360.731963401892, 5431.293931788842, 5453.345598528202, 5557.055300598908, 5568.248286481355, 5801.564882633735, 5833.183354330397, 5855.03391940325, 5875.11873219012, 5986.07215881539, 5521.5306698930235, 5578.163275508625, 5584.357798853102, 5587.552995760329, 5602.831915042555, 4921.138800709861, 5017.172166592544, 5033.7734801934, 5119.360079990001, 5130.589552835764, 5988.640681559121, 5994.310654274815, 6017.398260174035, 6041.516678665696, 6056.939430605726, 5838.824835254949, 5866.472017518444, 5874.324452687995, 5885.47030767233, 5895.380984996514, 5875.559333049953, 5984.521238301013, 6034.758609655741, 6074.787382441594, 6104.337893874237, 5621.831345059655, 5663.461971112738, 5670.177824215548, 5679.659220446786, 5736.0, 5833.533317334518, 5837.416258374129, 5842.883142337045, 5861.6189947653265, 5864.765409383577, 5450.5912056595125, 5579.581531385081, 5608.85977850557, 5720.141978703228, 5733.111367738007, 5624.971875140598, 5658.915116273177, 5662.377138514677, 5705.914411283917, 5829.271341082364, 5544.805931792368, 5565.916511252253, 5609.158626205938, 5611.466910643482, 5614.943850561442, 5439.646422982493, 5521.641093328921, 5705.971470142623, 5791.797287094932, 5814.592978491634, 5569.693666848362, 5588.692621905834, 5604.243427137284, 5605.215269862141, 5639.661620302795], "unit": "ms", "name": "dojo.html", "value": 5367.366989436452}, {"lowerIsBetter": false, "replicates": [552.9498889163169, 588.3733823477995, 590.6249531547469, 595.1013968906949, 596.8063872255487, 40495.79752101239, 41026.17947641053, 41130.17739645209, 41143.58856411435, 41280.58719412805, 42342.0, 42836.35745463821, 42836.78581607088, 43218.56781432185, 43259.13481730364, 8681.826363472743, 8898.466092034467, 8904.777380565472, 8972.147645973622, 8973.685920992766, 8740.300775937909, 8885.822283554357, 8888.333374996868, 8888.822223555557, 8893.021767605558, 8850.291976641853, 8931.0, 8937.419067760575, 8940.821183576325, 8946.41848279863, 8791.912080879174, 8819.735407937804, 8849.292056635519, 8889.555522223927, 8906.33202509811, 8713.869291960626, 8820.558972051436, 8837.779055523599, 8868.0, 8901.910980890172, 39339.213215735814, 40240.0, 40265.79867100675, 40290.59709402898, 40371.59628403737, 3152.36952609479, 3470.2192006798523, 3526.0, 3731.1418373773913, 3990.74060186087, 29752.55371169434, 29789.70210297891, 30399.0, 30528.389432211454, 31417.0, 3707.1288247261873, 3725.068732816796, 3920.0, 3983.5418926823495, 4024.0, 269319.0, 271572.0, 272055.999999998, 272393.0, 272531.0, 60188.39811601828, 61143.38856611377, 61198.38801612016, 61308.69345653243, 61329.38670613237, 65132.0, 71036.64481677559, 71801.0, 71980.64009679918, 72715.63642181756, 14419.711605767827, 14505.709885802225, 14537.273136343141, 14538.418463261563, 14558.563243102724, 11379.658610241706, 11479.655610331703, 11489.712757181138, 11522.423878806027, 11529.481173347052, 20988.265410710857, 21016.78983210179, 21019.369418917457, 21204.939753012288, 21297.36107916765, 7892.4869883457395, 7980.526036928571, 8034.799130021679, 8084.151164127799, 8130.3495720342235, 860.7589874835056, 881.6120906800987, 891.3804905590553, 946.1437399153776, 1022.5194158745378, 28454.288642784097, 29136.27159321034, 32511.0, 33517.16207094842, 33805.66194338025, 1009.7929924365487, 1055.303499690216, 1076.2251179150999, 1084.6637542361893, 1102.6195962392962, 15127.924360378347, 15206.239688015556, 15238.3904643813, 15330.463433779763, 15404.92297538505, 379187.0, 386751.0, 387976.0, 389299.0, 389478.0, 53103.203451948255, 53713.731431343374, 54103.671706263405, 54253.45746542484, 54351.0, 1327.150623600896, 1354.2619272496513, 1354.6613346663335, 1354.8780609744972, 1461.0211158523814, 28019.0, 28533.42933141284, 28582.0, 28853.134405967856, 29331.26671833136, 47873.04253914972, 49189.754051229516, 49262.0, 49295.26057109218, 49349.0, 287658.0, 288102.0, 288425.0, 288784.0, 288973.0, 42445.363319549615, 46528.0, 46618.06763864771, 47385.28922066241, 47517.76241118772, 44114.779426102665, 44448.77775611101, 44733.77633111813, 44899.551004490844, 45102.54897451115, 37224.0, 37585.2482950334, 38566.035849103995, 38672.22655546817, 39107.80446097751, 37579.81210093932, 37930.0, 38821.6117838818, 39174.60825391824, 39211.41182882316, 36741.26517469582, 37040.44439333466, 37423.0, 37474.625253747115, 37654.435183472815, 32800.671993279764, 34238.65761342454, 34302.65697342995, 34604.30791384209, 34628.480572790926, 25934.740652593988, 26201.379282793045, 26450.867745661148, 26460.206193814218, 26642.333941651614], "unit": "ms", "name": "ext.html", "value": 19253.332473450573}, {"lowerIsBetter": false, "replicates": [343.1147639091145, 360.8574613027852, 362.217609962481, 363.01803621204647, 364.3605472395945, 16811.159442027896, 17364.565885852844, 17517.124143792793, 18094.457166285, 18297.17662705178, 13806.102603330777, 16183.0, 16189.35242590295, 16318.102504362256, 16436.506904792874, 4818.108649899762, 4913.336699545569, 4939.234418665094, 4957.281194226835, 4957.5042495750495, 4844.733539655317, 4863.36776219091, 4944.0, 4956.231784073457, 4958.206686930092, 4327.870163895088, 5216.400113986883, 5316.601254905878, 5331.067063263933, 5370.0, 5292.973535132319, 5308.0, 5320.467953204688, 5324.840254792362, 5327.786888524454, 5161.767720452551, 5360.705161216131, 5367.865803354908, 5370.624056316059, 5376.784928602851, 14822.0, 20397.694034589495, 20681.0, 21604.135834566598, 21608.0, 2085.2180432337873, 2103.5897999890026, 2157.8273738100916, 2184.0826852721734, 2215.944601384962, 9691.70924872255, 9843.852342214872, 10064.647737329231, 11433.14251431146, 13181.670458238621, 1781.8930864148192, 1825.1604262039477, 1851.3520267906124, 1868.0566314011337, 1917.1851962915705, 63045.0, 63336.683316583585, 63773.362266377204, 65213.347866521675, 66853.0, 10163.28856980019, 10245.231607629457, 10410.115140213014, 10450.895491044992, 10462.372257664565, 13458.93270533641, 13529.18824870511, 13597.252151131584, 13641.181529108286, 13648.795268070988, 6972.477064220204, 7227.602481863443, 7386.926130738624, 7464.664090115958, 7617.085949686073, 7324.926750732425, 7397.334239918433, 7407.2592740725495, 7407.481476296607, 7412.110546734426, 4449.57729015743, 4548.6133678637025, 4555.589996900295, 4560.247559152769, 4565.360849481075, 1816.9545761355807, 1817.2276782367442, 1827.8903265803829, 1840.4110684581074, 1843.3732530939544, 384.55583800710224, 388.2952441318997, 397.2254104496244, 407.3502763092862, 410.7720215280488, 10311.0, 10406.947965260277, 10464.21518386124, 10593.470326483644, 10626.521806518725, 424.7706238631166, 427.32269353075725, 430.6619303846528, 444.38896517288725, 451.95932366086555, 5650.886982260332, 5672.631278966854, 5674.602777805597, 5692.857678558069, 5701.116326969326, 510954.0, 529541.0, 534566.0, 546342.0, 548170.0, 80118.0, 80714.0, 80770.59614702007, 81234.0, 81711.59144204241, 461.53846153846155, 462.88196509889764, 468.43553518011396, 470.1654563150435, 472.93142494338815, 10113.19094472455, 10133.847992279974, 10136.391816491034, 10243.7439064024, 10345.275830691779, 36038.639613603526, 36125.0, 36876.26247475089, 37610.81194594119, 38285.808570958085, 46160.53839461562, 46699.76650116728, 48776.75611621919, 51140.0, 52890.73554632202, 8636.524991125549, 9406.05939406054, 9824.115829575372, 9843.753906152404, 9903.356281841658, 16661.263858203667, 16847.241874115938, 17133.74299385535, 17298.394556190473, 17582.032988185772, 11357.943210283896, 11738.295702257892, 13813.171209727449, 14248.928755356157, 14777.630559236106, 13803.447862085404, 13981.930090349482, 14001.22993235382, 14314.284285785878, 14396.784048239075, 14311.499097531536, 14353.067050641675, 14434.855651443771, 14645.267736612914, 14764.261786910396, 8643.092475290256, 8925.0, 8964.506952117696, 8981.281497480317, 9035.0, 11920.284782913053, 14248.64378390507, 14490.0, 14545.0, 14729.92635036818], "unit": "ms", "name": "jquery.html", "value": 7949.567442246344}, {"lowerIsBetter": false, "replicates": [1496.5659958612002, 1653.8098118716348, 1724.7844019497568, 1724.9396271130506, 1745.8865173763697, 6884.3115688431135, 6963.199232088311, 7475.401967842573, 7773.999999999993, 7877.80305492363, 7405.148407933089, 7557.50876193047, 7592.430567707416, 7609.429292803048, 7614.4669873108905, 2265.8640481571074, 2304.481491664379, 2317.9884100579557, 2318.53629274145, 2322.8025617822423, 2257.3792207143, 2275.283285764987, 2278.977210227893, 2287.8512896661664, 2302.7121609798774, 2226.109556177526, 2236.1502629000956, 2237.093976939342, 2260.9886950565224, 2267.546490701858, 2254.1096266974455, 2286.1198438601177, 2314.9652755208685, 2319.9652005219937, 2323.035940084863, 2307.86152830829, 2332.102140675852, 2338.4504641409253, 2340.8829558522007, 2341.2390972933863, 7731.7680469586, 7773.611319434006, 7789.06531216252, 7790.649420776079, 7825.882611760828, 4662.393888794435, 4748.477667456577, 4781.091592597395, 4789.114013907439, 4789.760511974422, 2979.016924414938, 2995.1314118905493, 3056.9388612227854, 3076.5385192221124, 3093.767967402431, 988.6687959533565, 1000.4047591682937, 1902.5529000684828, 1909.5035290824485, 1913.6938089905548, 10649.57401703931, 10678.305910115818, 10735.087517560938, 10752.462376881125, 10805.243632945698, 4047.8785636430953, 4083.6120568546535, 4105.322621767375, 4134.64855487281, 4190.832366705358, 8706.825863482694, 8710.346723995726, 8711.21599056088, 8722.520261385685, 8727.0, 4683.906321873544, 4684.110019096361, 4685.789139488731, 4697.6241900647865, 4722.0, 4247.936280955788, 4304.763238021939, 4340.262155433584, 4351.086271882877, 4364.672649551233, 3684.2631473704832, 3761.774293542396, 3765.058735316171, 3767.9246415072093, 3786.5456145262747, 1237.0907383073434, 1245.8380410546752, 1246.0965799795258, 1246.401727170963, 1249.981265268803, 944.1596978688972, 944.7496413450441, 948.3266880514774, 961.8605302231138, 1075.4945175767377, 7224.024756657889, 7242.275772422821, 7278.636068196569, 7283.0, 7333.376662983599, 475.57911248545287, 480.3779106057664, 495.92561115832194, 496.3225197605243, 503.94960503950045, 5698.572607054488, 5766.740496677659, 5789.623674461147, 5815.156802263648, 5830.533557315404, 9351.485668288173, 9399.91900931388, 9407.0, 9477.099675530813, 9486.146246837818, 9141.634334626673, 9317.767055823659, 9386.765330866647, 9397.57710903011, 9405.623775048922, 7260.782176534713, 7324.597147156957, 7331.8900216496795, 7356.37470814976, 7411.370033547101, 6645.60126392418, 7038.3665470107935, 7066.293370663098, 7083.645817708991, 7084.539504932163, 8130.268275855202, 8224.958875205586, 8246.134155913544, 8256.917430825615, 8264.380171487042, 8360.28937540316, 8377.45546539473, 8393.412461127662, 8400.117987611213, 8441.66233350659, 6666.566673166229, 6924.307569243036, 6931.44548436134, 6955.269696681978, 7021.648917554, 7445.367143792838, 7446.4042876568665, 7463.290987356192, 7489.8876516851205, 7508.849823003618, 6913.308669133247, 7024.016637670628, 7118.9644051779405, 7172.103487064117, 7208.4593655475, 6979.720811167496, 7011.123609548807, 7015.228324884157, 7034.226235114235, 7073.186583542958, 6957.37383635455, 7045.612491313027, 7049.7885063448175, 7060.470464715064, 7081.681324340314, 6158.414950579688, 6199.380061993765, 6207.968960155351, 6223.595466294676, 6234.875302493834, 6270.0908368287255, 6281.968590157203, 6326.9683651581445, 6349.619022858643, 6423.0], "unit": "ms", "name": "mootools.html", "value": 4415.895338351915}, {"lowerIsBetter": false, "replicates": [338.8813915129705, 341.2288228603356, 346.11740062839783, 349.0784329370461, 352.8253514510318, 6222.533310001751, 6227.937720622793, 6287.559870809046, 6303.054541818724, 6386.808395748123, 6173.629582225059, 6182.938170618292, 6184.907226391608, 6213.596116252441, 6226.315105338409, 4741.099191153687, 4752.881177970552, 4763.90472190556, 4773.976130119345, 4776.8566942991765, 4777.90444191116, 4780.259059845712, 4794.137055330039, 4794.568488836004, 4795.616350691954, 4550.476695180064, 4604.3323718060865, 4644.72131672099, 4663.044075964436, 4694.29585562165, 4669.41632295963, 4675.555822196886, 4675.81296748128, 4694.0, 4702.882427939329, 4071.75569465833, 4093.3246014407587, 4093.6315731584004, 4099.528554216274, 4105.055837157471, 5831.329397119343, 5847.327557330919, 5860.681346696959, 5876.55925805562, 5876.55925805562, 5261.289725886994, 5434.619576629638, 5448.673079615236, 5508.3114610673665, 5508.6970216638065, 6556.049372840911, 6565.868682626368, 6582.703778329987, 6583.177102862142, 6584.209894812653, 4431.335299705038, 4455.554444555551, 4456.465224173087, 4459.977700111511, 4467.106578684244, 6718.0, 6793.932060679429, 6811.761588344434, 6845.726170953156, 6853.314668533157, 4661.0, 4672.462666793363, 4677.111348843709, 4677.2750223715375, 4678.204705200124, 4713.245880659147, 4733.905321893543, 4735.0, 4737.218358970731, 4748.145333839942, 5498.917516237259, 5523.7238138092935, 5525.4474552544425, 5527.751251193706, 5528.115501519818, 6495.577787443801, 6646.235682896432, 6660.9000864987065, 6668.633225172565, 6670.299618540081, 1618.6924484348172, 1635.9427420040242, 1645.4569991902642, 1648.7444446110633, 1648.934042638305, 1046.3042077018697, 1052.921030922684, 1055.37205362809, 1071.0253669161182, 1103.624767579027, 6409.711562979677, 6436.645984470805, 6440.291567927524, 6464.062710906892, 6467.805965821033, 6811.148606424197, 6843.794686159324, 6849.520533562702, 6849.794506164823, 6869.141357330333, 6315.210598675166, 6433.260175079832, 6442.61344319333, 6483.513736469689, 6485.6108633482145, 3701.8149092545264, 3714.5542534895444, 3724.72064595151, 3731.1418373774186, 3733.197362567061, 7116.857662846714, 7129.037579926748, 7135.7859264221115, 7142.607156606333, 7150.892736608955, 6911.481638877004, 7010.719571217196, 7017.719291228395, 7085.610291433917, 7091.6454177290925, 7141.9285807142305, 7142.142942846892, 7149.106361704891, 7149.7497587584185, 7162.570245785269, 6800.115984921928, 6862.588244705334, 6864.897026544706, 6869.793906182823, 6871.3472220141, 6682.498812588978, 6777.322267773183, 6825.35159159879, 6827.078344423439, 6828.146481689789, 7066.823329416806, 7120.145582530129, 7130.896385566167, 7135.714571417086, 7137.393321567725, 4612.7001744886475, 4656.278276867091, 4672.74299913508, 4684.953150468452, 4685.273782563708, 6613.66931653425, 6871.347222013901, 6876.896846547205, 6885.173779146535, 6893.862122757417, 6696.263411024686, 6705.195376554844, 6706.295838937037, 6707.463402927851, 6707.8993815091835, 6633.336666333328, 6657.40083392497, 6673.599584024974, 6675.766348177791, 6677.599344039373, 6251.187345645037, 6546.279909210079, 6600.504962127764, 6601.933980660132, 6615.305392933865, 6684.298148694317, 6740.62926539045, 6749.156355455568, 6755.392014718699, 6766.458683305422, 6348.301686814539, 6585.1439312889015, 6587.571807832475, 6592.67036648156, 6596.868062638624], "unit": "ms", "name": "prototype.html", "value": 4979.583324835378}, {"lowerIsBetter": false, "replicates": [773.6982576795051, 816.6855760532197, 830.7715378270975, 832.1096426823294, 854.58552601988, 13262.801057984138, 13380.59858204253, 13539.864601353984, 13597.864021359783, 14396.568102956902, 13510.93244533776, 13586.116902401336, 13598.252096134733, 13607.795883061763, 13638.522651707191, 787.7518581646791, 810.2100452059254, 814.5886327404652, 814.8777683347515, 817.0154963269247, 794.7417089445953, 803.2931020701803, 809.4333966223637, 810.8175660476375, 812.0580127052621, 845.5518575155178, 846.272205902923, 846.289117141601, 848.8090179709578, 851.4423052900361, 843.0852525010371, 843.6372359885247, 845.0788640381983, 847.1274587175219, 849.235687880906, 621.2110619513193, 621.9315875253764, 622.2595111816969, 624.3444383397415, 626.3016736338994, 13557.389917453738, 13608.863911360859, 13698.794518082237, 13705.246211458365, 13710.588682339545, 11636.941815290955, 11759.7060073498, 12181.0, 12253.0, 12265.08011899111, 10264.74338141545, 10428.21788365868, 10494.52774625136, 10598.682039538826, 10932.836007459815, 3470.8946367477874, 3506.789592624425, 3532.258225772591, 3553.662402071799, 3579.0873327301633, 49098.26352604749, 49112.754436227944, 49570.7521462394, 49643.25535116976, 49784.25323620148, 9492.90507094934, 9676.70969870905, 9839.754006149904, 9871.180496747173, 10076.949615251877, 17389.304427822746, 17565.121743912754, 17610.0, 17612.823871761375, 17632.090705033526, 6752.3922846944015, 7059.92940070603, 7214.74748383804, 7238.674259658328, 7419.629018549051, 3908.5309762828642, 3926.1166237596885, 3932.508436445444, 3982.542007669097, 4026.6778657707314, 2845.701201373867, 2859.3280579063903, 2877.741003309712, 2889.436559870847, 2891.6385451818524, 541.934967803866, 545.6044367833289, 549.9780008799603, 553.3608681972329, 553.7037684838673, 604.4046614085123, 633.8700566383973, 646.4470200973659, 662.8342914271432, 679.3877540855403, 8398.179997819223, 8702.434341767765, 8723.258523025486, 8773.517456539825, 8905.73282801517, 622.6762083716533, 643.5655932245716, 669.397542212013, 716.8351279205812, 723.5043994863536, 4079.449274347925, 4091.672666186698, 4121.835126594962, 4191.91616167675, 4261.936070958938, 57997.71001144967, 62335.688321558104, 62639.6868015657, 62666.37333626606, 62672.68663656653, 54768.17847732287, 55308.0, 55498.44501555013, 55942.720286398304, 56466.0, 46902.76548617235, 47121.76439117782, 49604.0, 50009.49990500121, 50150.247746283836, 8788.868166977372, 8929.0, 9115.817683646423, 9208.263338932735, 9214.631414743335, 33406.83296583501, 34191.31617367688, 34199.65800342064, 34464.65535344614, 34676.306473869874, 42867.785661071495, 46602.48360541484, 47008.29487557621, 47313.52686473229, 47515.28727069166, 11016.339019658846, 11120.832312607059, 11341.376224307412, 11361.832182265514, 11517.193796434169, 11830.645080647595, 11955.581554645545, 12383.938080309901, 12570.1200915935, 12676.366181690693, 11163.609273675382, 11302.0, 11374.601888933848, 11730.19946689917, 11745.0, 10932.180086493387, 11420.0, 11506.194566380273, 11817.704557386134, 11942.0, 10692.358458492516, 10754.89245107539, 10813.459327033774, 10947.83578246343, 11140.220184587, 9209.731752963195, 9443.480608566595, 9454.95272523633, 9473.66842160521, 10159.695209143738, 8377.204165604258, 8387.41288109851, 8917.554122293988, 9073.77315567116, 9503.382280151767], "unit": "ms", "name": "yui.html", "value": 6315.9735759993255}], "name": "dromaeo_css", "value": 6964.396790267765}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 114.0, 112.0, 111.0, 124.0, 111.0, 109.0, 111.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [159.0, 124.0, 150.0, 160.0, 125.0, 149.0, 148.0, 129.0, 173.0, 127.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.4}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 162.0, 162.0, 161.0, 162.0, 161.0, 163.0, 170.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 163.0}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 73.0, 72.0, 76.0, 72.0, 72.0, 71.0, 137.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.1}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 138.0, 92.0, 92.0, 93.0, 145.0, 94.0, 93.0, 141.0], "unit": "ms", "name": "audio-oscillator", "value": 107.4}, {"lowerIsBetter": true, "replicates": [111.0, 111.0, 113.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.5}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 64.0, 63.0, 64.0, 63.0, 62.0, 63.0, 64.0, 64.0], "unit": "ms", "name": "json-parse-financial", "value": 63.2}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 70.0, 69.0, 69.0, 68.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [84.0, 94.0, 86.0, 87.0, 88.0, 86.0, 86.0, 85.0, 87.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.0}, {"lowerIsBetter": true, "replicates": [120.0, 129.0, 122.0, 118.0, 129.0, 121.0, 120.0, 128.0, 122.0, 119.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.8}, {"lowerIsBetter": true, "replicates": [140.0, 158.0, 151.0, 151.0, 163.0, 152.0, 151.0, 160.0, 152.0, 152.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 153.0}, {"lowerIsBetter": true, "replicates": [67.0, 73.0, 72.0, 67.0, 67.0, 66.0, 72.0, 67.0, 68.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1522.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.7008217340265], "unit": "score", "name": "Richards", "value": 210.50582599999998}, {"lowerIsBetter": false, "replicates": [187.30099269526127], "unit": "score", "name": "DeltaBlue", "value": 353.0040020000002}, {"lowerIsBetter": false, "replicates": [278.6291446085261], "unit": "score", "name": "Encrypt", "value": 955.3236090000001}, {"lowerIsBetter": false, "replicates": [5278.9473684210525], "unit": "score", "name": "Decrypt", "value": 50.423120638085756}, {"lowerIsBetter": false, "replicates": [1077.502691065662], "unit": "score", "name": "RayTrace", "value": 686.7630179820178}, {"lowerIsBetter": false, "replicates": [748.502994011976], "unit": "score", "name": "Earley", "value": 890.3945680000003}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [25923.076923076922], "unit": "score", "name": "RegExp", "value": 35.14185459940652}, {"lowerIsBetter": false, "replicates": [567.2149744753261], "unit": "score", "name": "Splay", "value": 143.66863300000006}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 21308.06453435713}]} 15:35:20 INFO - RETURN: dromaeo_css: 6964.40 15:35:20 INFO - RETURN: kraken: 1522.60 15:35:20 INFO - RETURN: v8_7: 21308.06 15:35:20 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21308.06"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1522.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6964.40"}}} 15:35:20 INFO - Return code: 0 15:35:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 15:35:20 INFO - # TBPL SUCCESS # 15:35:20 INFO - Running post-action listener: _resource_record_post_action 15:35:20 INFO - Running post-run listener: _resource_record_post_run 15:35:21 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 16384; Write bytes: 521347072; Read time: 316; Write time: 376068 15:35:21 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 8192; Write bytes: 238321664; Read time: 192; Write time: 247800 15:35:21 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 8192; Write bytes: 283013120; Read time: 124; Write time: 128268 15:35:21 INFO - Running post-run listener: _upload_blobber_files 15:35:21 INFO - Blob upload gear active. 15:35:21 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:35:21 INFO - Copying logs to upload dir... 15:35:21 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1254.931094 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2015-11-23 15:35:20.427507) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 15:35:20.431581) ========= 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=5804b9f07a53938c557deee7000001c5-1448317651.642415-413582922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010120 build_url: 'https://queue.taskcluster.net/v1/task/DVafpJcPRmGXlU_Rfe6ylQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 15:35:20.487159) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:35:20.487825) ========= 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=5804b9f07a53938c557deee7000001c5-1448317651.642415-413582922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004550 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 15:35:20.539772) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 15:35:20.540136) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 15:35:20.540476) ========= ========= Total master_lag: 0.23 =========