builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1455563673.79 results: success (0) buildid: 20160215085326 builduid: e53bfeb58de549599c3578facc9cbf36 revision: 41eb59a46425 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-15 11:14:33.788406) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-15 11:14:33.788780) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-15 11:14:33.789358) ========= 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=652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006314 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.68 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-15 11:14:34.474163) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-15 11:14:34.474476) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-15 11:14:34.504332) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 11:14:34.504585) ========= 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=652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 11:14:34.555728) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-15 11:14:34.555994) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-15 11:14:34.556329) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 11:14:34.556590) ========= 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=652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-15 11:14:34-- 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% 221M=0s 2016-02-15 11:14:34 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174429 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 11:14:34.742952) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 11:14:34.743361) ========= 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=652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017874 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 11:14:34.794427) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-15 11:14:34.794755) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 41eb59a46425 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 41eb59a46425 --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=652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-15 11:14:35,004 Setting DEBUG logging. 2016-02-15 11:14:35,005 attempt 1/10 2016-02-15 11:14:35,005 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/41eb59a46425?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-15 11:14:35,981 unpacking tar archive at: mozilla-beta-41eb59a46425/testing/mozharness/ program finished with exit code 0 elapsedTime=1.265560 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-15 11:14:36.072478) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-15 11:14:36.072822) ========= echo 41eb59a46425 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'41eb59a46425'] 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=652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 41eb59a46425 program finished with exit code 0 elapsedTime=0.003543 script_repo_revision: '41eb59a46425' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-15 11:14:36.121411) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-15 11:14:36.121708) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-15 11:14:36.131303) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-02-15 11:14:36.131564) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:14:36 INFO - MultiFileLogger online at 20160215 11:14:36 in /builds/slave/test-pgo 11:14:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:14:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:14:36 INFO - {'append_to_log': False, 11:14:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:14:36 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:14:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:14:36 INFO - 'branch': 'Mozilla-Beta', 11:14:36 INFO - 'buildbot_json_path': 'buildprops.json', 11:14:36 INFO - 'config_files': ('talos/linux_config.py',), 11:14:36 INFO - 'default_actions': ('clobber', 11:14:36 INFO - 'read-buildbot-config', 11:14:36 INFO - 'download-and-extract', 11:14:36 INFO - 'populate-webroot', 11:14:36 INFO - 'create-virtualenv', 11:14:36 INFO - 'install', 11:14:36 INFO - 'run-tests'), 11:14:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:14:36 INFO - 'download_minidump_stackwalk': True, 11:14:36 INFO - 'download_symbols': 'ondemand', 11:14:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:14:36 INFO - 'tooltool.py': '/tools/tooltool.py', 11:14:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:14:36 INFO - '/tools/misc-python/virtualenv.py')}, 11:14:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:14:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:14:36 INFO - 'installer_path': 'installer.exe', 11:14:36 INFO - 'log_level': 'info', 11:14:36 INFO - 'log_name': 'talos', 11:14:36 INFO - 'log_to_console': True, 11:14:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:14:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:14:36 INFO - 'opt_config_files': (), 11:14:36 INFO - 'pip_index': False, 11:14:36 INFO - 'sps_profile': False, 11:14:36 INFO - 'sps_profile_interval': 0, 11:14:36 INFO - 'suite': 'dromaeojs', 11:14:36 INFO - 'system_bits': '32', 11:14:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:14:36 INFO - 'title': 'talos-linux64-ix-046', 11:14:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:14:36 INFO - 'use_talos_json': True, 11:14:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:14:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:14:36 INFO - 'work_dir': 'build'} 11:14:36 INFO - ##### 11:14:36 INFO - ##### Running clobber step. 11:14:36 INFO - ##### 11:14:36 INFO - Running pre-action listener: _resource_record_pre_action 11:14:36 INFO - Running main action method: clobber 11:14:36 INFO - rmtree: /builds/slave/test-pgo/build 11:14:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:14:36 INFO - Running post-action listener: _resource_record_post_action 11:14:36 INFO - ##### 11:14:36 INFO - ##### Running read-buildbot-config step. 11:14:36 INFO - ##### 11:14:36 INFO - Running pre-action listener: _resource_record_pre_action 11:14:36 INFO - Running main action method: read_buildbot_config 11:14:36 INFO - Using buildbot properties: 11:14:36 INFO - { 11:14:36 INFO - "properties": { 11:14:36 INFO - "buildnumber": 107, 11:14:36 INFO - "product": "firefox", 11:14:36 INFO - "script_repo_revision": "production", 11:14:36 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 11:14:36 INFO - "repository": "", 11:14:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 11:14:36 INFO - "buildid": "20160215085326", 11:14:36 INFO - "slavename": "talos-linux64-ix-046", 11:14:36 INFO - "pgo_build": "True", 11:14:36 INFO - "basedir": "/builds/slave/test-pgo", 11:14:36 INFO - "project": "", 11:14:36 INFO - "platform": "ubuntu64_hw", 11:14:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:14:36 INFO - "slavebuilddir": "test", 11:14:36 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:14:36 INFO - "branch": "mozilla-beta", 11:14:36 INFO - "repo_path": "releases/mozilla-beta", 11:14:36 INFO - "stage_platform": "linux64-pgo", 11:14:36 INFO - "builduid": "e53bfeb58de549599c3578facc9cbf36", 11:14:36 INFO - "revision": "41eb59a46425" 11:14:36 INFO - }, 11:14:36 INFO - "sourcestamp": { 11:14:36 INFO - "repository": "", 11:14:36 INFO - "hasPatch": false, 11:14:36 INFO - "project": "", 11:14:36 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 11:14:36 INFO - "changes": [ 11:14:36 INFO - { 11:14:36 INFO - "category": null, 11:14:36 INFO - "files": [ 11:14:36 INFO - { 11:14:36 INFO - "url": null, 11:14:36 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455555206/firefox-45.0.en-US.linux-x86_64.tar.bz2" 11:14:36 INFO - } 11:14:36 INFO - ], 11:14:36 INFO - "repository": "", 11:14:36 INFO - "rev": "41eb59a46425", 11:14:36 INFO - "who": "sendchange", 11:14:36 INFO - "when": 1455563627, 11:14:36 INFO - "number": 7606680, 11:14:36 INFO - "comments": "Bug 1246592 - Try and fix windows locale repack bustage by adjusting how locales are built for Loop. r=glandium,a=sledru", 11:14:36 INFO - "project": "", 11:14:36 INFO - "at": "Mon 15 Feb 2016 11:13:47", 11:14:36 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 11:14:36 INFO - "revlink": "", 11:14:36 INFO - "properties": [ 11:14:36 INFO - [ 11:14:36 INFO - "buildid", 11:14:36 INFO - "20160215085326", 11:14:36 INFO - "Change" 11:14:36 INFO - ], 11:14:36 INFO - [ 11:14:36 INFO - "builduid", 11:14:36 INFO - "e53bfeb58de549599c3578facc9cbf36", 11:14:36 INFO - "Change" 11:14:36 INFO - ], 11:14:36 INFO - [ 11:14:36 INFO - "pgo_build", 11:14:36 INFO - "True", 11:14:36 INFO - "Change" 11:14:36 INFO - ] 11:14:36 INFO - ], 11:14:36 INFO - "revision": "41eb59a46425" 11:14:36 INFO - } 11:14:36 INFO - ], 11:14:36 INFO - "revision": "41eb59a46425" 11:14:36 INFO - } 11:14:36 INFO - } 11:14:36 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455555206/firefox-45.0.en-US.linux-x86_64.tar.bz2. 11:14:36 INFO - Running post-action listener: _resource_record_post_action 11:14:36 INFO - ##### 11:14:36 INFO - ##### Running download-and-extract step. 11:14:36 INFO - ##### 11:14:36 INFO - Running pre-action listener: _resource_record_pre_action 11:14:36 INFO - Running main action method: download_and_extract 11:14:36 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:14:36 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')]} 11:14:36 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455555206/test_packages.json 11:14:36 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455555206/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:14:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455555206/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:14:36 INFO - Downloaded 1270 bytes. 11:14:36 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:14:36 INFO - Using the following test package requirements: 11:14:36 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 11:14:36 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 11:14:36 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:14:36 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 11:14:36 INFO - u'jsshell-linux-x86_64.zip'], 11:14:36 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 11:14:36 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:14:36 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 11:14:36 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 11:14:36 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 11:14:36 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 11:14:36 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 11:14:36 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 11:14:36 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:14:36 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 11:14:36 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 11:14:36 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:14:36 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:14:36 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')]} 11:14:36 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455555206/firefox-45.0.en-US.linux-x86_64.common.tests.zip 11:14:36 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455555206/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 11:14:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455555206/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:14:37 INFO - Downloaded 22214436 bytes. 11:14:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 11:14:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 11:14:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:14:38 INFO - Return code: 0 11:14:38 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11: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')]} 11:14:38 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455555206/firefox-45.0.en-US.linux-x86_64.common.tests.zip 11:14:38 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455555206/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 11:14:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455555206/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:14:39 INFO - Downloaded 22214436 bytes. 11:14:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 11:14:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 11:14:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:14:40 INFO - Return code: 0 11: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')]} 11:14:40 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455555206/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 11:14:40 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455555206/firefox-45.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 11:14:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455555206/firefox-45.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:14:45 INFO - Downloaded 11132038 bytes. 11:14:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 11:14:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 11:14:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 11:14:45 INFO - Return code: 0 11: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')]} 11:14:45 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455555206/firefox-45.0.en-US.linux-x86_64.tar.bz2 11:14:45 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455555206/firefox-45.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 11:14:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455555206/firefox-45.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:14:46 INFO - Downloaded 58289828 bytes. 11:14:46 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455555206/firefox-45.0.en-US.linux-x86_64.tar.bz2 11:14:46 INFO - mkdir: /builds/slave/test-pgo/properties 11:14:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:14:46 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:14:46 INFO - Contents: 11:14:46 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455555206/firefox-45.0.en-US.linux-x86_64.tar.bz2 11:14:46 INFO - Running post-action listener: _resource_record_post_action 11:14:46 INFO - Running post-action listener: set_extra_try_arguments 11:14:46 INFO - ##### 11:14:46 INFO - ##### Running populate-webroot step. 11:14:46 INFO - ##### 11:14:46 INFO - Running pre-action listener: _resource_record_pre_action 11:14:46 INFO - Running main action method: populate_webroot 11:14:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:14:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:14:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:14:46 INFO - '--tppagecycles', 11:14:46 INFO - '7'], 11:14:46 INFO - 'tests': ['tsvgm']}}, 11:14:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:14:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:14:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:14:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:14:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:14:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:14:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:14:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:46 INFO - 'talos_options': ['--e10s'], 11:14:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:14:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:46 INFO - 'tests': ['damp', 'tps']}, 11:14:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:46 INFO - 'talos_options': ['--e10s'], 11:14:46 INFO - 'tests': ['damp', 'tps']}, 11:14:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:14:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:14:46 INFO - 'other': {'tests': ['a11yr', 11:14:46 INFO - 'ts_paint', 11:14:46 INFO - 'tpaint', 11:14:46 INFO - 'sessionrestore', 11:14:46 INFO - 'sessionrestore_no_auto_restore']}, 11:14:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:14:46 INFO - 'tests': ['a11yr', 11:14:46 INFO - 'ts_paint', 11:14:46 INFO - 'tpaint', 11:14:46 INFO - 'sessionrestore', 11:14:46 INFO - 'sessionrestore_no_auto_restore']}, 11:14:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:14:46 INFO - 'tests': ['a11yr', 11:14:46 INFO - 'ts_paint', 11:14:46 INFO - 'tpaint', 11:14:46 INFO - 'sessionrestore', 11:14:46 INFO - 'sessionrestore_no_auto_restore']}, 11:14:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:14:46 INFO - 'tests': ['a11yr', 11:14:46 INFO - 'ts_paint', 11:14:46 INFO - 'tpaint', 11:14:46 INFO - 'sessionrestore', 11:14:46 INFO - 'sessionrestore_no_auto_restore']}, 11:14:46 INFO - 'other_l64': {'tests': ['a11yr', 11:14:46 INFO - 'ts_paint', 11:14:46 INFO - 'tpaint', 11:14:46 INFO - 'sessionrestore', 11:14:46 INFO - 'sessionrestore_no_auto_restore']}, 11:14:46 INFO - 'other_nol64': {'tests': ['a11yr', 11:14:46 INFO - 'ts_paint', 11:14:46 INFO - 'tpaint', 11:14:46 INFO - 'sessionrestore', 11:14:46 INFO - 'sessionrestore_no_auto_restore']}, 11:14:46 INFO - 'svgr': {'tests': ['tsvgx', 11:14:46 INFO - 'tsvgr_opacity', 11:14:46 INFO - 'tart', 11:14:46 INFO - 'tscrollx', 11:14:46 INFO - 'cart']}, 11:14:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:14:46 INFO - 'tests': ['tsvgx', 11:14:46 INFO - 'tsvgr_opacity', 11:14:46 INFO - 'tart', 11:14:46 INFO - 'tscrollx', 11:14:46 INFO - 'cart']}, 11:14:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:46 INFO - 'tests': ['tp5o']}, 11:14:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:46 INFO - 'talos_options': ['--e10s'], 11:14:46 INFO - 'tests': ['tp5o']}, 11:14:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:46 INFO - 'talos_options': ['--xperf_path', 11:14:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:14:46 INFO - 'tests': ['tp5n']}, 11:14:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:14:46 INFO - 'talos_options': ['--e10s', 11:14:46 INFO - '--xperf_path', 11:14:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:14:46 INFO - 'tests': ['tp5n']}}, 11:14:46 INFO - 'talos.zip': {'path': '', 11:14:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:14:46 INFO - Running post-action listener: _resource_record_post_action 11:14:46 INFO - ##### 11:14:46 INFO - ##### Running create-virtualenv step. 11:14:46 INFO - ##### 11:14:46 INFO - Running pre-action listener: _resource_record_pre_action 11:14:46 INFO - Running main action method: create_virtualenv 11:14:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:14:46 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 11:14:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:14:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:14:46 INFO - Using real prefix '/usr' 11:14:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:14:47 INFO - Installing distribute.............................................................................................................................................................................................done. 11:14:49 INFO - Installing pip.................done. 11:14:49 INFO - Return code: 0 11:14:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11: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')]} 11:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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')]} 11:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f6af0f0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df8350>, '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 0x1df9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df96e0>, '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': '652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163', '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 11:14:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:14:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:14:49 INFO - Using env: {'DISPLAY': ':0', 11:14:49 INFO - 'HOME': '/home/cltbld', 11:14:49 INFO - 'LANG': 'en_US.UTF-8', 11:14:49 INFO - 'LANGUAGE': 'en_US:en', 11:14:49 INFO - 'LOGNAME': 'cltbld', 11:14:49 INFO - 'MAIL': '/var/mail/cltbld', 11:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:49 INFO - 'MOZ_NO_REMOTE': '1', 11:14:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:49 INFO - 'NO_EM_RESTART': '1', 11:14:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:14:49 INFO - 'PWD': '/builds/slave/test-pgo', 11:14:49 INFO - 'SHELL': '/bin/bash', 11:14:49 INFO - 'SHLVL': '1', 11:14:49 INFO - 'TERM': 'linux', 11:14:49 INFO - 'TMOUT': '86400', 11:14:49 INFO - 'USER': 'cltbld', 11:14:49 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163', 11:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:49 INFO - '_': '/tools/buildbot/bin/python'} 11:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:49 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 11:14:49 INFO - Cleaning up... 11:14:49 INFO - Return code: 0 11:14:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11: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')]} 11:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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')]} 11:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f6af0f0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df8350>, '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 0x1df9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df96e0>, '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': '652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163', '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 11:14:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:14:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:14:49 INFO - Using env: {'DISPLAY': ':0', 11:14:49 INFO - 'HOME': '/home/cltbld', 11:14:49 INFO - 'LANG': 'en_US.UTF-8', 11:14:49 INFO - 'LANGUAGE': 'en_US:en', 11:14:49 INFO - 'LOGNAME': 'cltbld', 11:14:49 INFO - 'MAIL': '/var/mail/cltbld', 11:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:49 INFO - 'MOZ_NO_REMOTE': '1', 11:14:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:49 INFO - 'NO_EM_RESTART': '1', 11:14:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:14:49 INFO - 'PWD': '/builds/slave/test-pgo', 11:14:49 INFO - 'SHELL': '/bin/bash', 11:14:49 INFO - 'SHLVL': '1', 11:14:49 INFO - 'TERM': 'linux', 11:14:49 INFO - 'TMOUT': '86400', 11:14:49 INFO - 'USER': 'cltbld', 11:14:49 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163', 11:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:49 INFO - '_': '/tools/buildbot/bin/python'} 11:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:49 INFO - Downloading/unpacking psutil>=0.7.1 11:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:14:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:14:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:14:51 INFO - Installing collected packages: psutil 11:14:51 INFO - Running setup.py install for psutil 11:14:51 INFO - building 'psutil._psutil_linux' extension 11:14:51 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 11:14:52 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 11:14:52 INFO - building 'psutil._psutil_posix' extension 11:14:52 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 11:14:52 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 11:14:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:14:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:14:52 INFO - Successfully installed psutil 11:14:52 INFO - Cleaning up... 11:14:52 INFO - Return code: 0 11:14:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11: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')]} 11:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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')]} 11:14:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f6af0f0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df8350>, '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 0x1df9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df96e0>, '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': '652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163', '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 11:14:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:14:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:14:52 INFO - Using env: {'DISPLAY': ':0', 11:14:52 INFO - 'HOME': '/home/cltbld', 11:14:52 INFO - 'LANG': 'en_US.UTF-8', 11:14:52 INFO - 'LANGUAGE': 'en_US:en', 11:14:52 INFO - 'LOGNAME': 'cltbld', 11:14:52 INFO - 'MAIL': '/var/mail/cltbld', 11:14:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:52 INFO - 'MOZ_NO_REMOTE': '1', 11:14:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:52 INFO - 'NO_EM_RESTART': '1', 11:14:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:14:52 INFO - 'PWD': '/builds/slave/test-pgo', 11:14:52 INFO - 'SHELL': '/bin/bash', 11:14:52 INFO - 'SHLVL': '1', 11:14:52 INFO - 'TERM': 'linux', 11:14:52 INFO - 'TMOUT': '86400', 11:14:52 INFO - 'USER': 'cltbld', 11:14:52 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163', 11:14:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:52 INFO - '_': '/tools/buildbot/bin/python'} 11:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:14:52 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 11:14:52 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 11:14:52 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 11:14:52 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 11:14:52 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 11:14:52 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 11:14:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:14:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:14:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:14:54 INFO - Installing collected packages: mozsystemmonitor 11:14:54 INFO - Running setup.py install for mozsystemmonitor 11:14:54 INFO - Successfully installed mozsystemmonitor 11:14:54 INFO - Cleaning up... 11:14:54 INFO - Return code: 0 11:14:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f6af0f0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df8350>, '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 0x1df9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df96e0>, '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': '652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163', '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 11:14:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:14:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:14:54 INFO - Using env: {'DISPLAY': ':0', 11:14:54 INFO - 'HOME': '/home/cltbld', 11:14:54 INFO - 'LANG': 'en_US.UTF-8', 11:14:54 INFO - 'LANGUAGE': 'en_US:en', 11:14:54 INFO - 'LOGNAME': 'cltbld', 11:14:54 INFO - 'MAIL': '/var/mail/cltbld', 11:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:54 INFO - 'MOZ_NO_REMOTE': '1', 11:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:54 INFO - 'NO_EM_RESTART': '1', 11:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:14:54 INFO - 'PWD': '/builds/slave/test-pgo', 11:14:54 INFO - 'SHELL': '/bin/bash', 11:14:54 INFO - 'SHLVL': '1', 11:14:54 INFO - 'TERM': 'linux', 11:14:54 INFO - 'TMOUT': '86400', 11:14:54 INFO - 'USER': 'cltbld', 11:14:54 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163', 11:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:54 INFO - '_': '/tools/buildbot/bin/python'} 11:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:54 INFO - Downloading/unpacking blobuploader==1.2.4 11: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 11: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 11: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 11: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 11: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 11: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 11:14:56 INFO - Downloading blobuploader-1.2.4.tar.gz 11:14:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:14:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:14:56 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 11:14:56 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 11:14:56 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 11:14:56 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 11:14:56 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 11:14:56 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 11:14:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:14:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:14:57 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 11:14:57 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 11:14:57 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 11:14:57 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 11:14:57 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 11:14:57 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 11:14:57 INFO - Downloading docopt-0.6.1.tar.gz 11:14:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:14:57 INFO - Installing collected packages: blobuploader, requests, docopt 11:14:57 INFO - Running setup.py install for blobuploader 11:14:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:14:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:14:57 INFO - Running setup.py install for requests 11:14:57 INFO - Running setup.py install for docopt 11:14:57 INFO - Successfully installed blobuploader requests docopt 11:14:57 INFO - Cleaning up... 11:14:57 INFO - Return code: 0 11:14:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f6af0f0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df8350>, '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 0x1df9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df96e0>, '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': '652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163', '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 11:14:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 11:14:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 11:14:57 INFO - Using env: {'DISPLAY': ':0', 11:14:57 INFO - 'HOME': '/home/cltbld', 11:14:57 INFO - 'LANG': 'en_US.UTF-8', 11:14:57 INFO - 'LANGUAGE': 'en_US:en', 11:14:57 INFO - 'LOGNAME': 'cltbld', 11:14:57 INFO - 'MAIL': '/var/mail/cltbld', 11:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:57 INFO - 'MOZ_NO_REMOTE': '1', 11:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:57 INFO - 'NO_EM_RESTART': '1', 11:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:14:57 INFO - 'PWD': '/builds/slave/test-pgo', 11:14:57 INFO - 'SHELL': '/bin/bash', 11:14:57 INFO - 'SHLVL': '1', 11:14:57 INFO - 'TERM': 'linux', 11:14:57 INFO - 'TMOUT': '86400', 11:14:57 INFO - 'USER': 'cltbld', 11:14:57 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163', 11:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:57 INFO - '_': '/tools/buildbot/bin/python'} 11:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:14:58 INFO - Running setup.py (path:/tmp/pip-7jOwm_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:14:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:14:58 INFO - Running setup.py (path:/tmp/pip-bB5gfi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:14:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:14:58 INFO - Running setup.py (path:/tmp/pip-WGhvXq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:14:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:14:58 INFO - Running setup.py (path:/tmp/pip-yRnSgi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:14:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:14:58 INFO - Running setup.py (path:/tmp/pip-TraF91-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:14:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:14:58 INFO - Running setup.py (path:/tmp/pip-KlfKBi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:14:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:14:58 INFO - Running setup.py (path:/tmp/pip-lggQci-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:14:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:14:58 INFO - Running setup.py (path:/tmp/pip-19EufH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:14:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:14:58 INFO - Running setup.py (path:/tmp/pip-3liZDl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:14:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:14:58 INFO - Running setup.py (path:/tmp/pip-rYSB76-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:14:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:14:58 INFO - Running setup.py (path:/tmp/pip-8FEPZg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:14:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:14:58 INFO - Running setup.py (path:/tmp/pip-57dfvK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:14:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:14:59 INFO - Running setup.py (path:/tmp/pip-m41rLv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:14:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:14:59 INFO - Running setup.py (path:/tmp/pip-IWo5Qh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:14:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:14:59 INFO - Running setup.py (path:/tmp/pip-H62WZo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:14:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:14:59 INFO - Running setup.py (path:/tmp/pip-E3YpTe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:14:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:14:59 INFO - Running setup.py (path:/tmp/pip-ozbzvT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:14:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:14:59 INFO - Running setup.py install for manifestparser 11:14:59 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:14:59 INFO - Running setup.py install for mozcrash 11:14:59 INFO - Running setup.py install for mozdebug 11:14:59 INFO - Running setup.py install for mozdevice 11:14:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:14:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:14:59 INFO - Running setup.py install for mozfile 11:14:59 INFO - Running setup.py install for mozhttpd 11:14:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:14:59 INFO - Running setup.py install for mozinfo 11:15:00 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:15:00 INFO - Running setup.py install for mozInstall 11:15:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:15:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:15:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:15:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:15:00 INFO - Running setup.py install for mozleak 11:15:00 INFO - Running setup.py install for mozlog 11:15:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:15:00 INFO - Running setup.py install for moznetwork 11:15:00 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:15:00 INFO - Running setup.py install for mozprocess 11:15:00 INFO - Running setup.py install for mozprofile 11:15:00 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:15:00 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:15:00 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:15:00 INFO - Running setup.py install for mozrunner 11:15:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:15:00 INFO - Running setup.py install for mozscreenshot 11:15:00 INFO - Running setup.py install for moztest 11:15:01 INFO - Running setup.py install for mozversion 11:15:01 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:15:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:15:01 INFO - Cleaning up... 11:15:01 INFO - Return code: 0 11:15:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f6af0f0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df8350>, '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 0x1df9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df96e0>, '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': '652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163', '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 11:15:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:15:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:15:01 INFO - Using env: {'DISPLAY': ':0', 11:15:01 INFO - 'HOME': '/home/cltbld', 11:15:01 INFO - 'LANG': 'en_US.UTF-8', 11:15:01 INFO - 'LANGUAGE': 'en_US:en', 11:15:01 INFO - 'LOGNAME': 'cltbld', 11:15:01 INFO - 'MAIL': '/var/mail/cltbld', 11:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:01 INFO - 'MOZ_NO_REMOTE': '1', 11:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:01 INFO - 'NO_EM_RESTART': '1', 11:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:15:01 INFO - 'PWD': '/builds/slave/test-pgo', 11:15:01 INFO - 'SHELL': '/bin/bash', 11:15:01 INFO - 'SHLVL': '1', 11:15:01 INFO - 'TERM': 'linux', 11:15:01 INFO - 'TMOUT': '86400', 11:15:01 INFO - 'USER': 'cltbld', 11:15:01 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163', 11:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:01 INFO - '_': '/tools/buildbot/bin/python'} 11:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:15:01 INFO - Running setup.py (path:/tmp/pip-1ebado-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:15:01 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)) 11:15:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:15:01 INFO - Running setup.py (path:/tmp/pip-3p67iu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:15:01 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)) 11:15:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:15:01 INFO - Running setup.py (path:/tmp/pip-4_e7ft-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:15:01 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)) 11:15:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:15:01 INFO - Running setup.py (path:/tmp/pip-VcCoDw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:15:01 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)) 11:15:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:15:01 INFO - Running setup.py (path:/tmp/pip-UaySKH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:15:01 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)) 11:15:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:15:01 INFO - Running setup.py (path:/tmp/pip-ZfytmR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:15:01 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)) 11:15:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:15:01 INFO - Running setup.py (path:/tmp/pip-v0qDsp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:15:01 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)) 11:15:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:15:01 INFO - Running setup.py (path:/tmp/pip-qqfmaf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:15:01 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)) 11:15:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:15:01 INFO - Running setup.py (path:/tmp/pip-wWPShJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:15:02 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)) 11:15:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:15:02 INFO - Running setup.py (path:/tmp/pip-4HWkuV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:15:02 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)) 11:15:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:15:02 INFO - Running setup.py (path:/tmp/pip-HEVN1j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:15:02 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)) 11:15:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:15:02 INFO - Running setup.py (path:/tmp/pip-uzqyw8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:15:02 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)) 11:15:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:15:02 INFO - Running setup.py (path:/tmp/pip-VVLoER-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:15:02 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)) 11:15:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:15:02 INFO - Running setup.py (path:/tmp/pip-kJk0HS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:15:02 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)) 11:15:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:15:02 INFO - Running setup.py (path:/tmp/pip-s4wdOo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:15:02 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)) 11:15:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:15:02 INFO - Running setup.py (path:/tmp/pip-lvrGNI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:15:02 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)) 11:15:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:15:02 INFO - Running setup.py (path:/tmp/pip-YMD1k7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:15:02 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)) 11:15:02 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)) 11:15:02 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)) 11:15:02 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)) 11:15:02 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)) 11:15:02 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)) 11:15:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:15:02 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 11:15:02 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 11:15:02 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 11:15:02 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 11:15:02 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 11:15:02 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 11:15:04 INFO - Downloading blessings-1.6.tar.gz 11:15:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:15:04 INFO - Installing collected packages: blessings 11:15:04 INFO - Running setup.py install for blessings 11:15:04 INFO - Successfully installed blessings 11:15:04 INFO - Cleaning up... 11:15:04 INFO - Return code: 0 11:15:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:15:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:15:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:15:04 INFO - Reading from file tmpfile_stdout 11:15:04 INFO - Current package versions: 11:15:04 INFO - argparse == 1.2.1 11:15:04 INFO - blessings == 1.6 11:15:04 INFO - blobuploader == 1.2.4 11:15:04 INFO - docopt == 0.6.1 11:15:04 INFO - manifestparser == 1.1 11:15:04 INFO - mozInstall == 1.12 11:15:04 INFO - mozcrash == 0.16 11:15:04 INFO - mozdebug == 0.1 11:15:04 INFO - mozdevice == 0.47 11:15:04 INFO - mozfile == 1.2 11:15:04 INFO - mozhttpd == 0.7 11:15:04 INFO - mozinfo == 0.9 11:15:04 INFO - mozleak == 0.1 11:15:04 INFO - mozlog == 3.1 11:15:04 INFO - moznetwork == 0.27 11:15:04 INFO - mozprocess == 0.22 11:15:04 INFO - mozprofile == 0.27 11:15:04 INFO - mozrunner == 6.11 11:15:04 INFO - mozscreenshot == 0.1 11:15:04 INFO - mozsystemmonitor == 0.0 11:15:04 INFO - moztest == 0.7 11:15:04 INFO - mozversion == 1.4 11:15:04 INFO - psutil == 3.1.1 11:15:04 INFO - requests == 1.2.3 11:15:04 INFO - wsgiref == 0.1.2 11:15:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:15:04 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')]} 11:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:04 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')]} 11:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f6af0f0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df8350>, '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 0x1df9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df96e0>, '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': '652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163', '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 11:15:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:15:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:15:04 INFO - Using env: {'DISPLAY': ':0', 11:15:04 INFO - 'HOME': '/home/cltbld', 11:15:04 INFO - 'LANG': 'en_US.UTF-8', 11:15:04 INFO - 'LANGUAGE': 'en_US:en', 11:15:04 INFO - 'LOGNAME': 'cltbld', 11:15:04 INFO - 'MAIL': '/var/mail/cltbld', 11:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:04 INFO - 'MOZ_NO_REMOTE': '1', 11:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:04 INFO - 'NO_EM_RESTART': '1', 11:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:15:04 INFO - 'PWD': '/builds/slave/test-pgo', 11:15:04 INFO - 'SHELL': '/bin/bash', 11:15:04 INFO - 'SHLVL': '1', 11:15:04 INFO - 'TERM': 'linux', 11:15:04 INFO - 'TMOUT': '86400', 11:15:04 INFO - 'USER': 'cltbld', 11:15:04 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163', 11:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:04 INFO - '_': '/tools/buildbot/bin/python'} 11:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:05 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)) 11:15:05 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)) 11:15:05 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)) 11:15:05 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)) 11:15:05 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)) 11:15:05 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)) 11:15:05 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)) 11:15:05 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)) 11:15:05 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)) 11:15:05 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)) 11:15:05 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)) 11:15:05 INFO - Cleaning up... 11:15:05 INFO - Return code: 0 11:15:05 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f6af0f0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df8350>, '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 0x1df9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df96e0>, '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': '652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163', '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 11:15:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:15:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:15:05 INFO - Using env: {'DISPLAY': ':0', 11:15:05 INFO - 'HOME': '/home/cltbld', 11:15:05 INFO - 'LANG': 'en_US.UTF-8', 11:15:05 INFO - 'LANGUAGE': 'en_US:en', 11:15:05 INFO - 'LOGNAME': 'cltbld', 11:15:05 INFO - 'MAIL': '/var/mail/cltbld', 11:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:05 INFO - 'MOZ_NO_REMOTE': '1', 11:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:05 INFO - 'NO_EM_RESTART': '1', 11:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:15:05 INFO - 'PWD': '/builds/slave/test-pgo', 11:15:05 INFO - 'SHELL': '/bin/bash', 11:15:05 INFO - 'SHLVL': '1', 11:15:05 INFO - 'TERM': 'linux', 11:15:05 INFO - 'TMOUT': '86400', 11:15:05 INFO - 'USER': 'cltbld', 11:15:05 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163', 11:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:05 INFO - '_': '/tools/buildbot/bin/python'} 11:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:05 INFO - Downloading/unpacking jsonschema 11:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:15:07 INFO - Downloading/unpacking functools32 (from jsonschema) 11:15:07 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 11:15:07 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 11:15:07 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 11:15:07 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 11:15:07 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 11:15:07 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 11:15:07 INFO - Downloading functools32-3.2.3-2.tar.gz 11:15:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:15:07 INFO - warning: no files found matching '*.txt' 11:15:07 INFO - no previously-included directories found matching 'build' 11:15:07 INFO - no previously-included directories found matching 'dist' 11:15:07 INFO - no previously-included directories found matching '.git*' 11:15:07 INFO - Installing collected packages: jsonschema, functools32 11:15:07 INFO - Running setup.py install for functools32 11:15:07 INFO - warning: no files found matching '*.txt' 11:15:07 INFO - no previously-included directories found matching 'build' 11:15:07 INFO - no previously-included directories found matching 'dist' 11:15:07 INFO - no previously-included directories found matching '.git*' 11:15:07 INFO - Successfully installed jsonschema functools32 11:15:07 INFO - Cleaning up... 11:15:07 INFO - Return code: 0 11:15:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:15:07 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')]} 11:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:07 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')]} 11:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6af0f0df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d69600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df8350>, '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 0x1df9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df96e0>, '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': '652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163', '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 11:15:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 11:15:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:15:07 INFO - Using env: {'DISPLAY': ':0', 11:15:07 INFO - 'HOME': '/home/cltbld', 11:15:07 INFO - 'LANG': 'en_US.UTF-8', 11:15:07 INFO - 'LANGUAGE': 'en_US:en', 11:15:07 INFO - 'LOGNAME': 'cltbld', 11:15:07 INFO - 'MAIL': '/var/mail/cltbld', 11:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:07 INFO - 'MOZ_NO_REMOTE': '1', 11:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:07 INFO - 'NO_EM_RESTART': '1', 11:15:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:15:07 INFO - 'PWD': '/builds/slave/test-pgo', 11:15:07 INFO - 'SHELL': '/bin/bash', 11:15:07 INFO - 'SHLVL': '1', 11:15:07 INFO - 'TERM': 'linux', 11:15:07 INFO - 'TMOUT': '86400', 11:15:07 INFO - 'USER': 'cltbld', 11:15:07 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163', 11:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:07 INFO - '_': '/tools/buildbot/bin/python'} 11:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:07 INFO - Downloading/unpacking flake8 11:15:07 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 11:15:07 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 11:15:07 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 11:15:07 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 11:15:07 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 11:15:07 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 11:15:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:15:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:15:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:15:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:15:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:15:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:15:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:15:10 INFO - no previously-included directories found matching 'docs/_build' 11:15:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:15:10 INFO - Running setup.py install for pep8 11:15:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:15:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:15:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:15:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:15:10 INFO - no previously-included directories found matching 'docs/_build' 11:15:10 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:15:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:15:10 INFO - Cleaning up... 11:15:10 INFO - Return code: 0 11:15:10 INFO - Running post-action listener: _resource_record_post_action 11:15:10 INFO - Running post-action listener: _start_resource_monitoring 11:15:10 INFO - Starting resource monitoring. 11:15:10 INFO - ##### 11:15:10 INFO - ##### Running install step. 11:15:10 INFO - ##### 11:15:10 INFO - Running pre-action listener: _resource_record_pre_action 11:15:10 INFO - Running main action method: install 11:15:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:15:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:15:10 INFO - Reading from file tmpfile_stdout 11:15:10 INFO - Detecting whether we're running mozinstall >=1.0... 11:15:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:15:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:15:10 INFO - Reading from file tmpfile_stdout 11:15:10 INFO - Output received: 11:15:10 INFO - Usage: mozinstall [options] installer 11:15:10 INFO - Options: 11:15:10 INFO - -h, --help show this help message and exit 11:15:10 INFO - -d DEST, --destination=DEST 11:15:10 INFO - Directory to install application into. [default: 11:15:10 INFO - "/builds/slave/test-pgo"] 11:15:10 INFO - --app=APP Application being installed. [default: firefox] 11:15:10 INFO - mkdir: /builds/slave/test-pgo/build/application 11:15:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 11:15:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 11:15:25 INFO - Reading from file tmpfile_stdout 11:15:25 INFO - Output received: 11:15:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:15:25 INFO - Running post-action listener: _resource_record_post_action 11:15:25 INFO - ##### 11:15:25 INFO - ##### Running run-tests step. 11:15:25 INFO - ##### 11:15:25 INFO - Running pre-action listener: _resource_record_pre_action 11:15:25 INFO - Running main action method: run_tests 11:15:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:15:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:15:25 INFO - Python 2.7.3 11:15:25 INFO - Return code: 0 11:15:25 INFO - grabbing minidump binary from tooltool 11:15:25 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')]} 11:15:25 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 0x1df8350>, '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 0x1df9250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df96e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:15:25 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 11:15:25 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 11:15:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:15:25 INFO - Return code: 0 11:15:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:15:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:15:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:15:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:15:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:15:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:15:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:15:26 INFO - Return code: 0 11:15:26 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-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455555206/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 11:15:26 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-Beta --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455555206/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost 11:15:26 INFO - Using env: {'DISPLAY': ':0', 11:15:26 INFO - 'HOME': '/home/cltbld', 11:15:26 INFO - 'LANG': 'en_US.UTF-8', 11:15:26 INFO - 'LANGUAGE': 'en_US:en', 11:15:26 INFO - 'LOGNAME': 'cltbld', 11:15:26 INFO - 'MAIL': '/var/mail/cltbld', 11:15:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:15:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:15:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:26 INFO - 'MOZ_NO_REMOTE': '1', 11:15:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:15:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:26 INFO - 'NO_EM_RESTART': '1', 11:15:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:15:26 INFO - 'PWD': '/builds/slave/test-pgo', 11:15:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:15:26 INFO - 'SHELL': '/bin/bash', 11:15:26 INFO - 'SHLVL': '1', 11:15:26 INFO - 'TERM': 'linux', 11:15:26 INFO - 'TMOUT': '86400', 11:15:26 INFO - 'USER': 'cltbld', 11:15:26 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163', 11:15:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:26 INFO - '_': '/tools/buildbot/bin/python'} 11:15:26 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455555206/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost'] with output_timeout 3600 11:15:26 INFO - mozversion INFO | application_buildid: 20160215085326 11:15:26 INFO - mozversion INFO | application_changeset: 41eb59a46425fa286cba45ed4f1cd049b9cca4f4 11:15:26 INFO - mozversion INFO | application_display_name: Nightly 11:15:26 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:15:26 INFO - mozversion INFO | application_name: Firefox 11:15:26 INFO - mozversion INFO | application_remotingname: firefox 11:15:26 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:15:26 INFO - mozversion INFO | application_vendor: Mozilla 11:15:26 INFO - mozversion INFO | application_version: 45.0 11:15:26 INFO - mozversion INFO | platform_buildid: 20160215085326 11:15:26 INFO - mozversion INFO | platform_changeset: 41eb59a46425fa286cba45ed4f1cd049b9cca4f4 11:15:26 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:15:26 INFO - mozversion INFO | platform_version: 45.0 11:15:26 INFO - 2016-02-15 11:15:26,775 DEBUG : using testdate: 1455563726 11:15:26 INFO - 2016-02-15 11:15:26,775 DEBUG : actual date: 1455563726 11:15:26 INFO - 2016-02-15 11:15:26,867 INFO : starting webserver on 'localhost:43665' 11:15:26 INFO - 2016-02-15 11:15:26,868 INFO : Starting test suite talos-linux64-ix-046 11:15:26 INFO - 2016-02-15 11:15:26,868 INFO : Starting test dromaeo_css 11:15:26 INFO - 2016-02-15 11:15:26,868 DEBUG : operating with platform_type : linux_ 11:15:26 INFO - 2016-02-15 11:15:26,869 INFO : Initialising browser for dromaeo_css test... 11:15:26 INFO - 2016-02-15 11:15:26,878 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp78rCNy/profile http://localhost:43665/getInfo.html 11:15:30 INFO - 2016-02-15 11:15:30,552 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:15:30 INFO - 2016-02-15 11:15:30,552 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:15:30 INFO - 2016-02-15 11:15:30,552 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:15:30 INFO - 2016-02-15 11:15:30,552 DEBUG : BROWSER_OUTPUT: __metrics 11:15:30 INFO - 2016-02-15 11:15:30,673 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:15:31 INFO - 2016-02-15 11:15:31,954 INFO : Browser initialized. 11:15:31 INFO - 2016-02-15 11:15:31,955 INFO : Running cycle 1/1 for dromaeo_css test... 11:15:31 INFO - 2016-02-15 11:15:31,955 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp78rCNy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:15:43 INFO - 2016-02-15 11:15:43,585 DEBUG : BROWSER_OUTPUT: RSS: Main: 132665344 11:15:43 INFO - 2016-02-15 11:15:43,585 DEBUG : BROWSER_OUTPUT: 11:16:35 INFO - 2016-02-15 11:16:35,381 DEBUG : BROWSER_OUTPUT: 1455563795377 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] 11:18:42 INFO - 2016-02-15 11:18:42,542 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43665/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43665/tests/dromaeo/cssquery-ext.html) 11:18:43 INFO - 2016-02-15 11:18:43,732 DEBUG : BROWSER_OUTPUT: RSS: Main: 254791680 11:18:43 INFO - 2016-02-15 11:18:43,732 DEBUG : BROWSER_OUTPUT: 11:21:45 INFO - 2016-02-15 11:21:45,892 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43665/tests/dromaeo/cssquery-ext.html (next: http://localhost:43665/tests/dromaeo/cssquery-jquery.html) 11:21:46 INFO - 2016-02-15 11:21:46,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 218025984 11:21:46 INFO - 2016-02-15 11:21:46,453 DEBUG : BROWSER_OUTPUT: 11:24:48 INFO - 2016-02-15 11:24:48,305 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43665/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43665/tests/dromaeo/cssquery-mootools.html) 11:24:48 INFO - 2016-02-15 11:24:48,887 DEBUG : BROWSER_OUTPUT: RSS: Main: 207826944 11:24:48 INFO - 2016-02-15 11:24:48,888 DEBUG : BROWSER_OUTPUT: 11:27:50 INFO - 2016-02-15 11:27:50,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43665/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43665/tests/dromaeo/cssquery-prototype.html) 11:27:51 INFO - 2016-02-15 11:27:51,129 DEBUG : BROWSER_OUTPUT: RSS: Main: 198246400 11:27:51 INFO - 2016-02-15 11:27:51,129 DEBUG : BROWSER_OUTPUT: 11:30:53 INFO - 2016-02-15 11:30:53,514 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43665/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43665/tests/dromaeo/cssquery-yui.html) 11:30:54 INFO - 2016-02-15 11:30:54,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 201838592 11:30:54 INFO - 2016-02-15 11:30:54,081 DEBUG : BROWSER_OUTPUT: 11:33:56 INFO - 2016-02-15 11:33:56,330 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43665/tests/dromaeo/cssquery-yui.html (next: http://localhost:43665/tests/dromaeo/cssquery-dojo.html) 11:33:56 INFO - 2016-02-15 11:33:56,581 DEBUG : BROWSER_OUTPUT: RSS: Main: 235589632 11:33:56 INFO - 2016-02-15 11:33:56,581 DEBUG : BROWSER_OUTPUT: 11:33:56 INFO - 2016-02-15 11:33:56,581 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:33:56 INFO - 2016-02-15 11:33:56,582 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:33:56 INFO - 2016-02-15 11:33:56,582 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:33:56 INFO - 2016-02-15 11:33:56,582 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:33:56 INFO - 2016-02-15 11:33:56,582 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3239.546463495111;3328.5007248912675;3354.8322583870818;3357.429237029706;3379;5451.318585176853;5509.614326997112;5531.91702124468;5535.833924982247;5607.7476513556885;5563.36021357544;5570.554355651539;5609.719514024303;5612.607117501777;5617.578681598876;4874.805007799684;5082.517160869711;5116.513931176532;5162.483751624826;5205.37535495741;5017.448080711137;5077.949220507785;5079.746012699368;5079.974600127012;5083.517065878736;5011.473795251501;5024.547790698836;5089.185730283156;5095.184770436731;5097.872553186182;5026.4219614744225;5109.335786347751;5115.641905066628;5143.04853602081;5157.948420515821;5058.822941197077;5129.717865517395;5131.948680513222;5138.5445602716;5175.223716442564;5264.657797243205;5341.946580534222;5365.114756065244;5464.6994415307145;5476.151196564539;5995.550333724988;6003.7898673546215;6009.278886533644;6015.27816661999;6027.547933904974;6027.698615069273;6042.274927008787;6045.72794224261;6048.1834952281315;6050.878982420371;5429.077056900336;5518.365387980353;5522.723863806794;5625.578081643852;5631.577631677641;6069.439175834017;6203.193584833943;6206.441420272197;6210.4100110489435;6214.316425193225;5961.254843144607;5972.432618901197;5974.103884417372;5974.462298393166;6018.638881667114;5793.913091303634;5930.7924222652;6044;6047.969760151171;6068.605540639845;5804.21643078179;5875.882482350415;5879.118132280192;5880.26496687914;5909.084091965752;5873.177755114288;5911.349751527328;5932.673702946293;5936.376680448577;5947.851303717355;4430.867073987721;4498.21281275782;4530.750808705553;4551.294549344857;4587.243104887656;4085.428040074392;4090.9590904091174;4102.50769907613;4107.116969851496;4132.483439570054;5717.142428635738;5717.571182161355;5718.68547229898;5721;5721.084626459747;5640.520555752807;5741.799037033684;5843;5961.582689211714;5975.462208401264;5713.342965558931;5716.514096301861;5734.856628584235;5737.85655358611;5764.654120752768;5014.824481143215;5014.84955451337;5016.347874776328;5023.095842748267;5040.647154699209;5928.170056192136;6037;6069.423404776539;6134.478569321568;6141.109539116893;6000.969995149996;6012.8797424052145;6014.939850601438;6017.608855424383;6064.636121832704;5925.792597259076;6179.62922224668;6191.84520386994;6196.969015155076;6197.81406557804;5708.457696518824;5837.94162058374;5915.40845915405;5953.434423729739;5983.880322393615;6005.87988240224;6046.486048685911;6055.848603784941;6058.151858739868;6103;5546.4453554645825;5660.490555849993;5915.260592425947;5916.171735957056;5933.821985340447;5874.647521148745;5949.6430214187285;5954.345022047658;5962.344142144274;5966.492848107786;5787.334456537552;5794.101914203306;5795.8551036224435;5800.76796928135;5801.738921748447;5666.17840413146;5713.285839270091;5733.598648094593;5900.232969713909;5904.409559044061;5751.712414379181;5787.247657804459;5790.10253410722;5799.768009279582;5810.73851676684 11:33:56 INFO - 2016-02-15 11:33:56,585 DEBUG : BROWSER_OUTPUT: |1;ext.html;602.7347966894566;649;649.629711064693;651.6057785040051;661.6195687479699;31790;32360.352792944126;32387.83806080972;32399.352012959756;32425.189370265754;33076.503852442234;43038;43115.35326970098;43200.783996079976;43209.567904320946;9259.351845370828;9399.95300023499;9418.340716149873;9426.104520070583;9428;7862.724804631839;8008.599570021504;9128.315376346767;9265.444073355586;10985.395803230818;10887.618933337335;10957.06864916483;11003.22977391583;11006.889931100666;11012.724681882977;10892.128629709605;10990.120790336754;10995.615153469591;11002.394868282241;11003.889961100367;10772.35365878042;10862.131029517619;10862.45687715611;10905.18211134168;10909.618163364323;41846;41922.580774192174;42141.36787948183;42301;42311.788441057906;3541.11472131967;3561.7684850484893;3584.193556449778;3692.7230457715777;3748.7938163401004;32964.6703532964;33298.66701333004;33466.83266583652;33491.162720932174;33558.49662255068;3837.6546110849877;3911.5110611173604;3981.41540365604;4012.29784787661;4037.9394309085387;298251;298986;299841;300980;301139;57471;59006.40993590009;66203;66754;68239.31760682429;59487;59541.40458595445;59818.700906495185;59876;59924.400755992756;16113.27490262941;16201.027938323738;16217.270222840001;16228.675426491403;16252.918735406247;11761.941190293994;11786.764264714659;11789.646310610695;11790.469428875722;11795.764084718428;22005.33983980483;22293.66559501609;22312.776872231396;22328.441788955082;22366;7671.808204794925;7755.2244775521995;7900.920990790019;7969.362451003905;7969.920300797034;1024.8155332040305;1069.417167643636;1072.1637123044038;1073.9624113156158;1110.74452875839;30705.539416908763;31082.067537973897;31440.842795785873;34549.481757773654;36264.63735362612;1087.4019289390803;1103.9116870650328;1131.8415421840948;1150.4362862197463;1247.089624574066;13762.587122386145;15209.543713688607;15529.145896975775;15630.843691563166;15968.920155399148;830710;844629;849863;852207;853582;62879.6856015717;63375.36624633787;63573;63580.68209659015;63616;1410.9717805644034;1440.7694768836936;1529.4341093795367;1539.8229203641501;1582.6518166003461;32404.189895251864;32419.027429177164;32452;32721.672783271864;33228.33543329168;49519.75240123776;49787.502124979736;50120.248196276356;50150;50185;229084;230761;233608;253062;254346;36993.81503092467;37352.43971340486;52659.47340526546;52758.20862686986;52967;47328.52671473379;47696;48467.5153248463;48576.271355930396;49110.75444622754;40206.798966004986;40781;41011.384829228184;41805.37291940562;41813.79093104515;40737.59262407457;41510.1697966045;46453.303200451344;46538.53461465342;48466.27300590424;45547;45976.540234597225;45997;46375.53624463847;46639.53360466487;35597.110072248404;35935;41396.474042134505;41425.792871036654;41444.585554144076;27156.592651109855;27293.590596140675;27327.726722733314;27415.17754467369;27419.451610968066 11:33:56 INFO - 2016-02-15 11:33:56,586 DEBUG : BROWSER_OUTPUT: |2;jquery.html;390.9413587961805;394.2430533375918;394.26272869733594;397.6520544523542;399.6323382488111;17226.397076102337;18141.81858181418;18439.72340414895;18631.1615977281;18643.1610577524;17377.30490780367;17515.299388024494;17571.56071098223;17939.641207175882;17968.281268749233;5549.417311182328;5696.430356964291;5698.914516282259;5699.829005129832;5722;5199.194124910645;5663.971680141593;5685.971570142144;5704.48659620634;5707.74315155819;4239.0674051708575;4362.650987920974;6044.667543285118;6311.621302721851;6314.968425157867;6101.054336577838;6132.969335153341;6163.414475624831;6166.075088736703;6171.938280617203;5383.838484845461;5463.699496527689;5466.316710411199;5468;5471.616986810925;16653.250603722863;17004.404845830337;19790.10944507486;20904.895475522524;21198.3640490784;2225.187806450634;2356.658284548731;2379.4765151666606;2447.229122826304;2591.585346344576;9740.90259097407;9799.657012004616;9847.064528869745;9860.65487707934;10055.145312648434;1946.5814849807218;1965.2237366240256;1973.6447439460892;1997.5405656698895;2048.774634790172;62335.571543565085;62750.686246568475;62790.37209627937;62930.370696292906;62954.68522657403;10662.360258384522;10764.515596798006;10793.78412431747;10797.622083227207;10865.293755905841;14225.359858806378;14234;14252.287385630678;14279.500217492337;14279.92860035714;8116.188381161836;8162.959185204036;8171.836563268701;8234.958825205835;8244.628991695388;7865.410094242955;7872.488288261359;7872.685092596232;7938.087119981161;7948.880766788503;4487.730736155841;4546.977265113654;4552.339910712994;4596.563326483979;4597.4712908015335;1828.698264786322;1833.669939410892;1833.724941258822;1847.1226167570564;1860.9162587683586;926.4348747264163;1018.032868774667;1033.4625994482976;1037.0407373179778;1125.0380924309761;13925.442982280596;17274.568135796704;17335.913320433316;17772.911135444498;18630;945.432740355781;975.2880397310004;1000.7047920863363;1068.7648717282186;1083.8916108389099;9146.679866204651;9397.483138427315;9410.341276110743;9505.192058674951;9572.282078844115;479802;624365;631361;691990;695910;86754.1324586746;89333.55333223422;90594;92389.5380523093;93049.53475232716;1212.1454374665839;1233.6730766346925;1238.2508582307755;1241.3482921466302;1241.4909886946489;16120.355185792438;16167.191640418167;16191.271392787588;16241.67516649684;16638.66722665564;37087.443688345236;37344;37774;38652.420213696256;38734.612653873104;49931;50570.74714626403;51969.740151299;52645.47354526406;55503.72248138733;9725.0761177688;9778.60885564598;9914.355566888129;9917.752056198653;10006.849212340383;11977.880221198026;11999.700007499534;12070.094742894142;12147.878521214674;14261.286935653383;15274.541763747106;15282.617934551281;15462.458813941457;15510.379584816481;15789.368425262861;14373.64065898361;14943.103413795207;14980.775288370465;14999.925000374928;15339.463118791235;15250.923745381202;15318.463853765064;15365.539033829004;15680.76478852841;15828.841711582736;9763.365381250196;9903.207743380657;10020;10051.497425128568;10106.696799096038;10358.792824143626;14217.50238741639;14946.252687365806;15015.324310406277;15401.614959626098 11:33:56 INFO - 2016-02-15 11:33:56,587 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1482.3255418784452;1532.731771939911;1623.9525506048592;1714.2628669672035;1853.240171529673;8028.518288902663;8291.295239904615;8326.83346333073;8333.333333333334;8346.707865224718;8266.049404318504;8372.53951032693;8386.87419688705;8393.622286997084;8394.076651568323;2344.296710986706;2349.4126468382906;2394.0663141374876;2396.940076498084;2397.2328854766483;2353.0587764894094;2378.4291769975252;2379.583572874749;2380.2026321182425;2381.1308872261675;2006.678931370981;2054.6917962305697;2264.2527965771255;2295.070496448941;2375.8455700379504;2328.871912044837;2331.8717470539113;2354.3407845803204;2354.8704821234824;2356.9175078872245;2284.7601001894727;2310.8844557772045;2313.456337760625;2315.085541211229;2315.120254303354;6968.756093536753;7220.169680486759;7764.3788496920115;8004.959975200087;8045.5977201140295;4901.632377571696;4973.502649735034;4979.327790748239;4979.45226025137;4981.476944920767;3179.72972297355;3203.983980080108;3218.3563287342627;3245.789023713451;3249.333886553251;956.7942892278194;963.8554216867456;968.8062387522453;973.0123924216925;995.6017592962801;11436.19946603738;11487.25332853362;11531.019863311629;11548.018418434443;11569.826452603218;4468.084042771224;4479.731216127043;4544.431946006749;4552.88617784558;4560.4071470708595;9876.555555000043;9937.552810123561;9946.80106397868;9955.203583713286;9966.152877005536;4942.159832828428;4962.851114466572;4970.105381031449;4980.501949805063;4994;4441.866743997685;4452.065066336106;4469.08383781324;4477.820887164542;4479.30570761526;3702.8148592570265;3744.9063773405883;3745;3770.170562476306;3792.6017768133947;1194.6296648039136;1198.7362780188344;1202.855657321127;1204.8493938257718;1208.5528354508713;1276.380955236728;1290.077594519904;1304.7586196553668;1312.0028778128692;1320.3398300849576;7634.160242373335;7685.730999414994;7703.922960770433;7704;7706.267904549059;482.7151980331551;488.6213184781823;488.7458521568764;489.3980404102902;489.9436564795094;5314.681119132864;5457.181422786613;6277.748890044347;6343.143675603735;6348.968255158695;9574.760630984281;9628.32601717887;9664.420134791935;9715.805683886425;9810.166135878388;9543.284253681002;9639.71080867575;9692.22462203022;10030.197584193247;10052.246081543768;7818.843623127505;7862.764117076496;7894.368450523944;7923.20767923203;7926.920730792734;7946.086200087064;7975.242351976785;8020.358371330396;8058.3150432213915;8072.112067672434;8915.687950921687;8936.597853096497;9057.637694492147;9062.456252624863;9179.449233046038;9031.232345250464;9254.907450925404;9325.766855828659;9327.906720932704;9354.298427618092;7301.780946571611;7313;7326.560406375635;7352.191258961617;7422.7402040930465;8090.393220508367;8171.182881711781;8178.182181782012;8179.509229446252;8186.345092392713;7558.433117516099;7689.88465173034;7727.42044346665;7782.299593036654;7813.921860781319;7538.283863033003;7599.316061554266;7627.771166865003;7694.692212311669;7719.614019299125;7573.46985710995;7578;7584.08990921093;7605.353544948742;7605.581693006938;6703.765368212089;6805.183377994672;6821.590704557742;6849.075374824335;6853.760118396031;7098.432125430057;7130.322619351154;7139.643017848983;7142.214356420894;7160.033395491542 11:33:56 INFO - 2016-02-15 11:33:56,588 DEBUG : BROWSER_OUTPUT: |4;prototype.html;347.1546783581978;349.6136768870399;351.4657720265195;354.5178557162259;354.8367750834616;5842.386549412315;5967.671778052206;6013.609115407496;6013.729382177801;6055.182550355707;5785.392533783945;5913.113033045045;5931.792387266436;5934.258217722785;5937.4656280934705;4712.717236965776;4720.126776546333;4722.220833562458;4724.716517008973;4727.314539391786;4434.379186913835;4503.054358584701;4579.496255411902;4677.602403795681;4718.551737584941;4627.791749371287;4670.136024835399;4672.299155126741;4672.97663511682;4685.601723853477;4666.556677115668;4676.812927482896;4677.438707355105;4680.227762419197;4697.177993851063;4170.77060761658;4177.122804211089;4180.059486615518;4183;4185.100203456241;5606.859828504279;5685.886282274373;5695.34503532095;5696.11710184922;5700.543956483513;5455.645383050089;5458.399576046631;5465.234867118606;5468.425815289377;5474.972625136849;6007.128966299906;6336.271328797156;6339.461145802612;6340.651264180468;6346.746130154788;4391.341298805173;4480.686351955364;4575.382323386333;4613.146567884952;4619.3763841881255;6553.377429144223;6574.868502629921;6605.867882642368;6606.438452731523;6611.049740326615;4714.245720684674;4729.905401891943;4730.787114579852;4734.360861283752;4735.95264047362;4710.128626204163;4771.117343291502;4805.831795887128;4805.879853003703;4810.855674329776;5429.995450841607;5442.673439593637;5442.91835622466;5444.891102178013;5447.6459030163705;6379;6380;6383.914734495054;6387.872242555216;6450.096986421905;1676.9748453773202;1698.651776385838;1698.736695812151;1699.065513967313;1702.0213377308098;1169.4678921091054;1173.3253379306932;1173.8473998380157;1175.2419689300352;1192.3442106841203;6135.785247516315;6160.845978850564;6176.598521096204;6177.227846519185;6187.102870083812;6462.48300135988;6464.741410343628;6469.417752402306;6470.417662410406;6473.96416573346;6108.786192483241;6158.476529494954;6158.907616385758;6159.630422174684;6169.537284703665;3495.1961048958883;3523.6652518010746;3564.2515071834687;3574.8391322390034;3583.086312990171;6812.352826481477;6824.112865327475;6844.1444819397575;6857.485688573277;6868.381845633817;6599.406053455212;6747.696353664097;6752.493562982698;6757;6758.966205168943;6839.726410943506;6841.2132604750095;6848.828779280558;6859.348361905611;6864.553804002824;6360.713767880364;6468.094466774562;6481.578697384655;6614.173228346457;6619.073329733745;6492.513061520499;6492.513061520499;6497.512686548623;6500.512461565307;6545.967270163619;6805.04729337903;6831.59010459374;6840.726370945106;6841.965790171017;6845.596652686287;4495.640348772155;4621.653375996746;4640.466346370211;4658.930116048195;4663.580277775017;6571.277159512545;6573.211214654272;6574.868502630016;6578.638174900427;6578.80263592093;6411.96794016027;6417.26201486835;6419.775307864203;6423;6428.357164283534;6260.436560709558;6388;6399.296077431386;6443.613383197023;6451.41937225652;6301.054841773771;6338.207724034496;6342.334054924351;6354;6362.809115726535;6492.610443373413;6492.902606460812;6494.902576461452;6497.285298617243;6506.837329066811;6233.812985610439;6349.333320001333;6352.555321127476;6354.364563543609;6358.1734374531015 11:33:56 INFO - 2016-02-15 11:33:56,589 DEBUG : BROWSER_OUTPUT: |5;yui.html;919.099282702951;929.8605209218621;939.5631031570318;951.2247518272605;955.2453561686264;13706.725865482696;14103.858961410395;14538;15234.695306093872;15350.692986140299;13214.93392533036;13275.867241327584;13286.402111904963;13302.933485332584;13311.334433278322;734.988975165373;743.8698227810112;895.4716717136888;898.0794685447403;912.8721978922956;897.0401670212875;898.1512470715177;903.056306160061;905.004495055437;905.7554460295717;765.227120608187;943.6697155995381;949.9287553433486;950.9334346595741;954.1651055326589;763.4884627299695;764.4343186042345;764.8355603545209;934.4766930518931;945.3571571331491;705.1784670858444;708.6881772020295;708.9361957423805;708.989365159523;709.170270783185;14472.493462728859;14578.781318280235;14731.410743570244;14747;14755.11469311834;12675.366231688378;13256.270905100215;13403.396847141901;13431.194128352232;13437.260950647711;10144.970678415137;10159.746006349826;10396.376217426978;10456.738581535446;10491.42297173655;3706.3513885070006;3773.735838491307;3786.583475817658;3799.544054713452;3800.5439347278225;47991;48654;50197.24704129441;50378.999999999636;50504.242436363485;10809.405482698527;10954.123670106372;10984.505697243643;10990.615328463466;11031.613893513688;19671.901640491706;19862.503437413892;19889.701654475193;19929.601407972048;19929.900350498156;8105.918940810634;8138.470999385021;8219.630116644765;8294.253517183482;8360;4468.977655111704;4607.9308810367875;4614.307853821953;4636.536346365337;4665.5567721066445;3210.7912985655857;3255.3652037852867;3259.3807176636365;3265.232670322472;3265.248992731685;577.8786454844445;578.988420231593;581.2995340614549;588.485075558886;591.8372447576951;514.0284861611557;576.1530550091359;576.711644177911;600.8768202518473;693.4868197533789;8909.866352004725;9863.654772083086;9883.357581757307;9987.550560224807;10044.849327260097;531.7553925194454;627.9152314437583;688.3804575881746;692.3249831414331;716.3839098375392;4150.568054021358;4621.168189725814;4808.591269742111;4808.951910480921;4810.63920205986;59724;59947.400525994184;64180;64299;64603;56282.71858640681;56542.151867722016;57296.71351643215;58588.41411585829;58915.705421473474;52820.943581128166;53751.73124134433;53945.730271348395;54315.72842135764;54656.45343546513;9419.905800941902;9514.857277140987;9676.371035882645;9704.175145112462;9733.19935811877;37554.24891502209;37978.81010594929;38085.23829523449;38507.2298554033;38961.220775583766;45015.54984450113;46834;50595;50976.23535646894;51029.234561480866;12085.637430877088;12275.75448491043;12317.938410307892;12773.169743966613;12850.807237891626;12085.456154473246;12248.877511224773;12668.746625067632;12992.805107923577;13223.735525289632;12042.879571204527;12179.269243845398;12392.938035309766;12612.369381530703;12665.936670316958;12582.748345033231;12965.15726477776;13067.607971760863;13197.736045279233;13240.40418181165;12434.564790232298;12680.556180533637;12984;13267.800982985456;13294.335283235992;10412.010858968386;10418.374897506174;10608.893911061099;11285.266457680225;11357.772844542898;9624.615015399586;9809.460479673686;10461.895381046092;10483.947580262049;10699.572017119228 11:33:56 INFO - 2016-02-15 11:33:56,589 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:33:56 INFO - 2016-02-15 11:33:56,589 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:33:56 INFO - 2016-02-15 11:33:56,589 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,960 11:33:56 INFO - 2016-02-15 11:33:56,590 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:33:56 INFO - 2016-02-15 11:33:56,590 DEBUG : BROWSER_OUTPUT: __startTimestamp1455564836579__endTimestamp 11:33:56 INFO - 2016-02-15 11:33:56,590 DEBUG : BROWSER_OUTPUT: 11:33:56 INFO - 2016-02-15 11:33:56,590 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:33:56 INFO - 2016-02-15 11:33:56,590 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:33:56 INFO - 2016-02-15 11:33:56,590 DEBUG : BROWSER_OUTPUT: 11:33:56 INFO - 2016-02-15 11:33:56,590 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5545.76 Median:5751.71 stddev:623.60 (10.8%) stddev-sans-first:598.69 11:33:56 INFO - 2016-02-15 11:33:56,590 DEBUG : BROWSER_OUTPUT: Values: 3239.5 3328.5 3354.8 3357.4 3379.0 5451.3 5509.6 5531.9 5535.8 5607.7 5563.4 5570.6 5609.7 5612.6 5617.6 4874.8 5082.5 5116.5 5162.5 5205.4 5017.4 5077.9 5079.7 5080.0 5083.5 5011.5 5024.5 5089.2 5095.2 5097.9 5026.4 5109.3 5115.6 5143.0 5157.9 5058.8 5129.7 5131.9 5138.5 5175.2 5264.7 5341.9 5365.1 5464.7 5476.2 5995.6 6003.8 6009.3 6015.3 6027.5 6027.7 6042.3 6045.7 6048.2 6050.9 5429.1 5518.4 5522.7 5625.6 5631.6 6069.4 6203.2 6206.4 6210.4 6214.3 5961.3 5972.4 5974.1 5974.5 6018.6 5793.9 5930.8 6044.0 6048.0 6068.6 5804.2 5875.9 5879.1 5880.3 5909.1 5873.2 5911.3 5932.7 5936.4 5947.9 4430.9 4498.2 4530.8 4551.3 4587.2 4085.4 4091.0 4102.5 4107.1 4132.5 5717.1 5717.6 5718.7 5721.0 5721.1 5640.5 5741.8 5843.0 5961.6 5975.5 5713.3 5716.5 5734.9 5737.9 5764.7 5014.8 5014.8 5016.3 5023.1 5040.6 5928.2 6037.0 6069.4 6134.5 6141.1 6001.0 6012.9 6014.9 6017.6 6064.6 5925.8 6179.6 6191.8 6197.0 6197.8 5708.5 5837.9 5915.4 5953.4 5983.9 6005.9 6046.5 6055.8 6058.2 6103.0 5546.4 5660.5 5915.3 5916.2 5933.8 5874.6 5949.6 5954.3 5962.3 5966.5 5787.3 5794.1 5795.9 5800.8 5801.7 5666.2 5713.3 5733.6 5900.2 5904.4 5751.7 5787.2 5790.1 5799.8 5810.7 11:33:56 INFO - 2016-02-15 11:33:56,591 DEBUG : BROWSER_OUTPUT: 11:33:56 INFO - 2016-02-15 11:33:56,591 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:62969.27 Median:36099.82 stddev:145455.62 (402.9%) stddev-sans-first:145788.29 11:33:56 INFO - 2016-02-15 11:33:56,591 DEBUG : BROWSER_OUTPUT: Values: 602.7 649.0 649.6 651.6 661.6 31790.0 32360.4 32387.8 32399.4 32425.2 33076.5 43038.0 43115.4 43200.8 43209.6 9259.4 9400.0 9418.3 9426.1 9428.0 7862.7 8008.6 9128.3 9265.4 10985.4 10887.6 10957.1 11003.2 11006.9 11012.7 10892.1 10990.1 10995.6 11002.4 11003.9 10772.4 10862.1 10862.5 10905.2 10909.6 41846.0 41922.6 42141.4 42301.0 42311.8 3541.1 3561.8 3584.2 3692.7 3748.8 32964.7 33298.7 33466.8 33491.2 33558.5 3837.7 3911.5 3981.4 4012.3 4037.9 298251.0 298986.0 299841.0 300980.0 301139.0 57471.0 59006.4 66203.0 66754.0 68239.3 59487.0 59541.4 59818.7 59876.0 59924.4 16113.3 16201.0 16217.3 16228.7 16252.9 11761.9 11786.8 11789.6 11790.5 11795.8 22005.3 22293.7 22312.8 22328.4 22366.0 7671.8 7755.2 7900.9 7969.4 7969.9 1024.8 1069.4 1072.2 1074.0 1110.7 30705.5 31082.1 31440.8 34549.5 36264.6 1087.4 1103.9 1131.8 1150.4 1247.1 13762.6 15209.5 15529.1 15630.8 15968.9 830710.0 844629.0 849863.0 852207.0 853582.0 62879.7 63375.4 63573.0 63580.7 63616.0 1411.0 1440.8 1529.4 1539.8 1582.7 32404.2 32419.0 32452.0 32721.7 33228.3 49519.8 49787.5 50120.2 50150.0 50185.0 229084.0 230761.0 233608.0 253062.0 254346.0 36993.8 37352.4 52659.5 52758.2 52967.0 47328.5 47696.0 48467.5 48576.3 49110.8 40206.8 40781.0 41011.4 41805.4 41813.8 40737.6 41510.2 46453.3 46538.5 48466.3 45547.0 45976.5 45997.0 46375.5 46639.5 35597.1 35935.0 41396.5 41425.8 41444.6 27156.6 27293.6 27327.7 27415.2 27419.5 11:33:56 INFO - 2016-02-15 11:33:56,591 DEBUG : BROWSER_OUTPUT: 11:33:56 INFO - 2016-02-15 11:33:56,591 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31986.64 Median:2519.41 stddev:102954.01 (4086.4%) stddev-sans-first:103215.48 11:33:56 INFO - 2016-02-15 11:33:56,592 DEBUG : BROWSER_OUTPUT: Values: 390.9 394.2 394.3 397.7 399.6 17226.4 18141.8 18439.7 18631.2 18643.2 17377.3 17515.3 17571.6 17939.6 17968.3 5549.4 5696.4 5698.9 5699.8 5722.0 5199.2 5664.0 5686.0 5704.5 5707.7 4239.1 4362.7 6044.7 6311.6 6315.0 6101.1 6133.0 6163.4 6166.1 6171.9 5383.8 5463.7 5466.3 5468.0 5471.6 16653.3 17004.4 19790.1 20904.9 21198.4 2225.2 2356.7 2379.5 2447.2 2591.6 9740.9 9799.7 9847.1 9860.7 10055.1 1946.6 1965.2 1973.6 1997.5 2048.8 62335.6 62750.7 62790.4 62930.4 62954.7 10662.4 10764.5 10793.8 10797.6 10865.3 14225.4 14234.0 14252.3 14279.5 14279.9 8116.2 8163.0 8171.8 8235.0 8244.6 7865.4 7872.5 7872.7 7938.1 7948.9 4487.7 4547.0 4552.3 4596.6 4597.5 1828.7 1833.7 1833.7 1847.1 1860.9 926.4 1018.0 1033.5 1037.0 1125.0 13925.4 17274.6 17335.9 17772.9 18630.0 945.4 975.3 1000.7 1068.8 1083.9 9146.7 9397.5 9410.3 9505.2 9572.3 479802.0 624365.0 631361.0 691990.0 695910.0 86754.1 89333.6 90594.0 92389.5 93049.5 1212.1 1233.7 1238.3 1241.3 1241.5 16120.4 16167.2 16191.3 16241.7 16638.7 37087.4 37344.0 37774.0 38652.4 38734.6 49931.0 50570.7 51969.7 52645.5 55503.7 9725.1 9778.6 9914.4 9917.8 10006.8 11977.9 11999.7 12070.1 12147.9 14261.3 15274.5 15282.6 15462.5 15510.4 15789.4 14373.6 14943.1 14980.8 14999.9 15339.5 15250.9 15318.5 15365.5 15680.8 15828.8 9763.4 9903.2 10020.0 10051.5 10106.7 10358.8 14217.5 14946.3 15015.3 15401.6 11:33:56 INFO - 2016-02-15 11:33:56,592 DEBUG : BROWSER_OUTPUT: 11:33:56 INFO - 2016-02-15 11:33:56,592 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5790.39 Median:6851.42 stddev:3081.01 (45.0%) stddev-sans-first:3072.64 11:33:56 INFO - 2016-02-15 11:33:56,593 DEBUG : BROWSER_OUTPUT: Values: 1482.3 1532.7 1624.0 1714.3 1853.2 8028.5 8291.3 8326.8 8333.3 8346.7 8266.0 8372.5 8386.9 8393.6 8394.1 2344.3 2349.4 2394.1 2396.9 2397.2 2353.1 2378.4 2379.6 2380.2 2381.1 2006.7 2054.7 2264.3 2295.1 2375.8 2328.9 2331.9 2354.3 2354.9 2356.9 2284.8 2310.9 2313.5 2315.1 2315.1 6968.8 7220.2 7764.4 8005.0 8045.6 4901.6 4973.5 4979.3 4979.5 4981.5 3179.7 3204.0 3218.4 3245.8 3249.3 956.8 963.9 968.8 973.0 995.6 11436.2 11487.3 11531.0 11548.0 11569.8 4468.1 4479.7 4544.4 4552.9 4560.4 9876.6 9937.6 9946.8 9955.2 9966.2 4942.2 4962.9 4970.1 4980.5 4994.0 4441.9 4452.1 4469.1 4477.8 4479.3 3702.8 3744.9 3745.0 3770.2 3792.6 1194.6 1198.7 1202.9 1204.8 1208.6 1276.4 1290.1 1304.8 1312.0 1320.3 7634.2 7685.7 7703.9 7704.0 7706.3 482.7 488.6 488.7 489.4 489.9 5314.7 5457.2 6277.7 6343.1 6349.0 9574.8 9628.3 9664.4 9715.8 9810.2 9543.3 9639.7 9692.2 10030.2 10052.2 7818.8 7862.8 7894.4 7923.2 7926.9 7946.1 7975.2 8020.4 8058.3 8072.1 8915.7 8936.6 9057.6 9062.5 9179.4 9031.2 9254.9 9325.8 9327.9 9354.3 7301.8 7313.0 7326.6 7352.2 7422.7 8090.4 8171.2 8178.2 8179.5 8186.3 7558.4 7689.9 7727.4 7782.3 7813.9 7538.3 7599.3 7627.8 7694.7 7719.6 7573.5 7578.0 7584.1 7605.4 7605.6 6703.8 6805.2 6821.6 6849.1 6853.8 7098.4 7130.3 7139.6 7142.2 7160.0 11:33:56 INFO - 2016-02-15 11:33:56,593 DEBUG : BROWSER_OUTPUT: 11:33:56 INFO - 2016-02-15 11:33:56,593 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5377.34 Median:6081.98 stddev:1579.65 (26.0%) stddev-sans-first:1538.30 11:33:56 INFO - 2016-02-15 11:33:56,593 DEBUG : BROWSER_OUTPUT: Values: 347.2 349.6 351.5 354.5 354.8 5842.4 5967.7 6013.6 6013.7 6055.2 5785.4 5913.1 5931.8 5934.3 5937.5 4712.7 4720.1 4722.2 4724.7 4727.3 4434.4 4503.1 4579.5 4677.6 4718.6 4627.8 4670.1 4672.3 4673.0 4685.6 4666.6 4676.8 4677.4 4680.2 4697.2 4170.8 4177.1 4180.1 4183.0 4185.1 5606.9 5685.9 5695.3 5696.1 5700.5 5455.6 5458.4 5465.2 5468.4 5475.0 6007.1 6336.3 6339.5 6340.7 6346.7 4391.3 4480.7 4575.4 4613.1 4619.4 6553.4 6574.9 6605.9 6606.4 6611.0 4714.2 4729.9 4730.8 4734.4 4736.0 4710.1 4771.1 4805.8 4805.9 4810.9 5430.0 5442.7 5442.9 5444.9 5447.6 6379.0 6380.0 6383.9 6387.9 6450.1 1677.0 1698.7 1698.7 1699.1 1702.0 1169.5 1173.3 1173.8 1175.2 1192.3 6135.8 6160.8 6176.6 6177.2 6187.1 6462.5 6464.7 6469.4 6470.4 6474.0 6108.8 6158.5 6158.9 6159.6 6169.5 3495.2 3523.7 3564.3 3574.8 3583.1 6812.4 6824.1 6844.1 6857.5 6868.4 6599.4 6747.7 6752.5 6757.0 6759.0 6839.7 6841.2 6848.8 6859.3 6864.6 6360.7 6468.1 6481.6 6614.2 6619.1 6492.5 6492.5 6497.5 6500.5 6546.0 6805.0 6831.6 6840.7 6842.0 6845.6 4495.6 4621.7 4640.5 4658.9 4663.6 6571.3 6573.2 6574.9 6578.6 6578.8 6412.0 6417.3 6419.8 6423.0 6428.4 6260.4 6388.0 6399.3 6443.6 6451.4 6301.1 6338.2 6342.3 6354.0 6362.8 6492.6 6492.9 6494.9 6497.3 6506.8 6233.8 6349.3 6352.6 6354.4 6358.2 11:33:56 INFO - 2016-02-15 11:33:56,593 DEBUG : BROWSER_OUTPUT: 11:33:56 INFO - 2016-02-15 11:33:56,593 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:15077.32 Median:4651.05 stddev:17543.61 (377.2%) stddev-sans-first:17560.61 11:33:56 INFO - 2016-02-15 11:33:56,593 DEBUG : BROWSER_OUTPUT: Values: 919.1 929.9 939.6 951.2 955.2 13706.7 14103.9 14538.0 15234.7 15350.7 13214.9 13275.9 13286.4 13302.9 13311.3 735.0 743.9 895.5 898.1 912.9 897.0 898.2 903.1 905.0 905.8 765.2 943.7 949.9 950.9 954.2 763.5 764.4 764.8 934.5 945.4 705.2 708.7 708.9 709.0 709.2 14472.5 14578.8 14731.4 14747.0 14755.1 12675.4 13256.3 13403.4 13431.2 13437.3 10145.0 10159.7 10396.4 10456.7 10491.4 3706.4 3773.7 3786.6 3799.5 3800.5 47991.0 48654.0 50197.2 50379.0 50504.2 10809.4 10954.1 10984.5 10990.6 11031.6 19671.9 19862.5 19889.7 19929.6 19929.9 8105.9 8138.5 8219.6 8294.3 8360.0 4469.0 4607.9 4614.3 4636.5 4665.6 3210.8 3255.4 3259.4 3265.2 3265.2 577.9 579.0 581.3 588.5 591.8 514.0 576.2 576.7 600.9 693.5 8909.9 9863.7 9883.4 9987.6 10044.8 531.8 627.9 688.4 692.3 716.4 4150.6 4621.2 4808.6 4809.0 4810.6 59724.0 59947.4 64180.0 64299.0 64603.0 56282.7 56542.2 57296.7 58588.4 58915.7 52820.9 53751.7 53945.7 54315.7 54656.5 9419.9 9514.9 9676.4 9704.2 9733.2 37554.2 37978.8 38085.2 38507.2 38961.2 45015.5 46834.0 50595.0 50976.2 51029.2 12085.6 12275.8 12317.9 12773.2 12850.8 12085.5 12248.9 12668.7 12992.8 13223.7 12042.9 12179.3 12392.9 12612.4 12665.9 12582.7 12965.2 13067.6 13197.7 13240.4 12434.6 12680.6 12984.0 13267.8 13294.3 10412.0 10418.4 10608.9 11285.3 11357.8 9624.6 9809.5 10461.9 10483.9 10699.6 11:33:56 INFO - 2016-02-15 11:33:56,593 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:33:56 INFO - 2016-02-15 11:33:56,593 DEBUG : BROWSER_OUTPUT: 11:33:57 INFO - 2016-02-15 11:33:57,182 INFO : Browser exited with error code: 0 11:33:57 INFO - 2016-02-15 11:33:57,203 INFO : Completed test dromaeo_css (00:18:30) 11:33:57 INFO - 2016-02-15 11:33:57,203 INFO : Starting test kraken 11:33:57 INFO - 2016-02-15 11:33:57,203 DEBUG : operating with platform_type : linux_ 11:33:57 INFO - 2016-02-15 11:33:57,203 INFO : Initialising browser for kraken test... 11:33:57 INFO - 2016-02-15 11:33:57,209 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_pRIk5/profile http://localhost:43665/getInfo.html 11:34:01 INFO - 2016-02-15 11:34:01,014 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:34:01 INFO - 2016-02-15 11:34:01,014 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:34:01 INFO - 2016-02-15 11:34:01,014 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:34:01 INFO - 2016-02-15 11:34:01,014 DEBUG : BROWSER_OUTPUT: __metrics 11:34:01 INFO - 2016-02-15 11:34:01,171 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:34:01 INFO - 2016-02-15 11:34:01,926 INFO : Browser initialized. 11:34:01 INFO - 2016-02-15 11:34:01,926 INFO : Running cycle 1/1 for kraken test... 11:34:01 INFO - 2016-02-15 11:34:01,927 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_pRIk5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:34:13 INFO - 2016-02-15 11:34:13,570 DEBUG : BROWSER_OUTPUT: RSS: Main: 132861952 11:34:13 INFO - 2016-02-15 11:34:13,570 DEBUG : BROWSER_OUTPUT: 11:34:16 INFO - 2016-02-15 11:34:16,026 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43665/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43665/tests/kraken/driver.html?testName=audio-beat-detection) 11:34:16 INFO - 2016-02-15 11:34:16,608 DEBUG : BROWSER_OUTPUT: RSS: Main: 164315136 11:34:16 INFO - 2016-02-15 11:34:16,608 DEBUG : BROWSER_OUTPUT: 11:34:19 INFO - 2016-02-15 11:34:19,166 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43665/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43665/tests/kraken/driver.html?testName=audio-dft) 11:34:19 INFO - 2016-02-15 11:34:19,732 DEBUG : BROWSER_OUTPUT: RSS: Main: 161181696 11:34:19 INFO - 2016-02-15 11:34:19,732 DEBUG : BROWSER_OUTPUT: 11:34:22 INFO - 2016-02-15 11:34:22,516 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43665/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43665/tests/kraken/driver.html?testName=audio-fft) 11:34:23 INFO - 2016-02-15 11:34:23,082 DEBUG : BROWSER_OUTPUT: RSS: Main: 159444992 11:34:23 INFO - 2016-02-15 11:34:23,082 DEBUG : BROWSER_OUTPUT: 11:34:25 INFO - 2016-02-15 11:34:25,055 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43665/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43665/tests/kraken/driver.html?testName=audio-oscillator) 11:34:25 INFO - 2016-02-15 11:34:25,620 DEBUG : BROWSER_OUTPUT: RSS: Main: 159571968 11:34:25 INFO - 2016-02-15 11:34:25,620 DEBUG : BROWSER_OUTPUT: 11:34:27 INFO - 2016-02-15 11:34:27,799 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43665/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43665/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:34:28 INFO - 2016-02-15 11:34:28,369 DEBUG : BROWSER_OUTPUT: RSS: Main: 158769152 11:34:28 INFO - 2016-02-15 11:34:28,369 DEBUG : BROWSER_OUTPUT: 11:34:31 INFO - 2016-02-15 11:34:31,220 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43665/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43665/tests/kraken/driver.html?testName=imaging-darkroom) 11:34:31 INFO - 2016-02-15 11:34:31,787 DEBUG : BROWSER_OUTPUT: RSS: Main: 157331456 11:34:31 INFO - 2016-02-15 11:34:31,787 DEBUG : BROWSER_OUTPUT: 11:34:35 INFO - 2016-02-15 11:34:35,100 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43665/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43665/tests/kraken/driver.html?testName=imaging-desaturate) 11:34:35 INFO - 2016-02-15 11:34:35,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 160030720 11:34:35 INFO - 2016-02-15 11:34:35,667 DEBUG : BROWSER_OUTPUT: 11:34:38 INFO - 2016-02-15 11:34:38,410 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43665/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43665/tests/kraken/driver.html?testName=json-parse-financial) 11:34:38 INFO - 2016-02-15 11:34:38,979 DEBUG : BROWSER_OUTPUT: RSS: Main: 158736384 11:34:38 INFO - 2016-02-15 11:34:38,979 DEBUG : BROWSER_OUTPUT: 11:34:40 INFO - 2016-02-15 11:34:40,536 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43665/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43665/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:34:41 INFO - 2016-02-15 11:34:41,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 163848192 11:34:41 INFO - 2016-02-15 11:34:41,102 DEBUG : BROWSER_OUTPUT: 11:34:42 INFO - 2016-02-15 11:34:42,879 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43665/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43665/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:34:43 INFO - 2016-02-15 11:34:43,480 DEBUG : BROWSER_OUTPUT: RSS: Main: 163020800 11:34:43 INFO - 2016-02-15 11:34:43,480 DEBUG : BROWSER_OUTPUT: 11:34:45 INFO - 2016-02-15 11:34:45,473 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43665/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43665/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:34:46 INFO - 2016-02-15 11:34:46,038 DEBUG : BROWSER_OUTPUT: RSS: Main: 168054784 11:34:46 INFO - 2016-02-15 11:34:46,038 DEBUG : BROWSER_OUTPUT: 11:34:48 INFO - 2016-02-15 11:34:48,394 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43665/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43665/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:34:48 INFO - 2016-02-15 11:34:48,975 DEBUG : BROWSER_OUTPUT: RSS: Main: 177111040 11:34:48 INFO - 2016-02-15 11:34:48,975 DEBUG : BROWSER_OUTPUT: 11:34:51 INFO - 2016-02-15 11:34:51,471 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43665/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43665/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:34:52 INFO - 2016-02-15 11:34:52,034 DEBUG : BROWSER_OUTPUT: RSS: Main: 174518272 11:34:52 INFO - 2016-02-15 11:34:52,035 DEBUG : BROWSER_OUTPUT: 11:34:53 INFO - 2016-02-15 11:34:53,664 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43665/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43665/tests/kraken/driver.html?testName=ai-astar) 11:34:53 INFO - 2016-02-15 11:34:53,908 DEBUG : BROWSER_OUTPUT: RSS: Main: 231976960 11:34:53 INFO - 2016-02-15 11:34:53,909 DEBUG : BROWSER_OUTPUT: 11:34:53 INFO - 2016-02-15 11:34:53,912 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:34:53 INFO - 2016-02-15 11:34:53,912 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:34:53 INFO - 2016-02-15 11:34:53,912 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:34:53 INFO - 2016-02-15 11:34:53,913 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:34:53 INFO - 2016-02-15 11:34:53,913 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;111;105;109;110;109;100;108;109;109 11:34:53 INFO - 2016-02-15 11:34:53,913 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;122;152;151;127;146;156;121;157;122 11:34:53 INFO - 2016-02-15 11:34:53,913 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;159;161;160;160;159;161;160;160 11:34:53 INFO - 2016-02-15 11:34:53,913 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;71;149;71;71;72;72;151;72 11:34:53 INFO - 2016-02-15 11:34:53,913 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;92;141;92;92;93;149;91;92;133 11:34:53 INFO - 2016-02-15 11:34:53,913 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;110;110;110;109;109;109 11:34:53 INFO - 2016-02-15 11:34:53,914 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;145;146;145;146;145;145;146;145 11:34:53 INFO - 2016-02-15 11:34:53,914 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;95;95;96;95;96;95;95 11:34:53 INFO - 2016-02-15 11:34:53,914 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;56;60;57;57;56;58;57;54;56 11:34:53 INFO - 2016-02-15 11:34:53,914 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;65;64;65;65;65;64;64;65;65 11:34:53 INFO - 2016-02-15 11:34:53,914 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;75;76;75;84;77;76;76;77;76;77 11:34:53 INFO - 2016-02-15 11:34:53,914 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;115;122;116;110;112;115;110;116;111 11:34:53 INFO - 2016-02-15 11:34:53,914 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;141;132;136;144;156;138;155;139;128 11:34:53 INFO - 2016-02-15 11:34:53,914 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;63;64;71;63;63;62;62;63;63;62 11:34:53 INFO - 2016-02-15 11:34:53,915 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:34:53 INFO - 2016-02-15 11:34:53,915 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:34:53 INFO - 2016-02-15 11:34:53,915 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,911 11:34:53 INFO - 2016-02-15 11:34:53,915 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:34:53 INFO - 2016-02-15 11:34:53,915 DEBUG : BROWSER_OUTPUT: __startTimestamp1455564893910__endTimestamp 11:34:53 INFO - 2016-02-15 11:34:53,915 DEBUG : BROWSER_OUTPUT: 11:34:53 INFO - 2016-02-15 11:34:53,919 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:34:53 INFO - 2016-02-15 11:34:53,919 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:34:53 INFO - 2016-02-15 11:34:53,919 DEBUG : BROWSER_OUTPUT: 11:34:53 INFO - 2016-02-15 11:34:53,920 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.10 Median:109.00 stddev:3.31 (3.0%) stddev-sans-first:3.35 11:34:53 INFO - 2016-02-15 11:34:53,920 DEBUG : BROWSER_OUTPUT: Values: 111.0 111.0 105.0 109.0 110.0 109.0 100.0 108.0 109.0 109.0 11:34:53 INFO - 2016-02-15 11:34:53,920 DEBUG : BROWSER_OUTPUT: 11:34:53 INFO - 2016-02-15 11:34:53,920 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.40 Median:150.50 stddev:15.36 (10.2%) stddev-sans-first:15.89 11:34:53 INFO - 2016-02-15 11:34:53,920 DEBUG : BROWSER_OUTPUT: Values: 150.0 122.0 152.0 151.0 127.0 146.0 156.0 121.0 157.0 122.0 11:34:53 INFO - 2016-02-15 11:34:53,921 DEBUG : BROWSER_OUTPUT: 11:34:53 INFO - 2016-02-15 11:34:53,921 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 11:34:53 INFO - 2016-02-15 11:34:53,921 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 159.0 161.0 160.0 160.0 159.0 161.0 160.0 160.0 11:34:53 INFO - 2016-02-15 11:34:53,921 DEBUG : BROWSER_OUTPUT: 11:34:53 INFO - 2016-02-15 11:34:53,921 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.20 Median:71.50 stddev:33.11 (46.3%) stddev-sans-first:34.65 11:34:53 INFO - 2016-02-15 11:34:53,921 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 71.0 149.0 71.0 71.0 72.0 72.0 151.0 72.0 11:34:53 INFO - 2016-02-15 11:34:53,922 DEBUG : BROWSER_OUTPUT: 11:34:53 INFO - 2016-02-15 11:34:53,922 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.60 Median:92.00 stddev:24.04 (26.1%) stddev-sans-first:24.83 11:34:53 INFO - 2016-02-15 11:34:53,922 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 141.0 92.0 92.0 93.0 149.0 91.0 92.0 133.0 11:34:53 INFO - 2016-02-15 11:34:53,922 DEBUG : BROWSER_OUTPUT: 11:34:53 INFO - 2016-02-15 11:34:53,922 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 11:34:53 INFO - 2016-02-15 11:34:53,922 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 110.0 110.0 110.0 109.0 109.0 109.0 11:34:53 INFO - 2016-02-15 11:34:53,922 DEBUG : BROWSER_OUTPUT: 11:34:53 INFO - 2016-02-15 11:34:53,922 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:34:53 INFO - 2016-02-15 11:34:53,922 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 145.0 146.0 145.0 146.0 145.0 145.0 146.0 145.0 11:34:53 INFO - 2016-02-15 11:34:53,922 DEBUG : BROWSER_OUTPUT: 11:34:53 INFO - 2016-02-15 11:34:53,922 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 11:34:53 INFO - 2016-02-15 11:34:53,922 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 11:34:53 INFO - 2016-02-15 11:34:53,922 DEBUG : BROWSER_OUTPUT: 11:34:53 INFO - 2016-02-15 11:34:53,922 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.60 Median:57.00 stddev:1.65 (2.9%) stddev-sans-first:1.64 11:34:53 INFO - 2016-02-15 11:34:53,922 DEBUG : BROWSER_OUTPUT: Values: 55.0 56.0 60.0 57.0 57.0 56.0 58.0 57.0 54.0 56.0 11:34:53 INFO - 2016-02-15 11:34:53,923 DEBUG : BROWSER_OUTPUT: 11:34:53 INFO - 2016-02-15 11:34:53,923 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 11:34:53 INFO - 2016-02-15 11:34:53,923 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 64.0 65.0 65.0 65.0 64.0 64.0 65.0 65.0 11:34:53 INFO - 2016-02-15 11:34:53,923 DEBUG : BROWSER_OUTPUT: 11:34:53 INFO - 2016-02-15 11:34:53,923 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:76.50 stddev:2.60 (3.4%) stddev-sans-first:2.67 11:34:53 INFO - 2016-02-15 11:34:53,923 DEBUG : BROWSER_OUTPUT: Values: 75.0 76.0 75.0 84.0 77.0 76.0 76.0 77.0 76.0 77.0 11:34:53 INFO - 2016-02-15 11:34:53,923 DEBUG : BROWSER_OUTPUT: 11:34:53 INFO - 2016-02-15 11:34:53,923 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:114.30 Median:115.50 stddev:3.68 (3.2%) stddev-sans-first:3.86 11:34:53 INFO - 2016-02-15 11:34:53,923 DEBUG : BROWSER_OUTPUT: Values: 116.0 115.0 122.0 116.0 110.0 112.0 115.0 110.0 116.0 111.0 11:34:53 INFO - 2016-02-15 11:34:53,923 DEBUG : BROWSER_OUTPUT: 11:34:53 INFO - 2016-02-15 11:34:53,923 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.20 Median:142.00 stddev:8.95 (6.3%) stddev-sans-first:9.47 11:34:53 INFO - 2016-02-15 11:34:53,923 DEBUG : BROWSER_OUTPUT: Values: 143.0 141.0 132.0 136.0 144.0 156.0 138.0 155.0 139.0 128.0 11:34:53 INFO - 2016-02-15 11:34:53,923 DEBUG : BROWSER_OUTPUT: 11:34:53 INFO - 2016-02-15 11:34:53,923 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.00 stddev:2.67 (4.2%) stddev-sans-first:2.83 11:34:53 INFO - 2016-02-15 11:34:53,923 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 71.0 63.0 63.0 62.0 62.0 63.0 63.0 62.0 11:34:53 INFO - 2016-02-15 11:34:53,923 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:34:53 INFO - 2016-02-15 11:34:53,924 DEBUG : BROWSER_OUTPUT: 11:34:54 INFO - 2016-02-15 11:34:54,566 INFO : Browser exited with error code: 0 11:34:54 INFO - 2016-02-15 11:34:54,619 INFO : Completed test kraken (00:00:57) 11:34:54 INFO - 2016-02-15 11:34:54,619 INFO : Starting test v8_7 11:34:54 INFO - 2016-02-15 11:34:54,619 DEBUG : operating with platform_type : linux_ 11:34:54 INFO - 2016-02-15 11:34:54,619 INFO : Initialising browser for v8_7 test... 11:34:54 INFO - 2016-02-15 11:34:54,625 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBfUAja/profile http://localhost:43665/getInfo.html 11:34:58 INFO - 2016-02-15 11:34:58,108 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:34:58 INFO - 2016-02-15 11:34:58,108 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:34:58 INFO - 2016-02-15 11:34:58,108 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:34:58 INFO - 2016-02-15 11:34:58,109 DEBUG : BROWSER_OUTPUT: __metrics 11:34:58 INFO - 2016-02-15 11:34:58,265 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:34:59 INFO - 2016-02-15 11:34:59,365 INFO : Browser initialized. 11:34:59 INFO - 2016-02-15 11:34:59,366 INFO : Running cycle 1/1 for v8_7 test... 11:34:59 INFO - 2016-02-15 11:34:59,366 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBfUAja/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:35:11 INFO - 2016-02-15 11:35:11,034 DEBUG : BROWSER_OUTPUT: RSS: Main: 134774784 11:35:11 INFO - 2016-02-15 11:35:11,035 DEBUG : BROWSER_OUTPUT: 11:35:32 INFO - 2016-02-15 11:35:32,413 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43665/tests/v8_7/run.html (next: http://localhost:43665/tests/v8_7/run.html) 11:35:32 INFO - 2016-02-15 11:35:32,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 424681472 11:35:32 INFO - 2016-02-15 11:35:32,664 DEBUG : BROWSER_OUTPUT: 11:35:32 INFO - 2016-02-15 11:35:32,665 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:35:32 INFO - 2016-02-15 11:35:32,665 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:35:32 INFO - 2016-02-15 11:35:32,665 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:35:32 INFO - 2016-02-15 11:35:32,665 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:35:32 INFO - 2016-02-15 11:35:32,665 DEBUG : BROWSER_OUTPUT: |0;Richards;171.35023989033584 11:35:32 INFO - 2016-02-15 11:35:32,666 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.63615409944023 11:35:32 INFO - 2016-02-15 11:35:32,666 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.31895352073474 11:35:32 INFO - 2016-02-15 11:35:32,666 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5148.717948717948 11:35:32 INFO - 2016-02-15 11:35:32,666 DEBUG : BROWSER_OUTPUT: |4;RayTrace;936.3295880149813 11:35:32 INFO - 2016-02-15 11:35:32,666 DEBUG : BROWSER_OUTPUT: |5;Earley;543.4782608695652 11:35:32 INFO - 2016-02-15 11:35:32,666 DEBUG : BROWSER_OUTPUT: |6;Boyer;10443.298969072164 11:35:32 INFO - 2016-02-15 11:35:32,666 DEBUG : BROWSER_OUTPUT: |7;RegExp;24166.666666666668 11:35:32 INFO - 2016-02-15 11:35:32,667 DEBUG : BROWSER_OUTPUT: |8;Splay;517.8663904712585 11:35:32 INFO - 2016-02-15 11:35:32,667 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 11:35:32 INFO - 2016-02-15 11:35:32,667 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:35:32 INFO - 2016-02-15 11:35:32,667 DEBUG : BROWSER_OUTPUT: __startTimestamp1455564932664__endTimestamp 11:35:32 INFO - 2016-02-15 11:35:32,667 DEBUG : BROWSER_OUTPUT: 11:35:32 INFO - 2016-02-15 11:35:32,667 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:35:32 INFO - 2016-02-15 11:35:32,668 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:35:32 INFO - 2016-02-15 11:35:32,668 DEBUG : BROWSER_OUTPUT: 11:35:32 INFO - 2016-02-15 11:35:32,668 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:171.35 Median:171.35 stddev:0.00 (0.0%) 11:35:32 INFO - 2016-02-15 11:35:32,668 DEBUG : BROWSER_OUTPUT: Values: 171.4 11:35:32 INFO - 2016-02-15 11:35:32,668 DEBUG : BROWSER_OUTPUT: 11:35:32 INFO - 2016-02-15 11:35:32,669 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.64 Median:164.64 stddev:0.00 (0.0%) 11:35:32 INFO - 2016-02-15 11:35:32,669 DEBUG : BROWSER_OUTPUT: Values: 164.6 11:35:32 INFO - 2016-02-15 11:35:32,669 DEBUG : BROWSER_OUTPUT: 11:35:32 INFO - 2016-02-15 11:35:32,669 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 11:35:32 INFO - 2016-02-15 11:35:32,669 DEBUG : BROWSER_OUTPUT: Values: 278.3 11:35:32 INFO - 2016-02-15 11:35:32,669 DEBUG : BROWSER_OUTPUT: 11:35:32 INFO - 2016-02-15 11:35:32,669 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5148.72 Median:5148.72 stddev:0.00 (0.0%) 11:35:32 INFO - 2016-02-15 11:35:32,671 DEBUG : BROWSER_OUTPUT: Values: 5148.7 11:35:32 INFO - 2016-02-15 11:35:32,671 DEBUG : BROWSER_OUTPUT: 11:35:32 INFO - 2016-02-15 11:35:32,671 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:936.33 Median:936.33 stddev:0.00 (0.0%) 11:35:32 INFO - 2016-02-15 11:35:32,671 DEBUG : BROWSER_OUTPUT: Values: 936.3 11:35:32 INFO - 2016-02-15 11:35:32,671 DEBUG : BROWSER_OUTPUT: 11:35:32 INFO - 2016-02-15 11:35:32,671 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:543.48 Median:543.48 stddev:0.00 (0.0%) 11:35:32 INFO - 2016-02-15 11:35:32,671 DEBUG : BROWSER_OUTPUT: Values: 543.5 11:35:32 INFO - 2016-02-15 11:35:32,672 DEBUG : BROWSER_OUTPUT: 11:35:32 INFO - 2016-02-15 11:35:32,672 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10443.30 Median:10443.30 stddev:0.00 (0.0%) 11:35:32 INFO - 2016-02-15 11:35:32,672 DEBUG : BROWSER_OUTPUT: Values: 10443.3 11:35:32 INFO - 2016-02-15 11:35:32,672 DEBUG : BROWSER_OUTPUT: 11:35:32 INFO - 2016-02-15 11:35:32,672 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24166.67 Median:24166.67 stddev:0.00 (0.0%) 11:35:32 INFO - 2016-02-15 11:35:32,672 DEBUG : BROWSER_OUTPUT: Values: 24166.7 11:35:32 INFO - 2016-02-15 11:35:32,672 DEBUG : BROWSER_OUTPUT: 11:35:32 INFO - 2016-02-15 11:35:32,672 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:517.87 Median:517.87 stddev:0.00 (0.0%) 11:35:32 INFO - 2016-02-15 11:35:32,673 DEBUG : BROWSER_OUTPUT: Values: 517.9 11:35:32 INFO - 2016-02-15 11:35:32,673 DEBUG : BROWSER_OUTPUT: 11:35:32 INFO - 2016-02-15 11:35:32,673 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 11:35:32 INFO - 2016-02-15 11:35:32,673 DEBUG : BROWSER_OUTPUT: Values: 4826.9 11:35:32 INFO - 2016-02-15 11:35:32,673 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:35:32 INFO - 2016-02-15 11:35:32,673 DEBUG : BROWSER_OUTPUT: 11:35:33 INFO - 2016-02-15 11:35:33,358 INFO : Browser exited with error code: 0 11:35:33 INFO - 2016-02-15 11:35:33,370 INFO : Completed test v8_7 (00:00:38) 11:35:33 INFO - 2016-02-15 11:35:33,701 INFO : Completed test suite (00:20:06) 11:35:33 INFO - 2016-02-15 11:35:33,702 DEBUG : Working with test: dromaeo_css 11:35:33 INFO - 2016-02-15 11:35:33,702 DEBUG : Generating results file: dromaeo_css 11:35:33 INFO - 2016-02-15 11:35:33,703 DEBUG : Working with test: kraken 11:35:33 INFO - 2016-02-15 11:35:33,703 DEBUG : Generating results file: kraken 11:35:33 INFO - 2016-02-15 11:35:33,703 INFO : javascript benchmark 11:35:33 INFO - 2016-02-15 11:35:33,703 DEBUG : Working with test: v8_7 11:35:33 INFO - 2016-02-15 11:35:33,703 DEBUG : Generating results file: v8_7 11:35:33 INFO - 2016-02-15 11:35:33,704 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:35:33 INFO - 2016-02-15 11:35:33,769 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 11:35:33 INFO - 2016-02-15 11:35:33,769 DEBUG : process_Request line: dromaeo_css 7397.27 graph.html#tests=[[72,53,35]] 11:35:33 INFO - 2016-02-15 11:35:33,769 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:35:33 INFO - 2016-02-15 11:35:33,811 DEBUG : process_Request line: kraken 1469.80 graph.html#tests=[[232,53,35]] 11:35:33 INFO - 2016-02-15 11:35:33,811 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:35:33 INFO - 2016-02-15 11:35:33,841 DEBUG : process_Request line: v8_7 23338.21 graph.html#tests=[[230,53,35]] 11:35:33 INFO - 2016-02-15 11:35:33,842 INFO : javascript benchmark 11:35:33 INFO - 2016-02-15 11:35:33,845 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3239.546463495111, 3328.5007248912675, 3354.8322583870818, 3357.429237029706, 3379.0, 5451.318585176853, 5509.614326997112, 5531.91702124468, 5535.833924982247, 5607.7476513556885, 5563.36021357544, 5570.554355651539, 5609.719514024303, 5612.607117501777, 5617.578681598876, 4874.805007799684, 5082.517160869711, 5116.513931176532, 5162.483751624826, 5205.37535495741, 5017.448080711137, 5077.949220507785, 5079.746012699368, 5079.974600127012, 5083.517065878736, 5011.473795251501, 5024.547790698836, 5089.185730283156, 5095.184770436731, 5097.872553186182, 5026.4219614744225, 5109.335786347751, 5115.641905066628, 5143.04853602081, 5157.948420515821, 5058.822941197077, 5129.717865517395, 5131.948680513222, 5138.5445602716, 5175.223716442564, 5264.657797243205, 5341.946580534222, 5365.114756065244, 5464.6994415307145, 5476.151196564539, 5995.550333724988, 6003.7898673546215, 6009.278886533644, 6015.27816661999, 6027.547933904974, 6027.698615069273, 6042.274927008787, 6045.72794224261, 6048.1834952281315, 6050.878982420371, 5429.077056900336, 5518.365387980353, 5522.723863806794, 5625.578081643852, 5631.577631677641, 6069.439175834017, 6203.193584833943, 6206.441420272197, 6210.4100110489435, 6214.316425193225, 5961.254843144607, 5972.432618901197, 5974.103884417372, 5974.462298393166, 6018.638881667114, 5793.913091303634, 5930.7924222652, 6044.0, 6047.969760151171, 6068.605540639845, 5804.21643078179, 5875.882482350415, 5879.118132280192, 5880.26496687914, 5909.084091965752, 5873.177755114288, 5911.349751527328, 5932.673702946293, 5936.376680448577, 5947.851303717355, 4430.867073987721, 4498.21281275782, 4530.750808705553, 4551.294549344857, 4587.243104887656, 4085.428040074392, 4090.9590904091174, 4102.50769907613, 4107.116969851496, 4132.483439570054, 5717.142428635738, 5717.571182161355, 5718.68547229898, 5721.0, 5721.084626459747, 5640.520555752807, 5741.799037033684, 5843.0, 5961.582689211714, 5975.462208401264, 5713.342965558931, 5716.514096301861, 5734.856628584235, 5737.85655358611, 5764.654120752768, 5014.824481143215, 5014.84955451337, 5016.347874776328, 5023.095842748267, 5040.647154699209, 5928.170056192136, 6037.0, 6069.423404776539, 6134.478569321568, 6141.109539116893, 6000.969995149996, 6012.8797424052145, 6014.939850601438, 6017.608855424383, 6064.636121832704, 5925.792597259076, 6179.62922224668, 6191.84520386994, 6196.969015155076, 6197.81406557804, 5708.457696518824, 5837.94162058374, 5915.40845915405, 5953.434423729739, 5983.880322393615, 6005.87988240224, 6046.486048685911, 6055.848603784941, 6058.151858739868, 6103.0, 5546.4453554645825, 5660.490555849993, 5915.260592425947, 5916.171735957056, 5933.821985340447, 5874.647521148745, 5949.6430214187285, 5954.345022047658, 5962.344142144274, 5966.492848107786, 5787.334456537552, 5794.101914203306, 5795.8551036224435, 5800.76796928135, 5801.738921748447, 5666.17840413146, 5713.285839270091, 5733.598648094593, 5900.232969713909, 5904.409559044061, 5751.712414379181, 5787.247657804459, 5790.10253410722, 5799.768009279582, 5810.73851676684], "unit": "ms", "name": "dojo.html", "value": 5504.913820406948}, {"lowerIsBetter": false, "replicates": [602.7347966894566, 649.0, 649.629711064693, 651.6057785040051, 661.6195687479699, 31790.0, 32360.352792944126, 32387.83806080972, 32399.352012959756, 32425.189370265754, 33076.503852442234, 43038.0, 43115.35326970098, 43200.783996079976, 43209.567904320946, 9259.351845370828, 9399.95300023499, 9418.340716149873, 9426.104520070583, 9428.0, 7862.724804631839, 8008.599570021504, 9128.315376346767, 9265.444073355586, 10985.395803230818, 10887.618933337335, 10957.06864916483, 11003.22977391583, 11006.889931100666, 11012.724681882977, 10892.128629709605, 10990.120790336754, 10995.615153469591, 11002.394868282241, 11003.889961100367, 10772.35365878042, 10862.131029517619, 10862.45687715611, 10905.18211134168, 10909.618163364323, 41846.0, 41922.580774192174, 42141.36787948183, 42301.0, 42311.788441057906, 3541.11472131967, 3561.7684850484893, 3584.193556449778, 3692.7230457715777, 3748.7938163401004, 32964.6703532964, 33298.66701333004, 33466.83266583652, 33491.162720932174, 33558.49662255068, 3837.6546110849877, 3911.5110611173604, 3981.41540365604, 4012.29784787661, 4037.9394309085387, 298251.0, 298986.0, 299841.0, 300980.0, 301139.0, 57471.0, 59006.40993590009, 66203.0, 66754.0, 68239.31760682429, 59487.0, 59541.40458595445, 59818.700906495185, 59876.0, 59924.400755992756, 16113.27490262941, 16201.027938323738, 16217.270222840001, 16228.675426491403, 16252.918735406247, 11761.941190293994, 11786.764264714659, 11789.646310610695, 11790.469428875722, 11795.764084718428, 22005.33983980483, 22293.66559501609, 22312.776872231396, 22328.441788955082, 22366.0, 7671.808204794925, 7755.2244775521995, 7900.920990790019, 7969.362451003905, 7969.920300797034, 1024.8155332040305, 1069.417167643636, 1072.1637123044038, 1073.9624113156158, 1110.74452875839, 30705.539416908763, 31082.067537973897, 31440.842795785873, 34549.481757773654, 36264.63735362612, 1087.4019289390803, 1103.9116870650328, 1131.8415421840948, 1150.4362862197463, 1247.089624574066, 13762.587122386145, 15209.543713688607, 15529.145896975775, 15630.843691563166, 15968.920155399148, 830710.0, 844629.0, 849863.0, 852207.0, 853582.0, 62879.6856015717, 63375.36624633787, 63573.0, 63580.68209659015, 63616.0, 1410.9717805644034, 1440.7694768836936, 1529.4341093795367, 1539.8229203641501, 1582.6518166003461, 32404.189895251864, 32419.027429177164, 32452.0, 32721.672783271864, 33228.33543329168, 49519.75240123776, 49787.502124979736, 50120.248196276356, 50150.0, 50185.0, 229084.0, 230761.0, 233608.0, 253062.0, 254346.0, 36993.81503092467, 37352.43971340486, 52659.47340526546, 52758.20862686986, 52967.0, 47328.52671473379, 47696.0, 48467.5153248463, 48576.271355930396, 49110.75444622754, 40206.798966004986, 40781.0, 41011.384829228184, 41805.37291940562, 41813.79093104515, 40737.59262407457, 41510.1697966045, 46453.303200451344, 46538.53461465342, 48466.27300590424, 45547.0, 45976.540234597225, 45997.0, 46375.53624463847, 46639.53360466487, 35597.110072248404, 35935.0, 41396.474042134505, 41425.792871036654, 41444.585554144076, 27156.592651109855, 27293.590596140675, 27327.726722733314, 27415.17754467369, 27419.451610968066], "unit": "ms", "name": "ext.html", "value": 20808.84870029782}, {"lowerIsBetter": false, "replicates": [390.9413587961805, 394.2430533375918, 394.26272869733594, 397.6520544523542, 399.6323382488111, 17226.397076102337, 18141.81858181418, 18439.72340414895, 18631.1615977281, 18643.1610577524, 17377.30490780367, 17515.299388024494, 17571.56071098223, 17939.641207175882, 17968.281268749233, 5549.417311182328, 5696.430356964291, 5698.914516282259, 5699.829005129832, 5722.0, 5199.194124910645, 5663.971680141593, 5685.971570142144, 5704.48659620634, 5707.74315155819, 4239.0674051708575, 4362.650987920974, 6044.667543285118, 6311.621302721851, 6314.968425157867, 6101.054336577838, 6132.969335153341, 6163.414475624831, 6166.075088736703, 6171.938280617203, 5383.838484845461, 5463.699496527689, 5466.316710411199, 5468.0, 5471.616986810925, 16653.250603722863, 17004.404845830337, 19790.10944507486, 20904.895475522524, 21198.3640490784, 2225.187806450634, 2356.658284548731, 2379.4765151666606, 2447.229122826304, 2591.585346344576, 9740.90259097407, 9799.657012004616, 9847.064528869745, 9860.65487707934, 10055.145312648434, 1946.5814849807218, 1965.2237366240256, 1973.6447439460892, 1997.5405656698895, 2048.774634790172, 62335.571543565085, 62750.686246568475, 62790.37209627937, 62930.370696292906, 62954.68522657403, 10662.360258384522, 10764.515596798006, 10793.78412431747, 10797.622083227207, 10865.293755905841, 14225.359858806378, 14234.0, 14252.287385630678, 14279.500217492337, 14279.92860035714, 8116.188381161836, 8162.959185204036, 8171.836563268701, 8234.958825205835, 8244.628991695388, 7865.410094242955, 7872.488288261359, 7872.685092596232, 7938.087119981161, 7948.880766788503, 4487.730736155841, 4546.977265113654, 4552.339910712994, 4596.563326483979, 4597.4712908015335, 1828.698264786322, 1833.669939410892, 1833.724941258822, 1847.1226167570564, 1860.9162587683586, 926.4348747264163, 1018.032868774667, 1033.4625994482976, 1037.0407373179778, 1125.0380924309761, 13925.442982280596, 17274.568135796704, 17335.913320433316, 17772.911135444498, 18630.0, 945.432740355781, 975.2880397310004, 1000.7047920863363, 1068.7648717282186, 1083.8916108389099, 9146.679866204651, 9397.483138427315, 9410.341276110743, 9505.192058674951, 9572.282078844115, 479802.0, 624365.0, 631361.0, 691990.0, 695910.0, 86754.1324586746, 89333.55333223422, 90594.0, 92389.5380523093, 93049.53475232716, 1212.1454374665839, 1233.6730766346925, 1238.2508582307755, 1241.3482921466302, 1241.4909886946489, 16120.355185792438, 16167.191640418167, 16191.271392787588, 16241.67516649684, 16638.66722665564, 37087.443688345236, 37344.0, 37774.0, 38652.420213696256, 38734.612653873104, 49931.0, 50570.74714626403, 51969.740151299, 52645.47354526406, 55503.72248138733, 9725.0761177688, 9778.60885564598, 9914.355566888129, 9917.752056198653, 10006.849212340383, 11977.880221198026, 11999.700007499534, 12070.094742894142, 12147.878521214674, 14261.286935653383, 15274.541763747106, 15282.617934551281, 15462.458813941457, 15510.379584816481, 15789.368425262861, 14373.64065898361, 14943.103413795207, 14980.775288370465, 14999.925000374928, 15339.463118791235, 15250.923745381202, 15318.463853765064, 15365.539033829004, 15680.76478852841, 15828.841711582736, 9763.365381250196, 9903.207743380657, 10020.0, 10051.497425128568, 10106.696799096038, 10358.792824143626, 14217.50238741639, 14946.252687365806, 15015.324310406277, 15401.614959626098], "unit": "ms", "name": "jquery.html", "value": 9322.51656773114}, {"lowerIsBetter": false, "replicates": [1482.3255418784452, 1532.731771939911, 1623.9525506048592, 1714.2628669672035, 1853.240171529673, 8028.518288902663, 8291.295239904615, 8326.83346333073, 8333.333333333334, 8346.707865224718, 8266.049404318504, 8372.53951032693, 8386.87419688705, 8393.622286997084, 8394.076651568323, 2344.296710986706, 2349.4126468382906, 2394.0663141374876, 2396.940076498084, 2397.2328854766483, 2353.0587764894094, 2378.4291769975252, 2379.583572874749, 2380.2026321182425, 2381.1308872261675, 2006.678931370981, 2054.6917962305697, 2264.2527965771255, 2295.070496448941, 2375.8455700379504, 2328.871912044837, 2331.8717470539113, 2354.3407845803204, 2354.8704821234824, 2356.9175078872245, 2284.7601001894727, 2310.8844557772045, 2313.456337760625, 2315.085541211229, 2315.120254303354, 6968.756093536753, 7220.169680486759, 7764.3788496920115, 8004.959975200087, 8045.5977201140295, 4901.632377571696, 4973.502649735034, 4979.327790748239, 4979.45226025137, 4981.476944920767, 3179.72972297355, 3203.983980080108, 3218.3563287342627, 3245.789023713451, 3249.333886553251, 956.7942892278194, 963.8554216867456, 968.8062387522453, 973.0123924216925, 995.6017592962801, 11436.19946603738, 11487.25332853362, 11531.019863311629, 11548.018418434443, 11569.826452603218, 4468.084042771224, 4479.731216127043, 4544.431946006749, 4552.88617784558, 4560.4071470708595, 9876.555555000043, 9937.552810123561, 9946.80106397868, 9955.203583713286, 9966.152877005536, 4942.159832828428, 4962.851114466572, 4970.105381031449, 4980.501949805063, 4994.0, 4441.866743997685, 4452.065066336106, 4469.08383781324, 4477.820887164542, 4479.30570761526, 3702.8148592570265, 3744.9063773405883, 3745.0, 3770.170562476306, 3792.6017768133947, 1194.6296648039136, 1198.7362780188344, 1202.855657321127, 1204.8493938257718, 1208.5528354508713, 1276.380955236728, 1290.077594519904, 1304.7586196553668, 1312.0028778128692, 1320.3398300849576, 7634.160242373335, 7685.730999414994, 7703.922960770433, 7704.0, 7706.267904549059, 482.7151980331551, 488.6213184781823, 488.7458521568764, 489.3980404102902, 489.9436564795094, 5314.681119132864, 5457.181422786613, 6277.748890044347, 6343.143675603735, 6348.968255158695, 9574.760630984281, 9628.32601717887, 9664.420134791935, 9715.805683886425, 9810.166135878388, 9543.284253681002, 9639.71080867575, 9692.22462203022, 10030.197584193247, 10052.246081543768, 7818.843623127505, 7862.764117076496, 7894.368450523944, 7923.20767923203, 7926.920730792734, 7946.086200087064, 7975.242351976785, 8020.358371330396, 8058.3150432213915, 8072.112067672434, 8915.687950921687, 8936.597853096497, 9057.637694492147, 9062.456252624863, 9179.449233046038, 9031.232345250464, 9254.907450925404, 9325.766855828659, 9327.906720932704, 9354.298427618092, 7301.780946571611, 7313.0, 7326.560406375635, 7352.191258961617, 7422.7402040930465, 8090.393220508367, 8171.182881711781, 8178.182181782012, 8179.509229446252, 8186.345092392713, 7558.433117516099, 7689.88465173034, 7727.42044346665, 7782.299593036654, 7813.921860781319, 7538.283863033003, 7599.316061554266, 7627.771166865003, 7694.692212311669, 7719.614019299125, 7573.46985710995, 7578.0, 7584.08990921093, 7605.353544948742, 7605.581693006938, 6703.765368212089, 6805.183377994672, 6821.590704557742, 6849.075374824335, 6853.760118396031, 7098.432125430057, 7130.322619351154, 7139.643017848983, 7142.214356420894, 7160.033395491542], "unit": "ms", "name": "mootools.html", "value": 4625.520492451491}, {"lowerIsBetter": false, "replicates": [347.1546783581978, 349.6136768870399, 351.4657720265195, 354.5178557162259, 354.8367750834616, 5842.386549412315, 5967.671778052206, 6013.609115407496, 6013.729382177801, 6055.182550355707, 5785.392533783945, 5913.113033045045, 5931.792387266436, 5934.258217722785, 5937.4656280934705, 4712.717236965776, 4720.126776546333, 4722.220833562458, 4724.716517008973, 4727.314539391786, 4434.379186913835, 4503.054358584701, 4579.496255411902, 4677.602403795681, 4718.551737584941, 4627.791749371287, 4670.136024835399, 4672.299155126741, 4672.97663511682, 4685.601723853477, 4666.556677115668, 4676.812927482896, 4677.438707355105, 4680.227762419197, 4697.177993851063, 4170.77060761658, 4177.122804211089, 4180.059486615518, 4183.0, 4185.100203456241, 5606.859828504279, 5685.886282274373, 5695.34503532095, 5696.11710184922, 5700.543956483513, 5455.645383050089, 5458.399576046631, 5465.234867118606, 5468.425815289377, 5474.972625136849, 6007.128966299906, 6336.271328797156, 6339.461145802612, 6340.651264180468, 6346.746130154788, 4391.341298805173, 4480.686351955364, 4575.382323386333, 4613.146567884952, 4619.3763841881255, 6553.377429144223, 6574.868502629921, 6605.867882642368, 6606.438452731523, 6611.049740326615, 4714.245720684674, 4729.905401891943, 4730.787114579852, 4734.360861283752, 4735.95264047362, 4710.128626204163, 4771.117343291502, 4805.831795887128, 4805.879853003703, 4810.855674329776, 5429.995450841607, 5442.673439593637, 5442.91835622466, 5444.891102178013, 5447.6459030163705, 6379.0, 6380.0, 6383.914734495054, 6387.872242555216, 6450.096986421905, 1676.9748453773202, 1698.651776385838, 1698.736695812151, 1699.065513967313, 1702.0213377308098, 1169.4678921091054, 1173.3253379306932, 1173.8473998380157, 1175.2419689300352, 1192.3442106841203, 6135.785247516315, 6160.845978850564, 6176.598521096204, 6177.227846519185, 6187.102870083812, 6462.48300135988, 6464.741410343628, 6469.417752402306, 6470.417662410406, 6473.96416573346, 6108.786192483241, 6158.476529494954, 6158.907616385758, 6159.630422174684, 6169.537284703665, 3495.1961048958883, 3523.6652518010746, 3564.2515071834687, 3574.8391322390034, 3583.086312990171, 6812.352826481477, 6824.112865327475, 6844.1444819397575, 6857.485688573277, 6868.381845633817, 6599.406053455212, 6747.696353664097, 6752.493562982698, 6757.0, 6758.966205168943, 6839.726410943506, 6841.2132604750095, 6848.828779280558, 6859.348361905611, 6864.553804002824, 6360.713767880364, 6468.094466774562, 6481.578697384655, 6614.173228346457, 6619.073329733745, 6492.513061520499, 6492.513061520499, 6497.512686548623, 6500.512461565307, 6545.967270163619, 6805.04729337903, 6831.59010459374, 6840.726370945106, 6841.965790171017, 6845.596652686287, 4495.640348772155, 4621.653375996746, 4640.466346370211, 4658.930116048195, 4663.580277775017, 6571.277159512545, 6573.211214654272, 6574.868502630016, 6578.638174900427, 6578.80263592093, 6411.96794016027, 6417.26201486835, 6419.775307864203, 6423.0, 6428.357164283534, 6260.436560709558, 6388.0, 6399.296077431386, 6443.613383197023, 6451.41937225652, 6301.054841773771, 6338.207724034496, 6342.334054924351, 6354.0, 6362.809115726535, 6492.610443373413, 6492.902606460812, 6494.902576461452, 6497.285298617243, 6506.837329066811, 6233.812985610439, 6349.333320001333, 6352.555321127476, 6354.364563543609, 6358.1734374531015], "unit": "ms", "name": "prototype.html", "value": 4873.310704891505}, {"lowerIsBetter": false, "replicates": [919.099282702951, 929.8605209218621, 939.5631031570318, 951.2247518272605, 955.2453561686264, 13706.725865482696, 14103.858961410395, 14538.0, 15234.695306093872, 15350.692986140299, 13214.93392533036, 13275.867241327584, 13286.402111904963, 13302.933485332584, 13311.334433278322, 734.988975165373, 743.8698227810112, 895.4716717136888, 898.0794685447403, 912.8721978922956, 897.0401670212875, 898.1512470715177, 903.056306160061, 905.004495055437, 905.7554460295717, 765.227120608187, 943.6697155995381, 949.9287553433486, 950.9334346595741, 954.1651055326589, 763.4884627299695, 764.4343186042345, 764.8355603545209, 934.4766930518931, 945.3571571331491, 705.1784670858444, 708.6881772020295, 708.9361957423805, 708.989365159523, 709.170270783185, 14472.493462728859, 14578.781318280235, 14731.410743570244, 14747.0, 14755.11469311834, 12675.366231688378, 13256.270905100215, 13403.396847141901, 13431.194128352232, 13437.260950647711, 10144.970678415137, 10159.746006349826, 10396.376217426978, 10456.738581535446, 10491.42297173655, 3706.3513885070006, 3773.735838491307, 3786.583475817658, 3799.544054713452, 3800.5439347278225, 47991.0, 48654.0, 50197.24704129441, 50378.999999999636, 50504.242436363485, 10809.405482698527, 10954.123670106372, 10984.505697243643, 10990.615328463466, 11031.613893513688, 19671.901640491706, 19862.503437413892, 19889.701654475193, 19929.601407972048, 19929.900350498156, 8105.918940810634, 8138.470999385021, 8219.630116644765, 8294.253517183482, 8360.0, 4468.977655111704, 4607.9308810367875, 4614.307853821953, 4636.536346365337, 4665.5567721066445, 3210.7912985655857, 3255.3652037852867, 3259.3807176636365, 3265.232670322472, 3265.248992731685, 577.8786454844445, 578.988420231593, 581.2995340614549, 588.485075558886, 591.8372447576951, 514.0284861611557, 576.1530550091359, 576.711644177911, 600.8768202518473, 693.4868197533789, 8909.866352004725, 9863.654772083086, 9883.357581757307, 9987.550560224807, 10044.849327260097, 531.7553925194454, 627.9152314437583, 688.3804575881746, 692.3249831414331, 716.3839098375392, 4150.568054021358, 4621.168189725814, 4808.591269742111, 4808.951910480921, 4810.63920205986, 59724.0, 59947.400525994184, 64180.0, 64299.0, 64603.0, 56282.71858640681, 56542.151867722016, 57296.71351643215, 58588.41411585829, 58915.705421473474, 52820.943581128166, 53751.73124134433, 53945.730271348395, 54315.72842135764, 54656.45343546513, 9419.905800941902, 9514.857277140987, 9676.371035882645, 9704.175145112462, 9733.19935811877, 37554.24891502209, 37978.81010594929, 38085.23829523449, 38507.2298554033, 38961.220775583766, 45015.54984450113, 46834.0, 50595.0, 50976.23535646894, 51029.234561480866, 12085.637430877088, 12275.75448491043, 12317.938410307892, 12773.169743966613, 12850.807237891626, 12085.456154473246, 12248.877511224773, 12668.746625067632, 12992.805107923577, 13223.735525289632, 12042.879571204527, 12179.269243845398, 12392.938035309766, 12612.369381530703, 12665.936670316958, 12582.748345033231, 12965.15726477776, 13067.607971760863, 13197.736045279233, 13240.40418181165, 12434.564790232298, 12680.556180533637, 12984.0, 13267.800982985456, 13294.335283235992, 10412.010858968386, 10418.374897506174, 10608.893911061099, 11285.266457680225, 11357.772844542898, 9624.615015399586, 9809.460479673686, 10461.895381046092, 10483.947580262049, 10699.572017119228], "unit": "ms", "name": "yui.html", "value": 6805.689017995997}], "name": "dromaeo_css", "value": 7397.271778117862}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 105.0, 109.0, 110.0, 109.0, 100.0, 108.0, 109.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [150.0, 122.0, 152.0, 151.0, 127.0, 146.0, 156.0, 121.0, 157.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.4}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 159.0, 161.0, 160.0, 160.0, 159.0, 161.0, 160.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.0}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 71.0, 149.0, 71.0, 71.0, 72.0, 72.0, 151.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 87.2}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 141.0, 92.0, 92.0, 93.0, 149.0, 91.0, 92.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 106.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 60.0, 57.0, 57.0, 56.0, 58.0, 57.0, 54.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0, 64.0, 65.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.6}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 75.0, 84.0, 77.0, 76.0, 76.0, 77.0, 76.0, 77.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 76.9}, {"lowerIsBetter": true, "replicates": [116.0, 115.0, 122.0, 116.0, 110.0, 112.0, 115.0, 110.0, 116.0, 111.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 114.3}, {"lowerIsBetter": true, "replicates": [143.0, 141.0, 132.0, 136.0, 144.0, 156.0, 138.0, 155.0, 139.0, 128.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 141.2}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 71.0, 63.0, 63.0, 62.0, 62.0, 63.0, 63.0, 62.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.6}], "name": "kraken", "value": 1469.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [171.35023989033584], "unit": "score", "name": "Richards", "value": 206.02247199999996}, {"lowerIsBetter": false, "replicates": [164.63615409944023], "unit": "score", "name": "DeltaBlue", "value": 401.60073199999994}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5148.717948717948], "unit": "score", "name": "Decrypt", "value": 51.69850099601596}, {"lowerIsBetter": false, "replicates": [936.3295880149813], "unit": "score", "name": "RayTrace", "value": 790.3082519999997}, {"lowerIsBetter": false, "replicates": [543.4782608695652], "unit": "score", "name": "Earley", "value": 1226.2919200000001}, {"lowerIsBetter": false, "replicates": [10443.298969072164], "unit": "score", "name": "Boyer", "value": 63.81728627838104}, {"lowerIsBetter": false, "replicates": [24166.666666666668], "unit": "score", "name": "RegExp", "value": 37.69593103448274}, {"lowerIsBetter": false, "replicates": [517.8663904712585], "unit": "score", "name": "Splay", "value": 157.359121}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 23338.213587222308}]} 11:35:33 INFO - RETURN: dromaeo_css: 7397.27 11:35:33 INFO - RETURN: kraken: 1469.80 11:35:33 INFO - RETURN: v8_7: 23338.21 11:35:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23338.21"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1469.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7397.27"}}} 11:35:33 INFO - Return code: 0 11:35:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:35:33 INFO - # TBPL SUCCESS # 11:35:33 INFO - Running post-action listener: _resource_record_post_action 11:35:33 INFO - Running post-run listener: _resource_record_post_run 11:35:35 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 532480; Write bytes: 510791680; Read time: 124; Write time: 551248 11:35:35 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 244326400; Read time: 0; Write time: 379652 11:35:35 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 532480; Write bytes: 265998336; Read time: 124; Write time: 171568 11:35:35 INFO - Running post-run listener: _upload_blobber_files 11:35:35 INFO - Blob upload gear active. 11:35:35 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:35:35 INFO - Copying logs to upload dir... 11:35:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1258.800323 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-02-15 11:35:34.951485) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-15 11:35:34.955269) ========= 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=652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455555206/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009952 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455555206/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-15 11:35:35.007024) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 11:35:35.007346) ========= 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=652eb03db935cfc1c15ebda0000001ad-1455561377.717179-825895163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-15 11:35:35.056916) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-15 11:35:35.057227) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-15 11:35:35.057539) ========= ========= Total master_lag: 0.93 =========