builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1454348592.39 results: success (0) buildid: 20160201064427 builduid: 4c35f917776a4a00b789785e6d76281f revision: 8b76e1c0b2b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-01 09:43:12.393316) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-01 09:43:12.393820) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-01 09:43:12.394122) ========= 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-1454348372.207926-887817633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006458 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-01 09:43:12.420182) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-01 09:43:12.420458) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-01 09:43:12.433883) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 09:43:12.434148) ========= 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-1454348372.207926-887817633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004641 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 09:43:12.483506) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-01 09:43:12.483874) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-01 09:43:12.484336) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 09:43:12.484824) ========= 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-1454348372.207926-887817633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-01 09:43:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.7M=0s 2016-02-01 09:43:12 (39.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099002 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 09:43:12.595973) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 09:43:12.596246) ========= 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-1454348372.207926-887817633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021344 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 09:43:12.645208) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 09:43:12.645514) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8b76e1c0b2b5 --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 8b76e1c0b2b5 --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-1454348372.207926-887817633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-01 09:43:12,740 Setting DEBUG logging. 2016-02-01 09:43:12,740 attempt 1/10 2016-02-01 09:43:12,740 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/8b76e1c0b2b5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-01 09:43:13,185 unpacking tar archive at: mozilla-beta-8b76e1c0b2b5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.740033 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 09:43:13.398737) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-01 09:43:13.399095) ========= echo 8b76e1c0b2b5 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8b76e1c0b2b5'] 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-1454348372.207926-887817633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 8b76e1c0b2b5 program finished with exit code 0 elapsedTime=0.004038 script_repo_revision: '8b76e1c0b2b5' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-01 09:43:13.450034) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-01 09:43:13.450699) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-01 09:43:13.463309) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 58 secs) (at 2016-02-01 09:43:13.463571) ========= /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-1454348372.207926-887817633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:43:13 INFO - MultiFileLogger online at 20160201 09:43:13 in /builds/slave/test-pgo 09:43:13 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 09:43:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:43:13 INFO - {'append_to_log': False, 09:43:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:43:13 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:43:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:43:13 INFO - 'branch': 'Mozilla-Beta', 09:43:13 INFO - 'buildbot_json_path': 'buildprops.json', 09:43:13 INFO - 'config_files': ('talos/linux_config.py',), 09:43:13 INFO - 'default_actions': ('clobber', 09:43:13 INFO - 'read-buildbot-config', 09:43:13 INFO - 'download-and-extract', 09:43:13 INFO - 'populate-webroot', 09:43:13 INFO - 'create-virtualenv', 09:43:13 INFO - 'install', 09:43:13 INFO - 'run-tests'), 09:43:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:43:13 INFO - 'download_minidump_stackwalk': True, 09:43:13 INFO - 'download_symbols': 'ondemand', 09:43:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:43:13 INFO - 'tooltool.py': '/tools/tooltool.py', 09:43:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:43:13 INFO - '/tools/misc-python/virtualenv.py')}, 09:43:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:43:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:43:13 INFO - 'installer_path': 'installer.exe', 09:43:13 INFO - 'log_level': 'info', 09:43:13 INFO - 'log_name': 'talos', 09:43:13 INFO - 'log_to_console': True, 09:43:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:43:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:43:13 INFO - 'opt_config_files': (), 09:43:13 INFO - 'pip_index': False, 09:43:13 INFO - 'sps_profile': False, 09:43:13 INFO - 'sps_profile_interval': 0, 09:43:13 INFO - 'suite': 'dromaeojs', 09:43:13 INFO - 'system_bits': '32', 09:43:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:43:13 INFO - 'title': 'talos-linux64-ix-046', 09:43:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:43:13 INFO - 'use_talos_json': True, 09:43:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:43:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:43:13 INFO - 'work_dir': 'build'} 09:43:13 INFO - ##### 09:43:13 INFO - ##### Running clobber step. 09:43:13 INFO - ##### 09:43:13 INFO - Running pre-action listener: _resource_record_pre_action 09:43:13 INFO - Running main action method: clobber 09:43:13 INFO - rmtree: /builds/slave/test-pgo/build 09:43:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:43:14 INFO - Running post-action listener: _resource_record_post_action 09:43:14 INFO - ##### 09:43:14 INFO - ##### Running read-buildbot-config step. 09:43:14 INFO - ##### 09:43:14 INFO - Running pre-action listener: _resource_record_pre_action 09:43:14 INFO - Running main action method: read_buildbot_config 09:43:14 INFO - Using buildbot properties: 09:43:14 INFO - { 09:43:14 INFO - "properties": { 09:43:14 INFO - "buildnumber": 97, 09:43:14 INFO - "product": "firefox", 09:43:14 INFO - "script_repo_revision": "production", 09:43:14 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 09:43:14 INFO - "repository": "", 09:43:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 09:43:14 INFO - "buildid": "20160201064427", 09:43:14 INFO - "slavename": "talos-linux64-ix-046", 09:43:14 INFO - "pgo_build": "True", 09:43:14 INFO - "basedir": "/builds/slave/test-pgo", 09:43:14 INFO - "project": "", 09:43:14 INFO - "platform": "ubuntu64_hw", 09:43:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:43:14 INFO - "slavebuilddir": "test", 09:43:14 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:43:14 INFO - "branch": "mozilla-beta", 09:43:14 INFO - "repo_path": "releases/mozilla-beta", 09:43:14 INFO - "stage_platform": "linux64-pgo", 09:43:14 INFO - "builduid": "4c35f917776a4a00b789785e6d76281f", 09:43:14 INFO - "revision": "8b76e1c0b2b5" 09:43:14 INFO - }, 09:43:14 INFO - "sourcestamp": { 09:43:14 INFO - "repository": "", 09:43:14 INFO - "hasPatch": false, 09:43:14 INFO - "project": "", 09:43:14 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 09:43:14 INFO - "changes": [ 09:43:14 INFO - { 09:43:14 INFO - "category": null, 09:43:14 INFO - "files": [ 09:43:14 INFO - { 09:43:14 INFO - "url": null, 09:43:14 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454337867/firefox-45.0.en-US.linux-x86_64.tar.bz2" 09:43:14 INFO - } 09:43:14 INFO - ], 09:43:14 INFO - "repository": "", 09:43:14 INFO - "rev": "8b76e1c0b2b5", 09:43:14 INFO - "who": "sendchange", 09:43:14 INFO - "when": 1454348520, 09:43:14 INFO - "number": 7543939, 09:43:14 INFO - "comments": "Backed out changeset 508f5c34d798 (bug 1059469) for causing and crashtest crashes", 09:43:14 INFO - "project": "", 09:43:14 INFO - "at": "Mon 01 Feb 2016 09:42:00", 09:43:14 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 09:43:14 INFO - "revlink": "", 09:43:14 INFO - "properties": [ 09:43:14 INFO - [ 09:43:14 INFO - "buildid", 09:43:14 INFO - "20160201064427", 09:43:14 INFO - "Change" 09:43:14 INFO - ], 09:43:14 INFO - [ 09:43:14 INFO - "builduid", 09:43:14 INFO - "4c35f917776a4a00b789785e6d76281f", 09:43:14 INFO - "Change" 09:43:14 INFO - ], 09:43:14 INFO - [ 09:43:14 INFO - "pgo_build", 09:43:14 INFO - "True", 09:43:14 INFO - "Change" 09:43:14 INFO - ] 09:43:14 INFO - ], 09:43:14 INFO - "revision": "8b76e1c0b2b5" 09:43:14 INFO - } 09:43:14 INFO - ], 09:43:14 INFO - "revision": "8b76e1c0b2b5" 09:43:14 INFO - } 09:43:14 INFO - } 09:43:14 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454337867/firefox-45.0.en-US.linux-x86_64.tar.bz2. 09:43:14 INFO - Running post-action listener: _resource_record_post_action 09:43:14 INFO - ##### 09:43:14 INFO - ##### Running download-and-extract step. 09:43:14 INFO - ##### 09:43:14 INFO - Running pre-action listener: _resource_record_pre_action 09:43:14 INFO - Running main action method: download_and_extract 09:43:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:14 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454337867/test_packages.json 09:43:14 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454337867/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:43:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454337867/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:43:14 INFO - Downloaded 1270 bytes. 09:43:14 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:43:14 INFO - Using the following test package requirements: 09:43:14 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 09:43:14 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:43:14 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:43:14 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:43:14 INFO - u'jsshell-linux-x86_64.zip'], 09:43:14 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:43:14 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:43:14 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 09:43:14 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:43:14 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 09:43:14 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:43:14 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 09:43:14 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:43:14 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:43:14 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 09:43:14 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:43:14 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:43:14 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:14 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454337867/firefox-45.0.en-US.linux-x86_64.common.tests.zip 09:43:14 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454337867/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 09:43:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454337867/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 09:43:14 INFO - Downloaded 21580637 bytes. 09:43:14 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 09:43:14 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 09:43:14 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 09:43:15 INFO - Return code: 0 09:43:15 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 09:43:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:15 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454337867/firefox-45.0.en-US.linux-x86_64.common.tests.zip 09:43:15 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454337867/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 09:43:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454337867/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 09:43:16 INFO - Downloaded 21580637 bytes. 09:43:16 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 09:43:16 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 09:43:16 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 09:43:17 INFO - Return code: 0 09:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:17 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454337867/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 09:43:17 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454337867/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 09:43:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454337867/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 09:43:22 INFO - Downloaded 11132038 bytes. 09:43:22 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 09:43:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 09:43:22 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 09:43:22 INFO - Return code: 0 09:43:22 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')]} 09:43:22 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454337867/firefox-45.0.en-US.linux-x86_64.tar.bz2 09:43:22 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454337867/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 09:43:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454337867/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 09:43:23 INFO - Downloaded 57943214 bytes. 09:43:23 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454337867/firefox-45.0.en-US.linux-x86_64.tar.bz2 09:43:23 INFO - mkdir: /builds/slave/test-pgo/properties 09:43:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:43:23 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:43:23 INFO - Contents: 09:43:23 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454337867/firefox-45.0.en-US.linux-x86_64.tar.bz2 09:43:23 INFO - Running post-action listener: _resource_record_post_action 09:43:23 INFO - Running post-action listener: set_extra_try_arguments 09:43:23 INFO - ##### 09:43:23 INFO - ##### Running populate-webroot step. 09:43:23 INFO - ##### 09:43:23 INFO - Running pre-action listener: _resource_record_pre_action 09:43:23 INFO - Running main action method: populate_webroot 09:43:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:43:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:43:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:43:23 INFO - '--tppagecycles', 09:43:23 INFO - '7'], 09:43:23 INFO - 'tests': ['tsvgm']}}, 09:43:23 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:43:23 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:43:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:43:23 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:43:23 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:43:23 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:43:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:43:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:23 INFO - 'talos_options': ['--e10s'], 09:43:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:43:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:23 INFO - 'tests': ['damp', 'tps']}, 09:43:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:23 INFO - 'talos_options': ['--e10s'], 09:43:23 INFO - 'tests': ['damp', 'tps']}, 09:43:23 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:43:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:43:23 INFO - 'other': {'tests': ['a11yr', 09:43:23 INFO - 'ts_paint', 09:43:23 INFO - 'tpaint', 09:43:23 INFO - 'sessionrestore', 09:43:23 INFO - 'sessionrestore_no_auto_restore']}, 09:43:23 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:43:23 INFO - 'tests': ['a11yr', 09:43:23 INFO - 'ts_paint', 09:43:23 INFO - 'tpaint', 09:43:23 INFO - 'sessionrestore', 09:43:23 INFO - 'sessionrestore_no_auto_restore']}, 09:43:23 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:43:23 INFO - 'tests': ['a11yr', 09:43:23 INFO - 'ts_paint', 09:43:23 INFO - 'tpaint', 09:43:23 INFO - 'sessionrestore', 09:43:23 INFO - 'sessionrestore_no_auto_restore']}, 09:43:23 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:43:23 INFO - 'tests': ['a11yr', 09:43:23 INFO - 'ts_paint', 09:43:23 INFO - 'tpaint', 09:43:23 INFO - 'sessionrestore', 09:43:23 INFO - 'sessionrestore_no_auto_restore']}, 09:43:23 INFO - 'other_l64': {'tests': ['a11yr', 09:43:23 INFO - 'ts_paint', 09:43:23 INFO - 'tpaint', 09:43:23 INFO - 'sessionrestore', 09:43:23 INFO - 'sessionrestore_no_auto_restore']}, 09:43:23 INFO - 'other_nol64': {'tests': ['a11yr', 09:43:23 INFO - 'ts_paint', 09:43:23 INFO - 'tpaint', 09:43:23 INFO - 'sessionrestore', 09:43:23 INFO - 'sessionrestore_no_auto_restore']}, 09:43:23 INFO - 'svgr': {'tests': ['tsvgx', 09:43:23 INFO - 'tsvgr_opacity', 09:43:23 INFO - 'tart', 09:43:23 INFO - 'tscrollx', 09:43:23 INFO - 'cart']}, 09:43:23 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:43:23 INFO - 'tests': ['tsvgx', 09:43:23 INFO - 'tsvgr_opacity', 09:43:23 INFO - 'tart', 09:43:23 INFO - 'tscrollx', 09:43:23 INFO - 'cart']}, 09:43:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:23 INFO - 'tests': ['tp5o']}, 09:43:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:23 INFO - 'talos_options': ['--e10s'], 09:43:23 INFO - 'tests': ['tp5o']}, 09:43:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:23 INFO - 'talos_options': ['--xperf_path', 09:43:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:43:23 INFO - 'tests': ['tp5n']}, 09:43:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:43:23 INFO - 'talos_options': ['--e10s', 09:43:23 INFO - '--xperf_path', 09:43:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:43:23 INFO - 'tests': ['tp5n']}}, 09:43:23 INFO - 'talos.zip': {'path': '', 09:43:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:43:23 INFO - Running post-action listener: _resource_record_post_action 09:43:23 INFO - ##### 09:43:23 INFO - ##### Running create-virtualenv step. 09:43:23 INFO - ##### 09:43:23 INFO - Running pre-action listener: _resource_record_pre_action 09:43:23 INFO - Running main action method: create_virtualenv 09:43:23 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:43:23 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 09:43:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:43:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:43:23 INFO - Using real prefix '/usr' 09:43:23 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:43:24 INFO - Installing distribute.............................................................................................................................................................................................done. 09:43:26 INFO - Installing pip.................done. 09:43:26 INFO - Return code: 0 09:43:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:43:26 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')]} 09:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:26 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')]} 09:43:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:26 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 0x7f132ebbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2163350>, '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 0x2164250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21646e0>, '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-1454348372.207926-887817633', '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 09:43:26 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 09:43:26 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 09:43:26 INFO - Using env: {'DISPLAY': ':0', 09:43:26 INFO - 'HOME': '/home/cltbld', 09:43:26 INFO - 'LANG': 'en_US.UTF-8', 09:43:26 INFO - 'LANGUAGE': 'en_US:en', 09:43:26 INFO - 'LOGNAME': 'cltbld', 09:43:26 INFO - 'MAIL': '/var/mail/cltbld', 09:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:26 INFO - 'MOZ_NO_REMOTE': '1', 09:43:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:26 INFO - 'NO_EM_RESTART': '1', 09:43:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:43:26 INFO - 'PWD': '/builds/slave/test-pgo', 09:43:26 INFO - 'SHELL': '/bin/bash', 09:43:26 INFO - 'SHLVL': '1', 09:43:26 INFO - 'TERM': 'linux', 09:43:26 INFO - 'TMOUT': '86400', 09:43:26 INFO - 'USER': 'cltbld', 09:43:26 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1454348372.207926-887817633', 09:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:26 INFO - '_': '/tools/buildbot/bin/python'} 09:43:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:26 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 09:43:26 INFO - Cleaning up... 09:43:26 INFO - Return code: 0 09:43:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:43:26 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')]} 09:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:26 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')]} 09:43:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:26 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 0x7f132ebbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2163350>, '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 0x2164250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21646e0>, '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-1454348372.207926-887817633', '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 09:43:26 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 09:43:26 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 09:43:26 INFO - Using env: {'DISPLAY': ':0', 09:43:26 INFO - 'HOME': '/home/cltbld', 09:43:26 INFO - 'LANG': 'en_US.UTF-8', 09:43:26 INFO - 'LANGUAGE': 'en_US:en', 09:43:26 INFO - 'LOGNAME': 'cltbld', 09:43:26 INFO - 'MAIL': '/var/mail/cltbld', 09:43:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:26 INFO - 'MOZ_NO_REMOTE': '1', 09:43:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:26 INFO - 'NO_EM_RESTART': '1', 09:43:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:43:26 INFO - 'PWD': '/builds/slave/test-pgo', 09:43:26 INFO - 'SHELL': '/bin/bash', 09:43:26 INFO - 'SHLVL': '1', 09:43:26 INFO - 'TERM': 'linux', 09:43:26 INFO - 'TMOUT': '86400', 09:43:26 INFO - 'USER': 'cltbld', 09:43:26 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1454348372.207926-887817633', 09:43:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:26 INFO - '_': '/tools/buildbot/bin/python'} 09:43:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:26 INFO - Downloading/unpacking psutil>=0.7.1 09:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:43:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:43:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:43:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:43:28 INFO - Installing collected packages: psutil 09:43:28 INFO - Running setup.py install for psutil 09:43:28 INFO - building 'psutil._psutil_linux' extension 09:43:28 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 09:43:28 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 09:43:28 INFO - building 'psutil._psutil_posix' extension 09:43:28 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 09:43:29 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 09:43:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:43:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:43:29 INFO - Successfully installed psutil 09:43:29 INFO - Cleaning up... 09:43:29 INFO - Return code: 0 09:43:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:43:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:43:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:43:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:43:29 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 0x7f132ebbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2163350>, '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 0x2164250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21646e0>, '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-1454348372.207926-887817633', '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 09:43:29 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 09:43:29 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 09:43:29 INFO - Using env: {'DISPLAY': ':0', 09:43:29 INFO - 'HOME': '/home/cltbld', 09:43:29 INFO - 'LANG': 'en_US.UTF-8', 09:43:29 INFO - 'LANGUAGE': 'en_US:en', 09:43:29 INFO - 'LOGNAME': 'cltbld', 09:43:29 INFO - 'MAIL': '/var/mail/cltbld', 09:43:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:43:29 INFO - 'MOZ_NO_REMOTE': '1', 09:43:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:43:29 INFO - 'NO_EM_RESTART': '1', 09:43:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:43:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:43:29 INFO - 'PWD': '/builds/slave/test-pgo', 09:43:29 INFO - 'SHELL': '/bin/bash', 09:43:29 INFO - 'SHLVL': '1', 09:43:29 INFO - 'TERM': 'linux', 09:43:29 INFO - 'TMOUT': '86400', 09:43:29 INFO - 'USER': 'cltbld', 09:43:29 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1454348372.207926-887817633', 09:43:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:43:29 INFO - '_': '/tools/buildbot/bin/python'} 09:43:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:43:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:43:29 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 09:43:29 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 09:43:29 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 09:43:29 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 09:43:29 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 09:43:29 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 09:45:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:45:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:45:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:45:31 INFO - Installing collected packages: mozsystemmonitor 09:45:31 INFO - Running setup.py install for mozsystemmonitor 09:45:31 INFO - Successfully installed mozsystemmonitor 09:45:31 INFO - Cleaning up... 09:45:32 INFO - Return code: 0 09:45:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:32 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 0x7f132ebbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2163350>, '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 0x2164250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21646e0>, '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-1454348372.207926-887817633', '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 09:45:32 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 09:45:32 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 09:45:32 INFO - Using env: {'DISPLAY': ':0', 09:45:32 INFO - 'HOME': '/home/cltbld', 09:45:32 INFO - 'LANG': 'en_US.UTF-8', 09:45:32 INFO - 'LANGUAGE': 'en_US:en', 09:45:32 INFO - 'LOGNAME': 'cltbld', 09:45:32 INFO - 'MAIL': '/var/mail/cltbld', 09:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:32 INFO - 'MOZ_NO_REMOTE': '1', 09:45:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:32 INFO - 'NO_EM_RESTART': '1', 09:45:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:45:32 INFO - 'PWD': '/builds/slave/test-pgo', 09:45:32 INFO - 'SHELL': '/bin/bash', 09:45:32 INFO - 'SHLVL': '1', 09:45:32 INFO - 'TERM': 'linux', 09:45:32 INFO - 'TMOUT': '86400', 09:45:32 INFO - 'USER': 'cltbld', 09:45:32 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1454348372.207926-887817633', 09:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:32 INFO - '_': '/tools/buildbot/bin/python'} 09:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:32 INFO - Downloading/unpacking blobuploader==1.2.4 09:45:32 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 09:45:32 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 09:45:32 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 09:45:32 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 09:45:32 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 09:45:32 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 09:45:33 INFO - Downloading blobuploader-1.2.4.tar.gz 09:45:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:45:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:45:34 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 09:45:34 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 09:45:34 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 09:45:34 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 09:45:34 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 09:45:34 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 09:45:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:45:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:45:34 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 09:45:34 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 09:45:34 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 09:45:34 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 09:45:34 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 09:45:34 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 09:45:34 INFO - Downloading docopt-0.6.1.tar.gz 09:45:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:45:34 INFO - Installing collected packages: blobuploader, requests, docopt 09:45:34 INFO - Running setup.py install for blobuploader 09:45:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:45:34 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:45:34 INFO - Running setup.py install for requests 09:45:35 INFO - Running setup.py install for docopt 09:45:35 INFO - Successfully installed blobuploader requests docopt 09:45:35 INFO - Cleaning up... 09:45:35 INFO - Return code: 0 09:45:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:35 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 0x7f132ebbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2163350>, '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 0x2164250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21646e0>, '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-1454348372.207926-887817633', '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 09:45:35 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 09:45:35 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 09:45:35 INFO - Using env: {'DISPLAY': ':0', 09:45:35 INFO - 'HOME': '/home/cltbld', 09:45:35 INFO - 'LANG': 'en_US.UTF-8', 09:45:35 INFO - 'LANGUAGE': 'en_US:en', 09:45:35 INFO - 'LOGNAME': 'cltbld', 09:45:35 INFO - 'MAIL': '/var/mail/cltbld', 09:45:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:35 INFO - 'MOZ_NO_REMOTE': '1', 09:45:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:35 INFO - 'NO_EM_RESTART': '1', 09:45:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:45:35 INFO - 'PWD': '/builds/slave/test-pgo', 09:45:35 INFO - 'SHELL': '/bin/bash', 09:45:35 INFO - 'SHLVL': '1', 09:45:35 INFO - 'TERM': 'linux', 09:45:35 INFO - 'TMOUT': '86400', 09:45:35 INFO - 'USER': 'cltbld', 09:45:35 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1454348372.207926-887817633', 09:45:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:35 INFO - '_': '/tools/buildbot/bin/python'} 09:45:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:45:35 INFO - Running setup.py (path:/tmp/pip-b2oMRa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:45:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:45:35 INFO - Running setup.py (path:/tmp/pip-TYe34n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:45:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:45:35 INFO - Running setup.py (path:/tmp/pip-1XB4w3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:45:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:45:35 INFO - Running setup.py (path:/tmp/pip-sckVMo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:45:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:45:35 INFO - Running setup.py (path:/tmp/pip-k1qjTm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:45:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:45:35 INFO - Running setup.py (path:/tmp/pip-vuneDq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:45:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:45:35 INFO - Running setup.py (path:/tmp/pip-GJus7Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:45:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:45:36 INFO - Running setup.py (path:/tmp/pip-2fRFkF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:45:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:45:36 INFO - Running setup.py (path:/tmp/pip-yrinz_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:45:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:45:36 INFO - Running setup.py (path:/tmp/pip-RStIDk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:45:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:45:36 INFO - Running setup.py (path:/tmp/pip-WHjtjs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:45:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:45:36 INFO - Running setup.py (path:/tmp/pip-ENRbAj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:45:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:45:36 INFO - Running setup.py (path:/tmp/pip-7_Qt0w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:45:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:45:36 INFO - Running setup.py (path:/tmp/pip-Tr4VJI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:45:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:45:36 INFO - Running setup.py (path:/tmp/pip-QFal6w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:45:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:45:36 INFO - Running setup.py (path:/tmp/pip-7Xcgt8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:45:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:45:36 INFO - Running setup.py (path:/tmp/pip-JCBSZw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:45:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:45:36 INFO - Running setup.py install for manifestparser 09:45:36 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:45:36 INFO - Running setup.py install for mozcrash 09:45:36 INFO - Running setup.py install for mozdebug 09:45:37 INFO - Running setup.py install for mozdevice 09:45:37 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:45:37 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:45:37 INFO - Running setup.py install for mozfile 09:45:37 INFO - Running setup.py install for mozhttpd 09:45:37 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:45:37 INFO - Running setup.py install for mozinfo 09:45:37 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:45:37 INFO - Running setup.py install for mozInstall 09:45:37 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:45:37 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:45:37 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:45:37 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:45:37 INFO - Running setup.py install for mozleak 09:45:37 INFO - Running setup.py install for mozlog 09:45:37 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:45:37 INFO - Running setup.py install for moznetwork 09:45:37 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:45:37 INFO - Running setup.py install for mozprocess 09:45:38 INFO - Running setup.py install for mozprofile 09:45:38 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:45:38 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:45:38 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:45:38 INFO - Running setup.py install for mozrunner 09:45:38 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:45:38 INFO - Running setup.py install for mozscreenshot 09:45:38 INFO - Running setup.py install for moztest 09:45:38 INFO - Running setup.py install for mozversion 09:45:38 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:45:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:45:38 INFO - Cleaning up... 09:45:38 INFO - Return code: 0 09:45:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:45: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')]} 09:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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')]} 09:45:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:38 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 0x7f132ebbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2163350>, '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 0x2164250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21646e0>, '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-1454348372.207926-887817633', '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 09:45:38 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 09:45:38 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 09:45:38 INFO - Using env: {'DISPLAY': ':0', 09:45:38 INFO - 'HOME': '/home/cltbld', 09:45:38 INFO - 'LANG': 'en_US.UTF-8', 09:45:38 INFO - 'LANGUAGE': 'en_US:en', 09:45:38 INFO - 'LOGNAME': 'cltbld', 09:45:38 INFO - 'MAIL': '/var/mail/cltbld', 09:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:38 INFO - 'MOZ_NO_REMOTE': '1', 09:45:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:38 INFO - 'NO_EM_RESTART': '1', 09:45:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:45:38 INFO - 'PWD': '/builds/slave/test-pgo', 09:45:38 INFO - 'SHELL': '/bin/bash', 09:45:38 INFO - 'SHLVL': '1', 09:45:38 INFO - 'TERM': 'linux', 09:45:38 INFO - 'TMOUT': '86400', 09:45:38 INFO - 'USER': 'cltbld', 09:45:38 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1454348372.207926-887817633', 09:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:38 INFO - '_': '/tools/buildbot/bin/python'} 09:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:45:38 INFO - Running setup.py (path:/tmp/pip-EJNPbH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:45:38 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)) 09:45:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:45:38 INFO - Running setup.py (path:/tmp/pip-YGunAc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:45:38 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)) 09:45:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:45:38 INFO - Running setup.py (path:/tmp/pip-66_5bS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:45:39 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)) 09:45:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:45:39 INFO - Running setup.py (path:/tmp/pip-jMW3Ud-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:45:39 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)) 09:45:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:45:39 INFO - Running setup.py (path:/tmp/pip-jZkQhT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:45:39 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)) 09:45:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:45:39 INFO - Running setup.py (path:/tmp/pip-4cTHIC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:45:39 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)) 09:45:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:45:39 INFO - Running setup.py (path:/tmp/pip-7vuF5_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:45:39 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)) 09:45:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:45:39 INFO - Running setup.py (path:/tmp/pip-9NR1mG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:45:39 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)) 09:45:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:45:39 INFO - Running setup.py (path:/tmp/pip-ravt84-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:45:39 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)) 09:45:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:45:39 INFO - Running setup.py (path:/tmp/pip-sZ3865-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:45:39 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)) 09:45:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:45:39 INFO - Running setup.py (path:/tmp/pip-gaxhAw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:45:39 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)) 09:45:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:45:39 INFO - Running setup.py (path:/tmp/pip-HKAmUp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:45:39 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)) 09:45:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:45:39 INFO - Running setup.py (path:/tmp/pip-jgYND1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:45:39 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)) 09:45:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:45:39 INFO - Running setup.py (path:/tmp/pip-X3jRVp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:45:39 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)) 09:45:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:45:39 INFO - Running setup.py (path:/tmp/pip-_sw_r6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:45:39 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)) 09:45:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:45:39 INFO - Running setup.py (path:/tmp/pip-9bf2e5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:45:39 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)) 09:45:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:45:39 INFO - Running setup.py (path:/tmp/pip-UN8cp6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:45:40 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)) 09:45:40 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)) 09:45:40 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)) 09:45:40 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)) 09:45:40 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)) 09:45:40 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)) 09:45:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:41 INFO - Downloading blessings-1.6.tar.gz 09:45:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:45:41 INFO - Installing collected packages: blessings 09:45:41 INFO - Running setup.py install for blessings 09:45:41 INFO - Successfully installed blessings 09:45:41 INFO - Cleaning up... 09:45:42 INFO - Return code: 0 09:45:42 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:45:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:45:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:45:42 INFO - Reading from file tmpfile_stdout 09:45:42 INFO - Current package versions: 09:45:42 INFO - argparse == 1.2.1 09:45:42 INFO - blessings == 1.6 09:45:42 INFO - blobuploader == 1.2.4 09:45:42 INFO - docopt == 0.6.1 09:45:42 INFO - manifestparser == 1.1 09:45:42 INFO - mozInstall == 1.12 09:45:42 INFO - mozcrash == 0.16 09:45:42 INFO - mozdebug == 0.1 09:45:42 INFO - mozdevice == 0.47 09:45:42 INFO - mozfile == 1.2 09:45:42 INFO - mozhttpd == 0.7 09:45:42 INFO - mozinfo == 0.9 09:45:42 INFO - mozleak == 0.1 09:45:42 INFO - mozlog == 3.1 09:45:42 INFO - moznetwork == 0.27 09:45:42 INFO - mozprocess == 0.22 09:45:42 INFO - mozprofile == 0.27 09:45:42 INFO - mozrunner == 6.11 09:45:42 INFO - mozscreenshot == 0.1 09:45:42 INFO - mozsystemmonitor == 0.0 09:45:42 INFO - moztest == 0.7 09:45:42 INFO - mozversion == 1.4 09:45:42 INFO - psutil == 3.1.1 09:45:42 INFO - requests == 1.2.3 09:45:42 INFO - wsgiref == 0.1.2 09:45:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:42 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 0x7f132ebbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2163350>, '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 0x2164250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21646e0>, '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-1454348372.207926-887817633', '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 09:45:42 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 09:45:42 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 09:45:42 INFO - Using env: {'DISPLAY': ':0', 09:45:42 INFO - 'HOME': '/home/cltbld', 09:45:42 INFO - 'LANG': 'en_US.UTF-8', 09:45:42 INFO - 'LANGUAGE': 'en_US:en', 09:45:42 INFO - 'LOGNAME': 'cltbld', 09:45:42 INFO - 'MAIL': '/var/mail/cltbld', 09:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:42 INFO - 'MOZ_NO_REMOTE': '1', 09:45:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:42 INFO - 'NO_EM_RESTART': '1', 09:45:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:45:42 INFO - 'PWD': '/builds/slave/test-pgo', 09:45:42 INFO - 'SHELL': '/bin/bash', 09:45:42 INFO - 'SHLVL': '1', 09:45:42 INFO - 'TERM': 'linux', 09:45:42 INFO - 'TMOUT': '86400', 09:45:42 INFO - 'USER': 'cltbld', 09:45:42 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1454348372.207926-887817633', 09:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:42 INFO - '_': '/tools/buildbot/bin/python'} 09:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:42 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)) 09:45:42 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)) 09:45:42 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)) 09:45:42 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)) 09:45:42 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)) 09:45:42 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)) 09:45:42 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)) 09:45:42 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)) 09:45:42 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)) 09:45:42 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)) 09:45:42 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)) 09:45:42 INFO - Cleaning up... 09:45:42 INFO - Return code: 0 09:45:42 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:42 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 0x7f132ebbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2163350>, '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 0x2164250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21646e0>, '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-1454348372.207926-887817633', '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 09:45:42 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 09:45:42 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 09:45:42 INFO - Using env: {'DISPLAY': ':0', 09:45:42 INFO - 'HOME': '/home/cltbld', 09:45:42 INFO - 'LANG': 'en_US.UTF-8', 09:45:42 INFO - 'LANGUAGE': 'en_US:en', 09:45:42 INFO - 'LOGNAME': 'cltbld', 09:45:42 INFO - 'MAIL': '/var/mail/cltbld', 09:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:42 INFO - 'MOZ_NO_REMOTE': '1', 09:45:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:42 INFO - 'NO_EM_RESTART': '1', 09:45:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:45:42 INFO - 'PWD': '/builds/slave/test-pgo', 09:45:42 INFO - 'SHELL': '/bin/bash', 09:45:42 INFO - 'SHLVL': '1', 09:45:42 INFO - 'TERM': 'linux', 09:45:42 INFO - 'TMOUT': '86400', 09:45:42 INFO - 'USER': 'cltbld', 09:45:42 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1454348372.207926-887817633', 09:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:42 INFO - '_': '/tools/buildbot/bin/python'} 09:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:42 INFO - Downloading/unpacking jsonschema 09:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:45:44 INFO - Downloading/unpacking functools32 (from jsonschema) 09:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:44 INFO - Downloading functools32-3.2.3-2.tar.gz 09:45:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:45:44 INFO - warning: no files found matching '*.txt' 09:45:44 INFO - no previously-included directories found matching 'build' 09:45:44 INFO - no previously-included directories found matching 'dist' 09:45:44 INFO - no previously-included directories found matching '.git*' 09:45:44 INFO - Installing collected packages: jsonschema, functools32 09:45:44 INFO - Running setup.py install for functools32 09:45:44 INFO - warning: no files found matching '*.txt' 09:45:44 INFO - no previously-included directories found matching 'build' 09:45:44 INFO - no previously-included directories found matching 'dist' 09:45:44 INFO - no previously-included directories found matching '.git*' 09:45:44 INFO - Successfully installed jsonschema functools32 09:45:44 INFO - Cleaning up... 09:45:44 INFO - Return code: 0 09:45:44 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:45:44 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')]} 09:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:44 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')]} 09:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:44 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 0x7f132ebbcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d4600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2163350>, '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 0x2164250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21646e0>, '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-1454348372.207926-887817633', '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 09:45:44 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 09:45:44 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 09:45:44 INFO - Using env: {'DISPLAY': ':0', 09:45:44 INFO - 'HOME': '/home/cltbld', 09:45:44 INFO - 'LANG': 'en_US.UTF-8', 09:45:44 INFO - 'LANGUAGE': 'en_US:en', 09:45:44 INFO - 'LOGNAME': 'cltbld', 09:45:44 INFO - 'MAIL': '/var/mail/cltbld', 09:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:44 INFO - 'MOZ_NO_REMOTE': '1', 09:45:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:44 INFO - 'NO_EM_RESTART': '1', 09:45:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:45:44 INFO - 'PWD': '/builds/slave/test-pgo', 09:45:44 INFO - 'SHELL': '/bin/bash', 09:45:44 INFO - 'SHLVL': '1', 09:45:44 INFO - 'TERM': 'linux', 09:45:44 INFO - 'TMOUT': '86400', 09:45:44 INFO - 'USER': 'cltbld', 09:45:44 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1454348372.207926-887817633', 09:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:44 INFO - '_': '/tools/buildbot/bin/python'} 09:45:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:45 INFO - Downloading/unpacking flake8 09:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:45:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:45:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:45:47 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 09:45:47 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 09:45:47 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 09:45:47 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 09:45:47 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 09:45:47 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 09:45:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:45:47 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 09:45:47 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 09:45:47 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 09:45:47 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 09:45:47 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 09:45:47 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 09:45:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:45:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:45:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:45:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:45:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:45:47 INFO - no previously-included directories found matching 'docs/_build' 09:45:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:45:47 INFO - Running setup.py install for pep8 09:45:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:45:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:45:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:45:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:45:47 INFO - no previously-included directories found matching 'docs/_build' 09:45:47 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:45:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:45:47 INFO - Cleaning up... 09:45:47 INFO - Return code: 0 09:45:47 INFO - Running post-action listener: _resource_record_post_action 09:45:47 INFO - Running post-action listener: _start_resource_monitoring 09:45:47 INFO - Starting resource monitoring. 09:45:47 INFO - ##### 09:45:47 INFO - ##### Running install step. 09:45:47 INFO - ##### 09:45:47 INFO - Running pre-action listener: _resource_record_pre_action 09:45:47 INFO - Running main action method: install 09:45:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:45:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:45:48 INFO - Reading from file tmpfile_stdout 09:45:48 INFO - Detecting whether we're running mozinstall >=1.0... 09:45:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:45:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:45:48 INFO - Reading from file tmpfile_stdout 09:45:48 INFO - Output received: 09:45:48 INFO - Usage: mozinstall [options] installer 09:45:48 INFO - Options: 09:45:48 INFO - -h, --help show this help message and exit 09:45:48 INFO - -d DEST, --destination=DEST 09:45:48 INFO - Directory to install application into. [default: 09:45:48 INFO - "/builds/slave/test-pgo"] 09:45:48 INFO - --app=APP Application being installed. [default: firefox] 09:45:48 INFO - mkdir: /builds/slave/test-pgo/build/application 09:45:48 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'] 09:45:48 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 09:46:02 INFO - Reading from file tmpfile_stdout 09:46:02 INFO - Output received: 09:46:02 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:46:02 INFO - Running post-action listener: _resource_record_post_action 09:46:02 INFO - ##### 09:46:02 INFO - ##### Running run-tests step. 09:46:02 INFO - ##### 09:46:02 INFO - Running pre-action listener: _resource_record_pre_action 09:46:02 INFO - Running main action method: run_tests 09:46:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:46:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:46:02 INFO - Python 2.7.3 09:46:02 INFO - Return code: 0 09:46:02 INFO - grabbing minidump binary from tooltool 09:46:02 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')]} 09:46:02 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 0x2163350>, '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 0x2164250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21646e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:46:02 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 09:46:02 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 09:46:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:46:02 INFO - Return code: 0 09:46:02 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:46:02 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:46:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:46:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:46:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:46:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:46:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:46:03 INFO - Return code: 0 09:46:03 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/1454337867/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:46:03 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/1454337867/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost 09:46:03 INFO - Using env: {'DISPLAY': ':0', 09:46:03 INFO - 'HOME': '/home/cltbld', 09:46:03 INFO - 'LANG': 'en_US.UTF-8', 09:46:03 INFO - 'LANGUAGE': 'en_US:en', 09:46:03 INFO - 'LOGNAME': 'cltbld', 09:46:03 INFO - 'MAIL': '/var/mail/cltbld', 09:46:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:46:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:03 INFO - 'MOZ_NO_REMOTE': '1', 09:46:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:46:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:46:03 INFO - 'NO_EM_RESTART': '1', 09:46:03 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:46:03 INFO - 'PWD': '/builds/slave/test-pgo', 09:46:03 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:46:03 INFO - 'SHELL': '/bin/bash', 09:46:03 INFO - 'SHLVL': '1', 09:46:03 INFO - 'TERM': 'linux', 09:46:03 INFO - 'TMOUT': '86400', 09:46:03 INFO - 'USER': 'cltbld', 09:46:03 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1454348372.207926-887817633', 09:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:03 INFO - '_': '/tools/buildbot/bin/python'} 09:46:03 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/1454337867/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost'] with output_timeout 3600 09:46:03 INFO - mozversion INFO | application_buildid: 20160201064427 09:46:03 INFO - mozversion INFO | application_changeset: 8b76e1c0b2b5299ba18bd7522aecfa5dd5f0f11f 09:46:03 INFO - mozversion INFO | application_display_name: Nightly 09:46:03 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:46:03 INFO - mozversion INFO | application_name: Firefox 09:46:03 INFO - mozversion INFO | application_remotingname: firefox 09:46:03 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:46:03 INFO - mozversion INFO | application_vendor: Mozilla 09:46:03 INFO - mozversion INFO | application_version: 45.0 09:46:04 INFO - mozversion INFO | platform_buildid: 20160201064427 09:46:04 INFO - mozversion INFO | platform_changeset: 8b76e1c0b2b5299ba18bd7522aecfa5dd5f0f11f 09:46:04 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:46:04 INFO - mozversion INFO | platform_version: 45.0 09:46:04 INFO - 2016-02-01 09:46:03,998 DEBUG : using testdate: 1454348763 09:46:04 INFO - 2016-02-01 09:46:03,998 DEBUG : actual date: 1454348763 09:46:04 INFO - 2016-02-01 09:46:04,006 INFO : starting webserver on 'localhost:37409' 09:46:04 INFO - 2016-02-01 09:46:04,007 INFO : Starting test suite talos-linux64-ix-046 09:46:04 INFO - 2016-02-01 09:46:04,007 INFO : Starting test dromaeo_css 09:46:04 INFO - 2016-02-01 09:46:04,007 DEBUG : operating with platform_type : linux_ 09:46:04 INFO - 2016-02-01 09:46:04,008 INFO : Initialising browser for dromaeo_css test... 09:46:04 INFO - 2016-02-01 09:46:04,023 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpx1m58l/profile http://localhost:37409/getInfo.html 09:46:08 INFO - 2016-02-01 09:46:08,019 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:46:08 INFO - 2016-02-01 09:46:08,019 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:46:08 INFO - 2016-02-01 09:46:08,019 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:46:08 INFO - 2016-02-01 09:46:08,019 DEBUG : BROWSER_OUTPUT: __metrics 09:46:08 INFO - 2016-02-01 09:46:08,156 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] 09:46:08 INFO - 2016-02-01 09:46:08,843 INFO : Browser initialized. 09:46:08 INFO - 2016-02-01 09:46:08,844 INFO : Running cycle 1/1 for dromaeo_css test... 09:46:08 INFO - 2016-02-01 09:46:08,844 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpx1m58l/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:46:20 INFO - 2016-02-01 09:46:20,564 DEBUG : BROWSER_OUTPUT: RSS: Main: 134025216 09:46:20 INFO - 2016-02-01 09:46:20,565 DEBUG : BROWSER_OUTPUT: 09:47:11 INFO - 2016-02-01 09:47:11,365 DEBUG : BROWSER_OUTPUT: 1454348831363 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] 09:49:19 INFO - 2016-02-01 09:49:19,317 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37409/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37409/tests/dromaeo/cssquery-ext.html) 09:49:20 INFO - 2016-02-01 09:49:20,503 DEBUG : BROWSER_OUTPUT: RSS: Main: 210694144 09:49:20 INFO - 2016-02-01 09:49:20,503 DEBUG : BROWSER_OUTPUT: 09:52:22 INFO - 2016-02-01 09:52:22,538 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37409/tests/dromaeo/cssquery-ext.html (next: http://localhost:37409/tests/dromaeo/cssquery-jquery.html) 09:52:23 INFO - 2016-02-01 09:52:23,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 212467712 09:52:23 INFO - 2016-02-01 09:52:23,099 DEBUG : BROWSER_OUTPUT: 09:55:24 INFO - 2016-02-01 09:55:24,879 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37409/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37409/tests/dromaeo/cssquery-mootools.html) 09:55:25 INFO - 2016-02-01 09:55:25,448 DEBUG : BROWSER_OUTPUT: RSS: Main: 222978048 09:55:25 INFO - 2016-02-01 09:55:25,449 DEBUG : BROWSER_OUTPUT: 09:58:27 INFO - 2016-02-01 09:58:27,188 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37409/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37409/tests/dromaeo/cssquery-prototype.html) 09:58:27 INFO - 2016-02-01 09:58:27,770 DEBUG : BROWSER_OUTPUT: RSS: Main: 201498624 09:58:27 INFO - 2016-02-01 09:58:27,770 DEBUG : BROWSER_OUTPUT: 10:01:30 INFO - 2016-02-01 10:01:30,127 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37409/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37409/tests/dromaeo/cssquery-yui.html) 10:01:30 INFO - 2016-02-01 10:01:30,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 199659520 10:01:30 INFO - 2016-02-01 10:01:30,721 DEBUG : BROWSER_OUTPUT: 10:04:32 INFO - 2016-02-01 10:04:32,811 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37409/tests/dromaeo/cssquery-yui.html (next: http://localhost:37409/tests/dromaeo/cssquery-dojo.html) 10:04:33 INFO - 2016-02-01 10:04:33,061 DEBUG : BROWSER_OUTPUT: RSS: Main: 233447424 10:04:33 INFO - 2016-02-01 10:04:33,062 DEBUG : BROWSER_OUTPUT: 10:04:33 INFO - 2016-02-01 10:04:33,062 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:04:33 INFO - 2016-02-01 10:04:33,062 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:04:33 INFO - 2016-02-01 10:04:33,062 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:04:33 INFO - 2016-02-01 10:04:33,062 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:04:33 INFO - 2016-02-01 10:04:33,064 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3275.312184441267;3313.2213929726495;3383.01892451189;3395.966040339596;3395.998180536743;5520.365158006831;5548.195511650818;5564.638298510599;5566.137248726443;5580.190872323511;5503.064479038563;5524.751386187621;5573.331200255965;5583.413741557129;5594.356648985368;4835.661503694742;5058.190689489682;5088.872778180556;5157.510036546522;5171.974140129313;4918.655694101414;4975.3283306753665;4984.87537811554;4987.326710894019;4989.276554899556;4965.627577931651;4968.056069346831;4971.726555039471;5056.115179843531;5088.389393272812;5044.646874718771;5070.163423035232;5076.137056700333;5083.7712302946275;5105.974470127663;4927.728974906378;5003.92494112585;5037.143685573461;5047.545720885101;5054.595632349403;5169.276301317818;5221.530062294374;5279.260903473517;5316.9202461963105;5326.360836699582;5852.15143804146;5888.411158884121;5891.234139561872;5892.499137573312;5902.2622172228475;5597.692126933017;5926.674032928187;5931.851703707399;5934.7922822701;5938.198343223653;5368.8389348319615;5473.261109750172;5532.75102620387;5534.252875861787;5559.694216818073;5997.160397544348;5999.760009599654;6001.969990150022;6003.159557661931;6013.428724271187;5624.29696287964;5721.342045664718;5751.4536119068625;5811.070228763462;5812.7674893003805;5869.8239052828485;5952.613080149777;5954.01758709808;5962.672053037125;5998.040313549811;5859.472647461749;5895.764169433174;5909.970450147722;5911.113333000085;5911.822645320647;5614.63504872182;5652.378238393773;5727;5896.292444906639;5905.881882362329;4510.391097201836;4513.187626227311;4514.6614003949835;4539.614132798749;4541.500434952152;4056.127932494528;4061.289274376972;4061.4923134608175;4065.654419374327;4083.387491876183;5386.380566234855;5542.501174894198;5557.833265002057;5614.775408983676;5621.353544342453;5877.794277200277;5890.67601281925;5923.555733320019;5928.288605367384;5938.6436813791315;5647.29408823897;5661.2923384576925;5665.915011274834;5672.262605861211;5681.687507187062;5017.598592112622;5070.087384270793;5132.56373208274;5176.327077479904;5180.948190518122;6061.7575296987625;6103.298120716086;6104.481119104837;6107.328193898667;6127.509799216052;5873;5960.195373624505;5966.612170208922;5967.433093856251;5970.910436343545;5885.911711324419;5941.108833674811;6011.729472173675;6146.139540464428;6156.907646385218;5809.128630705428;5890.410958904246;5891.23413956183;5902.61632993854;5918.993771059017;5964.433378829004;5994.3705910878725;5995.400459953969;5996.4603185713495;5997.610155339889;5469.589780766538;5640.041192997118;5667.8866422672145;5745.798897038583;5839.124131380327;5770.076787713946;5826.563007774349;5828.562857785768;5832.096025116114;5834;5723.084306510938;5736.196932429547;5741.081426971665;5743.396943321059;5746.080627099644;5600.663960162403;5680.659160450221;5702.572307077069;5832.9708351457975;5852.736626851717;5648.23748793924;5670.461306175906;5671.971640141773;5680.886382272414;5730.426957304403 10:04:33 INFO - 2016-02-01 10:04:33,067 DEBUG : BROWSER_OUTPUT: |1;ext.html;592.1236569876583;627.504271625416;633.21165149389;635.9682015899207;639.434100820774;40601.59398406015;41688;41727.374089388686;41769.79115104424;41829.58170418302;45636;45717.54282457174;46198.538014619844;46239.53760462395;46275.76862115693;8081;8186;8986.865197022067;9241.49171795551;10548.261621686484;10813.243072984895;10920.235583509157;10921.399323037229;10947.397893115876;10954.39750813705;10878.564857405694;10976.341419514814;10980.725481862937;10987.175961802857;10989.340639561611;10824.72938176544;10907.127429805636;10922.017018468296;10928.562857485731;10930;10688.519016644192;10837.133029357632;10844.457777111193;10845.295055821347;10846.891531084746;42587.36118958218;42857.57142428567;42928;43053.138937221396;43107.35338969918;3577.338192434408;3619.077135330474;3729.1795804923145;4035.8587798636113;4256.702030857841;32431.51352729711;32994.17514562131;33028;33037;33401.16497087568;4287.442632457792;4320.697551171419;4343;4386.174253723907;4547.136044151601;314023;314862;315531;315532;315853.99999999773;64026.67986660037;65350.673246633465;72499.27500724925;73102;73691;64750.67624661847;64755;64972.67513662401;65021;65207.347926520124;17538.736918946226;17773.555661108574;17785.19966601506;17834;17834.19746111428;12878.549250776177;13083.215007099605;13086.14940028895;13166.341682915816;13168.275744834125;21686.24098156557;21927.232546860785;22010.33968980933;22049.669254961187;22066.779332206792;7857.685692572348;8053.758387248392;8073.31376832964;8167.959160204161;8178.836423271501;1033.503918119307;1058.6347710040025;1078.3745427651943;1119.5186069989982;1139.9886001140048;30489.237769055508;30517.824719458007;30729.231769205948;31097.53353699696;31140;1105.886103694256;1123.8763735989035;1183.148133343991;1200.6038007457519;1284.3000564692265;13322.533711320057;14510;14614.634634134232;14941.551753447415;16455.506334809976;366008;374899;376189;376260;376519;58542;58883;58939;59074;59220.70389648024;1465.9853401465848;1481.4370539195038;1487.152323175801;1497.7453832848441;1504.4959938420532;30592.235194120323;30858.382832342777;31299.530507041956;31352.686473134978;31595.684043160192;55734.442655574545;56982.7150864243;57084.42915570791;57156.714216430315;57166.42833571611;221707;223717;223829;224634;225347;31011.534826977164;31420.371592567564;34257.48613770845;45139.77430112829;45278.320825188304;48129.278060828416;50674.23988640247;51209.743951281496;52106.739466302424;52485.475145248056;41524.3771343424;41932.37101443542;42017.57982420137;42380.36429453499;43232.78383608188;39089.80455097706;42267;42269.78865105655;44331.77834110809;45925.31112033389;40606.79696601498;40631.1873762529;40861.38707919443;41228.38157427701;44949.32576011297;38855.418687325546;39546.2090758189;41016.384754228115;42803.57196427996;43770.56229437792;32445.675543244266;32636.347273054882;32936.505952411215;33045.66954330426;33093.83453082719 10:04:33 INFO - 2016-02-01 10:04:33,068 DEBUG : BROWSER_OUTPUT: |2;jquery.html;361.021631378963;367.07497107289646;374.32621281692946;382.0553383279109;388.19837036519584;15209.239538023083;15768.605784855356;17122.26788160324;20128.09423575939;20510.589788204226;18082;18138.909305453486;18426.262949482003;18609.441716748486;18611.069446527687;4592.058627981272;6070.696465176746;6198.535109866755;6225.035119556476;6226.533010024244;4816.51834816519;4844.515548445145;4853.369062021932;6773.356531129535;7007.474439417038;6818.556793808387;6956.547824391424;6978.581285122909;6979.546329488592;6984.895226571605;6867.278935711754;6897.41371983382;6901.447884169254;6906.75826346078;6911.101556797609;6166.07508873668;6172.969135154295;6173.444390004921;6175.845603859894;6301.243850737895;22574.661380079313;22923.197688080836;23299;23369.948352324187;24309.1491797788;2540.2633236361617;2548.617707343895;2551.9362015949564;2672.3319170207446;2779.596958441035;14785.630359240997;14809.333579988926;14845.554633361016;15082.170480623561;15128.546143615598;2082.854200205986;2131.11558703138;2158.568286342738;2160.4922843131853;2166.4042388343173;74140;78635;79527;80118.19881801166;80328.19671803266;15378;16377.83622163787;16496.17519124039;16499.257533410786;16549.669006620043;25086.749132508805;25145.497090058096;25278.241652750447;25394.238172854843;25437.10970116074;9827.624132621439;9874.80250394988;9881.901180988098;9923.801523969625;9930.50347482623;8379.748607541784;8416.410851240476;8427.494350338999;8453.70412035588;8503.404761666749;4415.602595766396;6723.949497212842;8077.596120193967;8144.633491492897;8222.876656850152;1785.7946336171506;1806.8102849200645;1821.5901422180168;1835.2108593305006;1884.7455593494976;828.7513745876213;982.9531548900541;1007.6221416968637;1015.7155996321042;1078.223678951154;17380.65238695219;17703;17775.73336399955;18038.36865709694;18262;977.4868194198103;997.665781963036;1022.728976821143;1041.2919214933765;1046.8011077895176;10100.646477373257;10329.896701033043;10370.429626370622;10376.16990640747;10414;631717;632187;646094;647546;651079;82621;84412;85071;86838;87923;1142.8285757136496;1154.6189757380043;1154.96535103947;1156.485364013023;1174.5771522251982;15633.14017729036;15972.201389930224;16176.191190440666;16343.182840858148;16943.882014748157;20549.075291611614;35259.82370088133;36020.45969310515;37743;39121.82634520969;48676;49688.75155624199;50065.24902126398;50641.240381395044;52143.21785173301;9925.702228932854;10014.449205293779;10184.490775461345;10211.897881021094;10226.693199204035;11964.282143071443;12022.038236941198;14274.785878211627;18564;18805.15376808074;14275.14349139055;14416.639584010483;15725.213739313218;15757.133357665438;15786.695351640235;14946.476873309382;15232.3907043717;15524.68950621004;15909.284082216096;15958.04251744899;15279.923600381928;15345;15931.362745490514;16209;16452.83547164513;10171.54228059754;10210.030047145508;10252.948735256276;10465.90108038645;10472.371657700258;14525.491607793676;14662.63343416423;14853;15617.45338913178;16011.19944002772 10:04:33 INFO - 2016-02-01 10:04:33,071 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1495.95512134636;1501.1368463133701;1648;1791.7222830461276;1811.2392795026092;7431.554106753599;7803.453758236926;7817.413693972946;7824.217578242173;7828.882566761503;6956.269591692875;7083.5749855008735;7174.533655312401;7402.22276660951;7767.22327767223;2244.102359056378;2252.68462415262;2281.030562011147;2282.897269622871;2284.1091974130104;2004.368623883472;2260.6156953317895;2290.4502919299416;2320.9419764505938;2322.581935251654;1986.7814540400545;2221.7222847144108;2254.9887250563725;2263.54729054189;2263.864168149908;2132.402927180392;2154.7306586676664;2164.2100633268824;2170.2621108822996;2175.2060497918305;2238.798508134276;2254.5829021631052;2258.5821622999797;2260.4348912771807;2264.705588273514;7711.0746710395115;7760.961195194044;7769;7781.766547003599;7793.220677932161;4411.470623525165;4461.665375096881;4497.707649002837;4507.706999045052;4512.390827238313;3021.561873528326;3042.863071161803;3066.877324907023;3071.9078427647205;3085.8148511089407;1058.2645061682133;1067.0343339277965;1076.7792602516465;1079.96220132295;1104.3981030338484;10533.420661863594;10558.52486638103;10559.260851740304;10561.894381056169;10572.894271057268;3999.140184860211;4021.1354558770004;4023.3160362738404;4094.0992981544014;4116.794160291974;9015.549222538846;9103;9115.908840911507;9116.863247051167;9123.680671176477;4451.08752705701;4461.888452788707;4490.865274041784;4494.16857881293;4500.977495112504;4113.609207125318;4152.5432202457705;4154.459920210354;4157.521884983205;4157.937630935538;3690.2435000824767;3751.9249615007548;3754.605766394544;3759.2293579816073;3786.7159963002887;1086.435053772034;1211.8121691137887;1218.482145088334;1223.7063104854772;1230.6185082624415;970.0687340153531;1166.935818529989;1181.5510106159604;1349.6153596225224;1434.3043623842427;7347.669354879044;7370.77887663371;7399.963000184965;7410.184879663233;7474.177840437547;1135.3641960502146;1141.611851970334;1148.494662348564;1161.4134861894688;1181.480148734554;5761.337446193657;5866.208061911672;5871.3541510433815;5872.2366092408565;5881.176635271066;9111.68109116191;9120.954395227982;9201.355905086713;9332.90667093334;9380.95309523448;9151.130642588943;9157.77105572366;9178.954105229432;9264.536773161315;9280.582373793195;7400.259974002557;7400.555966642019;7563.9621801891735;7572.280633339824;7587.317141457295;7474.03128641185;7560.395168386626;7611.3530349920875;7620.542767433972;7622.5426474411715;8547.615357308812;8664.566771661266;8763.737087887119;8776.341774367076;8778.288233794348;8522.74431767048;8817.735467935972;8881.023087460504;8890.555472226233;8901.955490222766;6671.099401580918;6713.664316784044;6742.325767423218;6744.190697116377;6745.5952642841585;7065.116860392451;7075.221725610076;7108.822279443055;7152.070230869954;7157.570545767062;6402.775902843378;6711.295313992156;6818.284080171709;7144.142702875688;7238.710451581877;6460.321666224979;6656.700448479927;6876.828079298058;6889.827754306182;6947.3747362737595;7004.439644828503;7005.01929729828;7041.014258003986;7045.718171273092;7048.753293634698;6463.644499552382;6506.707198175999;6507.511936604868;6510.5117116217425;6518.380753828379;6603.933960660332;6636.535442518977;6646.268910419946;6647.335266473314;6653.800385988428 10:04:33 INFO - 2016-02-01 10:04:33,071 DEBUG : BROWSER_OUTPUT: |4;prototype.html;329.4087113631032;336.4381482923518;337.7281288562706;343.99038821060174;347.1927767939541;6021.548383871211;6056.545759068071;6058.818235452933;6097.054956481741;6115.266168059828;6010.338862725108;6011.639301641893;6013.338532761392;6023.698815059241;6029.397060293968;4614.976925115387;4623.976880115595;4624.653151013671;4626.074785043005;4628.514006029369;4498.820047198108;4628.30575413689;4631.235846085392;4655.88360290992;4658.464276608182;4588.564086411786;4589.79345929434;4596.655250856183;4597.977010114945;4608.285715714053;4421.977890110545;4528.818847246106;4546.795394207235;4602.9769851150695;4610.76946152691;4073;4100.159467309224;4104.9121982674615;4105.712600117993;4111.033907031845;5709.514691251248;5709.942900570983;5715.085586306171;5715.228444160027;5727.1695604137585;5144.717040562768;5259.789608415659;5311;5435.782568697247;5444.074507333763;6362.459190968773;6374.139491168679;6374.426301632829;6376.904346434807;6387.680615969183;4542.568455996675;4547.3179023146795;4549.863504094882;4550.8862278442975;4554.70190995568;6491.772787952446;6596.868062638769;6674.966625166891;6679.933200668028;6690.866182676319;4521.3896124023495;4538.205813982539;4564.246899261585;4565.292379681155;4567.063751930847;4615.676902616785;4621.376114224604;4621.722696638145;4624.5144259852905;4624.815007399667;5315.123004704181;5321.574274058066;5326.680399176062;5331.067063263913;5334.1732031535175;6314.526410519229;6419.037144428373;6425.389587989133;6439.452646525004;6444.355564443518;1640.2946732904966;1665.4837000529874;1666.558362034062;1667.7915260592426;1668.5316921109345;1095.3427943233996;1113.1317572293624;1118.1781390677845;1132.5413207650915;1155.7861795567846;6359.332270111571;6359.872802543923;6361.5546911716665;6363.204599425072;6363.713632886531;6630.171228596426;6631.3700198481065;6636.800895973032;6640.966795165993;6646.202455705346;6224.62652240867;6324;6348.301686814447;6363.681815909186;6365.586236894587;3548.769329993542;3588.659077387644;3601.117726157056;3615.7830530168276;3620.25784714133;6986.476014298846;6992.475564332695;7000.159980802337;7001.824954376079;7008.859822803515;6594.802155935329;6754.932450675528;6772.729090836311;6873.965630171817;6886.51794374389;6942.791716248521;6959.791206263719;6980.162380514269;6986.790396288119;6995.615241161683;6661;6689.5986240825705;6695.765648202289;6700.530962832555;6710.83222919431;6479.967600161969;6600.63696496678;6610.636414997029;6611.966940165268;6612.669366531558;6970.337817907291;6970.860582788418;6978.406835419046;6979.930200697928;6980.860382792417;4568.086382723535;4598.724076555283;4601.309803529363;4601.93097103537;4606.032733126081;6582.407583317525;6700.49746269022;6710.496712746662;6729.663516824237;6740.258571557027;6535.248446428532;6559.868802624016;6560.8359791005605;6572.4084832365315;6573.079768832463;6521.152250207443;6545.312742162005;6547.279799222177;6558.049082883051;6562.146920900253;6287.465565426807;6428.774992875227;6443.516736244706;6445.387688169616;6448.226212854487;6561.835954100995;6567.113439685581;6573.5398522103;6577.079208910852;6577.375149360803;6397.520185985976;6400.615963042233;6404.871902561829;6410.743570257137;6414.711337989708 10:04:33 INFO - 2016-02-01 10:04:33,071 DEBUG : BROWSER_OUTPUT: |5;yui.html;833.704035067551;890.6660002499067;948.9134940493134;951.3973027191292;968.1383568623921;13993.790093148611;14025.789613155797;14039.649008774786;14046;14050.859491405083;13479.742900268902;13623.93188034061;13671.248081355521;13698.246596437191;13710.314484275772;884.6240347852154;898.640543782489;900.5542256583001;902.3773596218621;903.5482258870564;896.3411892259185;900.0999000999001;901.8286525560155;902.3367824648877;903.421810041574;922.8200500902327;925.4354843545432;934.7336009237368;934.8878134623855;935.4013431403907;925.3615005646083;927.2767241551601;928.22029495224;929.5120061967453;929.6513807322254;675.3516624040926;677.2854638356532;679.9932000680029;681.3527149208222;681.9761308354184;12941.741165176738;12995.350232488337;13043.739125217537;13058.673533161747;13074.084814063019;11723.531058757639;11888.167828251939;11954.282743035359;12031.097667674872;12321.383930803513;10223.795524089477;10266.897331026668;10375.325603835727;10497.632582859564;10500.737481562946;3861.6717579005817;3887.1448281378052;3890.0663840678317;3923.3330333843314;3954.6440820326306;43498.130037399074;47471.287930681065;49898.25152622713;51142.7442862787;51191.23213151843;11125.443727813577;11142;11232.831507527393;11379.374134422686;11418.771624567627;19901.303454379027;19924.3026494072;19961.500962476053;19997.700034499496;20001.799982000284;7842.29419352261;7998.600069996477;8017.559034253172;8078.474899131537;8311.916880831235;4494.056248187851;4584.609589516372;4605.976970115128;4614.3309220163555;4723.031778485402;3026.8637911294045;3055.2667359833927;3058.98470507646;3061.0816754973866;3064.080775767261;565.135342925325;572.5391060196582;577.8382053025159;579.0677010013874;582.0309185206584;653.1345966594282;661.1339145719123;693.3378623414627;723.6098876762385;738.3576288628927;8676.175763302475;8809.33929955256;8918.866217006751;8983.955080224558;9064.184223419792;664.8803215421174;679.5514960126293;708.624429052603;729.7664747280819;730.1364306419829;4342.457192850894;4374.950011997098;4390.385346051556;4403.207422663887;4536.319552067216;61245.08132378018;61555.69222153861;62127.068093978625;62232.68883655643;62307.6884615574;51359.48038970772;53927;53954.73022634862;54043.72978135084;54540.727296363264;43680;45093;54389.45610543844;55463.445365546635;57240.99999999917;9155.221806146552;9194.448333100036;9374.95312523433;9421.528923553931;9440.008799076273;35409.698369605896;36211.637883620824;36717;36790.08024799402;37712;46820.531794681614;46838.29742553933;47046.52953470559;47261.763691181324;47327.52672473231;10908.181886358396;11112.555497779998;11187.552497899993;11250.7749845001;11271.267367621407;12829.166104203197;13369.997250206468;13379.665508361979;13504.054716170167;13580.660483487596;11738.647840564796;11804.58683946092;11899.881001189877;12132.090093242865;12343.75312493763;11833.763324733629;11980.161388703056;12027.45876435545;12142.696432589257;12319.692007699521;11397.259178153394;11570.710732231762;11775.275098896735;12092.334921579397;12137.514499419924;10827.458627068772;10950.178736594627;10990.120790336914;10994.505247263733;11239.213255072067;9564.378315409476;9966.152877005246;9998.450085245382;10184.787279759488;10703.19726020536 10:04:33 INFO - 2016-02-01 10:04:33,071 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:04:33 INFO - 2016-02-01 10:04:33,072 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:04:33 INFO - 2016-02-01 10:04:33,072 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,927 10:04:33 INFO - 2016-02-01 10:04:33,072 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:04:33 INFO - 2016-02-01 10:04:33,072 DEBUG : BROWSER_OUTPUT: __startTimestamp1454349873060__endTimestamp 10:04:33 INFO - 2016-02-01 10:04:33,072 DEBUG : BROWSER_OUTPUT: 10:04:33 INFO - 2016-02-01 10:04:33,072 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:04:33 INFO - 2016-02-01 10:04:33,072 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:04:33 INFO - 2016-02-01 10:04:33,073 DEBUG : BROWSER_OUTPUT: 10:04:33 INFO - 2016-02-01 10:04:33,073 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5481.10 Median:5670.46 stddev:599.64 (10.6%) stddev-sans-first:575.97 10:04:33 INFO - 2016-02-01 10:04:33,074 DEBUG : BROWSER_OUTPUT: Values: 3275.3 3313.2 3383.0 3396.0 3396.0 5520.4 5548.2 5564.6 5566.1 5580.2 5503.1 5524.8 5573.3 5583.4 5594.4 4835.7 5058.2 5088.9 5157.5 5172.0 4918.7 4975.3 4984.9 4987.3 4989.3 4965.6 4968.1 4971.7 5056.1 5088.4 5044.6 5070.2 5076.1 5083.8 5106.0 4927.7 5003.9 5037.1 5047.5 5054.6 5169.3 5221.5 5279.3 5316.9 5326.4 5852.2 5888.4 5891.2 5892.5 5902.3 5597.7 5926.7 5931.9 5934.8 5938.2 5368.8 5473.3 5532.8 5534.3 5559.7 5997.2 5999.8 6002.0 6003.2 6013.4 5624.3 5721.3 5751.5 5811.1 5812.8 5869.8 5952.6 5954.0 5962.7 5998.0 5859.5 5895.8 5910.0 5911.1 5911.8 5614.6 5652.4 5727.0 5896.3 5905.9 4510.4 4513.2 4514.7 4539.6 4541.5 4056.1 4061.3 4061.5 4065.7 4083.4 5386.4 5542.5 5557.8 5614.8 5621.4 5877.8 5890.7 5923.6 5928.3 5938.6 5647.3 5661.3 5665.9 5672.3 5681.7 5017.6 5070.1 5132.6 5176.3 5180.9 6061.8 6103.3 6104.5 6107.3 6127.5 5873.0 5960.2 5966.6 5967.4 5970.9 5885.9 5941.1 6011.7 6146.1 6156.9 5809.1 5890.4 5891.2 5902.6 5919.0 5964.4 5994.4 5995.4 5996.5 5997.6 5469.6 5640.0 5667.9 5745.8 5839.1 5770.1 5826.6 5828.6 5832.1 5834.0 5723.1 5736.2 5741.1 5743.4 5746.1 5600.7 5680.7 5702.6 5833.0 5852.7 5648.2 5670.5 5672.0 5680.9 5730.4 10:04:33 INFO - 2016-02-01 10:04:33,074 DEBUG : BROWSER_OUTPUT: 10:04:33 INFO - 2016-02-01 10:04:33,074 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:50516.72 Median:184813.54 stddev:81183.24 (43.9%) stddev-sans-first:81324.44 10:04:33 INFO - 2016-02-01 10:04:33,075 DEBUG : BROWSER_OUTPUT: Values: 592.1 627.5 633.2 636.0 639.4 40601.6 41688.0 41727.4 41769.8 41829.6 45636.0 45717.5 46198.5 46239.5 46275.8 8081.0 8186.0 8986.9 9241.5 10548.3 10813.2 10920.2 10921.4 10947.4 10954.4 10878.6 10976.3 10980.7 10987.2 10989.3 10824.7 10907.1 10922.0 10928.6 10930.0 10688.5 10837.1 10844.5 10845.3 10846.9 42587.4 42857.6 42928.0 43053.1 43107.4 3577.3 3619.1 3729.2 4035.9 4256.7 32431.5 32994.2 33028.0 33037.0 33401.2 4287.4 4320.7 4343.0 4386.2 4547.1 314023.0 314862.0 315531.0 315532.0 315854.0 64026.7 65350.7 72499.3 73102.0 73691.0 64750.7 64755.0 64972.7 65021.0 65207.3 17538.7 17773.6 17785.2 17834.0 17834.2 12878.5 13083.2 13086.1 13166.3 13168.3 21686.2 21927.2 22010.3 22049.7 22066.8 7857.7 8053.8 8073.3 8168.0 8178.8 1033.5 1058.6 1078.4 1119.5 1140.0 30489.2 30517.8 30729.2 31097.5 31140.0 1105.9 1123.9 1183.1 1200.6 1284.3 13322.5 14510.0 14614.6 14941.6 16455.5 366008.0 374899.0 376189.0 376260.0 376519.0 58542.0 58883.0 58939.0 59074.0 59220.7 1466.0 1481.4 1487.2 1497.7 1504.5 30592.2 30858.4 31299.5 31352.7 31595.7 55734.4 56982.7 57084.4 57156.7 57166.4 221707.0 223717.0 223829.0 224634.0 225347.0 31011.5 31420.4 34257.5 45139.8 45278.3 48129.3 50674.2 51209.7 52106.7 52485.5 41524.4 41932.4 42017.6 42380.4 43232.8 39089.8 42267.0 42269.8 44331.8 45925.3 40606.8 40631.2 40861.4 41228.4 44949.3 38855.4 39546.2 41016.4 42803.6 43770.6 32445.7 32636.3 32936.5 33045.7 33093.8 10:04:33 INFO - 2016-02-01 10:04:33,075 DEBUG : BROWSER_OUTPUT: 10:04:33 INFO - 2016-02-01 10:04:33,075 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:33728.40 Median:12370.53 stddev:104768.30 (846.9%) stddev-sans-first:105032.24 10:04:33 INFO - 2016-02-01 10:04:33,076 DEBUG : BROWSER_OUTPUT: Values: 361.0 367.1 374.3 382.1 388.2 15209.2 15768.6 17122.3 20128.1 20510.6 18082.0 18138.9 18426.3 18609.4 18611.1 4592.1 6070.7 6198.5 6225.0 6226.5 4816.5 4844.5 4853.4 6773.4 7007.5 6818.6 6956.5 6978.6 6979.5 6984.9 6867.3 6897.4 6901.4 6906.8 6911.1 6166.1 6173.0 6173.4 6175.8 6301.2 22574.7 22923.2 23299.0 23369.9 24309.1 2540.3 2548.6 2551.9 2672.3 2779.6 14785.6 14809.3 14845.6 15082.2 15128.5 2082.9 2131.1 2158.6 2160.5 2166.4 74140.0 78635.0 79527.0 80118.2 80328.2 15378.0 16377.8 16496.2 16499.3 16549.7 25086.7 25145.5 25278.2 25394.2 25437.1 9827.6 9874.8 9881.9 9923.8 9930.5 8379.7 8416.4 8427.5 8453.7 8503.4 4415.6 6723.9 8077.6 8144.6 8222.9 1785.8 1806.8 1821.6 1835.2 1884.7 828.8 983.0 1007.6 1015.7 1078.2 17380.7 17703.0 17775.7 18038.4 18262.0 977.5 997.7 1022.7 1041.3 1046.8 10100.6 10329.9 10370.4 10376.2 10414.0 631717.0 632187.0 646094.0 647546.0 651079.0 82621.0 84412.0 85071.0 86838.0 87923.0 1142.8 1154.6 1155.0 1156.5 1174.6 15633.1 15972.2 16176.2 16343.2 16943.9 20549.1 35259.8 36020.5 37743.0 39121.8 48676.0 49688.8 50065.2 50641.2 52143.2 9925.7 10014.4 10184.5 10211.9 10226.7 11964.3 12022.0 14274.8 18564.0 18805.2 14275.1 14416.6 15725.2 15757.1 15786.7 14946.5 15232.4 15524.7 15909.3 15958.0 15279.9 15345.0 15931.4 16209.0 16452.8 10171.5 10210.0 10252.9 10465.9 10472.4 14525.5 14662.6 14853.0 15617.5 16011.2 10:04:33 INFO - 2016-02-01 10:04:33,077 DEBUG : BROWSER_OUTPUT: 10:04:33 INFO - 2016-02-01 10:04:33,077 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5436.77 Median:6461.98 stddev:2816.37 (43.6%) stddev-sans-first:2808.69 10:04:33 INFO - 2016-02-01 10:04:33,077 DEBUG : BROWSER_OUTPUT: Values: 1496.0 1501.1 1648.0 1791.7 1811.2 7431.6 7803.5 7817.4 7824.2 7828.9 6956.3 7083.6 7174.5 7402.2 7767.2 2244.1 2252.7 2281.0 2282.9 2284.1 2004.4 2260.6 2290.5 2320.9 2322.6 1986.8 2221.7 2255.0 2263.5 2263.9 2132.4 2154.7 2164.2 2170.3 2175.2 2238.8 2254.6 2258.6 2260.4 2264.7 7711.1 7761.0 7769.0 7781.8 7793.2 4411.5 4461.7 4497.7 4507.7 4512.4 3021.6 3042.9 3066.9 3071.9 3085.8 1058.3 1067.0 1076.8 1080.0 1104.4 10533.4 10558.5 10559.3 10561.9 10572.9 3999.1 4021.1 4023.3 4094.1 4116.8 9015.5 9103.0 9115.9 9116.9 9123.7 4451.1 4461.9 4490.9 4494.2 4501.0 4113.6 4152.5 4154.5 4157.5 4157.9 3690.2 3751.9 3754.6 3759.2 3786.7 1086.4 1211.8 1218.5 1223.7 1230.6 970.1 1166.9 1181.6 1349.6 1434.3 7347.7 7370.8 7400.0 7410.2 7474.2 1135.4 1141.6 1148.5 1161.4 1181.5 5761.3 5866.2 5871.4 5872.2 5881.2 9111.7 9121.0 9201.4 9332.9 9381.0 9151.1 9157.8 9179.0 9264.5 9280.6 7400.3 7400.6 7564.0 7572.3 7587.3 7474.0 7560.4 7611.4 7620.5 7622.5 8547.6 8664.6 8763.7 8776.3 8778.3 8522.7 8817.7 8881.0 8890.6 8902.0 6671.1 6713.7 6742.3 6744.2 6745.6 7065.1 7075.2 7108.8 7152.1 7157.6 6402.8 6711.3 6818.3 7144.1 7238.7 6460.3 6656.7 6876.8 6889.8 6947.4 7004.4 7005.0 7041.0 7045.7 7048.8 6463.6 6506.7 6507.5 6510.5 6518.4 6603.9 6636.5 6646.3 6647.3 6653.8 10:04:33 INFO - 2016-02-01 10:04:33,077 DEBUG : BROWSER_OUTPUT: 10:04:33 INFO - 2016-02-01 10:04:33,077 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5413.32 Median:6256.05 stddev:1638.58 (26.2%) stddev-sans-first:1598.13 10:04:33 INFO - 2016-02-01 10:04:33,077 DEBUG : BROWSER_OUTPUT: Values: 329.4 336.4 337.7 344.0 347.2 6021.5 6056.5 6058.8 6097.1 6115.3 6010.3 6011.6 6013.3 6023.7 6029.4 4615.0 4624.0 4624.7 4626.1 4628.5 4498.8 4628.3 4631.2 4655.9 4658.5 4588.6 4589.8 4596.7 4598.0 4608.3 4422.0 4528.8 4546.8 4603.0 4610.8 4073.0 4100.2 4104.9 4105.7 4111.0 5709.5 5709.9 5715.1 5715.2 5727.2 5144.7 5259.8 5311.0 5435.8 5444.1 6362.5 6374.1 6374.4 6376.9 6387.7 4542.6 4547.3 4549.9 4550.9 4554.7 6491.8 6596.9 6675.0 6679.9 6690.9 4521.4 4538.2 4564.2 4565.3 4567.1 4615.7 4621.4 4621.7 4624.5 4624.8 5315.1 5321.6 5326.7 5331.1 5334.2 6314.5 6419.0 6425.4 6439.5 6444.4 1640.3 1665.5 1666.6 1667.8 1668.5 1095.3 1113.1 1118.2 1132.5 1155.8 6359.3 6359.9 6361.6 6363.2 6363.7 6630.2 6631.4 6636.8 6641.0 6646.2 6224.6 6324.0 6348.3 6363.7 6365.6 3548.8 3588.7 3601.1 3615.8 3620.3 6986.5 6992.5 7000.2 7001.8 7008.9 6594.8 6754.9 6772.7 6874.0 6886.5 6942.8 6959.8 6980.2 6986.8 6995.6 6661.0 6689.6 6695.8 6700.5 6710.8 6480.0 6600.6 6610.6 6612.0 6612.7 6970.3 6970.9 6978.4 6979.9 6980.9 4568.1 4598.7 4601.3 4601.9 4606.0 6582.4 6700.5 6710.5 6729.7 6740.3 6535.2 6559.9 6560.8 6572.4 6573.1 6521.2 6545.3 6547.3 6558.0 6562.1 6287.5 6428.8 6443.5 6445.4 6448.2 6561.8 6567.1 6573.5 6577.1 6577.4 6397.5 6400.6 6404.9 6410.7 6414.7 10:04:33 INFO - 2016-02-01 10:04:33,077 DEBUG : BROWSER_OUTPUT: 10:04:33 INFO - 2016-02-01 10:04:33,077 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14556.12 Median:4560.46 stddev:16908.28 (370.8%) stddev-sans-first:16924.31 10:04:33 INFO - 2016-02-01 10:04:33,079 DEBUG : BROWSER_OUTPUT: Values: 833.7 890.7 948.9 951.4 968.1 13993.8 14025.8 14039.6 14046.0 14050.9 13479.7 13623.9 13671.2 13698.2 13710.3 884.6 898.6 900.6 902.4 903.5 896.3 900.1 901.8 902.3 903.4 922.8 925.4 934.7 934.9 935.4 925.4 927.3 928.2 929.5 929.7 675.4 677.3 680.0 681.4 682.0 12941.7 12995.4 13043.7 13058.7 13074.1 11723.5 11888.2 11954.3 12031.1 12321.4 10223.8 10266.9 10375.3 10497.6 10500.7 3861.7 3887.1 3890.1 3923.3 3954.6 43498.1 47471.3 49898.3 51142.7 51191.2 11125.4 11142.0 11232.8 11379.4 11418.8 19901.3 19924.3 19961.5 19997.7 20001.8 7842.3 7998.6 8017.6 8078.5 8311.9 4494.1 4584.6 4606.0 4614.3 4723.0 3026.9 3055.3 3059.0 3061.1 3064.1 565.1 572.5 577.8 579.1 582.0 653.1 661.1 693.3 723.6 738.4 8676.2 8809.3 8918.9 8984.0 9064.2 664.9 679.6 708.6 729.8 730.1 4342.5 4375.0 4390.4 4403.2 4536.3 61245.1 61555.7 62127.1 62232.7 62307.7 51359.5 53927.0 53954.7 54043.7 54540.7 43680.0 45093.0 54389.5 55463.4 57241.0 9155.2 9194.4 9375.0 9421.5 9440.0 35409.7 36211.6 36717.0 36790.1 37712.0 46820.5 46838.3 47046.5 47261.8 47327.5 10908.2 11112.6 11187.6 11250.8 11271.3 12829.2 13370.0 13379.7 13504.1 13580.7 11738.6 11804.6 11899.9 12132.1 12343.8 11833.8 11980.2 12027.5 12142.7 12319.7 11397.3 11570.7 11775.3 12092.3 12137.5 10827.5 10950.2 10990.1 10994.5 11239.2 9564.4 9966.2 9998.5 10184.8 10703.2 10:04:33 INFO - 2016-02-01 10:04:33,079 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:04:33 INFO - 2016-02-01 10:04:33,079 DEBUG : BROWSER_OUTPUT: 10:04:33 INFO - 2016-02-01 10:04:33,630 INFO : Browser exited with error code: 0 10:04:33 INFO - 2016-02-01 10:04:33,651 INFO : Completed test dromaeo_css (00:18:29) 10:04:33 INFO - 2016-02-01 10:04:33,651 INFO : Starting test kraken 10:04:33 INFO - 2016-02-01 10:04:33,651 DEBUG : operating with platform_type : linux_ 10:04:33 INFO - 2016-02-01 10:04:33,652 INFO : Initialising browser for kraken test... 10:04:33 INFO - 2016-02-01 10:04:33,658 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQnllQe/profile http://localhost:37409/getInfo.html 10:04:37 INFO - 2016-02-01 10:04:37,679 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:04:37 INFO - 2016-02-01 10:04:37,680 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:04:37 INFO - 2016-02-01 10:04:37,680 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:04:37 INFO - 2016-02-01 10:04:37,680 DEBUG : BROWSER_OUTPUT: __metrics 10:04:37 INFO - 2016-02-01 10:04:37,857 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] 10:04:38 INFO - 2016-02-01 10:04:38,529 INFO : Browser initialized. 10:04:38 INFO - 2016-02-01 10:04:38,530 INFO : Running cycle 1/1 for kraken test... 10:04:38 INFO - 2016-02-01 10:04:38,530 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQnllQe/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:04:50 INFO - 2016-02-01 10:04:50,283 DEBUG : BROWSER_OUTPUT: RSS: Main: 134410240 10:04:50 INFO - 2016-02-01 10:04:50,283 DEBUG : BROWSER_OUTPUT: 10:04:52 INFO - 2016-02-01 10:04:52,738 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37409/tests/kraken/driver.html?testName=audio-beat-detection) 10:04:53 INFO - 2016-02-01 10:04:53,321 DEBUG : BROWSER_OUTPUT: RSS: Main: 166903808 10:04:53 INFO - 2016-02-01 10:04:53,321 DEBUG : BROWSER_OUTPUT: 10:04:55 INFO - 2016-02-01 10:04:55,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37409/tests/kraken/driver.html?testName=audio-dft) 10:04:56 INFO - 2016-02-01 10:04:56,470 DEBUG : BROWSER_OUTPUT: RSS: Main: 165322752 10:04:56 INFO - 2016-02-01 10:04:56,470 DEBUG : BROWSER_OUTPUT: 10:04:59 INFO - 2016-02-01 10:04:59,290 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37409/tests/kraken/driver.html?testName=audio-fft) 10:04:59 INFO - 2016-02-01 10:04:59,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 161472512 10:04:59 INFO - 2016-02-01 10:04:59,852 DEBUG : BROWSER_OUTPUT: 10:05:01 INFO - 2016-02-01 10:05:01,849 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37409/tests/kraken/driver.html?testName=audio-oscillator) 10:05:02 INFO - 2016-02-01 10:05:02,415 DEBUG : BROWSER_OUTPUT: RSS: Main: 162574336 10:05:02 INFO - 2016-02-01 10:05:02,415 DEBUG : BROWSER_OUTPUT: 10:05:04 INFO - 2016-02-01 10:05:04,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37409/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:05:05 INFO - 2016-02-01 10:05:05,154 DEBUG : BROWSER_OUTPUT: RSS: Main: 160231424 10:05:05 INFO - 2016-02-01 10:05:05,155 DEBUG : BROWSER_OUTPUT: 10:05:08 INFO - 2016-02-01 10:05:08,014 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37409/tests/kraken/driver.html?testName=imaging-darkroom) 10:05:08 INFO - 2016-02-01 10:05:08,587 DEBUG : BROWSER_OUTPUT: RSS: Main: 161615872 10:05:08 INFO - 2016-02-01 10:05:08,588 DEBUG : BROWSER_OUTPUT: 10:05:11 INFO - 2016-02-01 10:05:11,899 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37409/tests/kraken/driver.html?testName=imaging-desaturate) 10:05:12 INFO - 2016-02-01 10:05:12,464 DEBUG : BROWSER_OUTPUT: RSS: Main: 161153024 10:05:12 INFO - 2016-02-01 10:05:12,464 DEBUG : BROWSER_OUTPUT: 10:05:15 INFO - 2016-02-01 10:05:15,162 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37409/tests/kraken/driver.html?testName=json-parse-financial) 10:05:15 INFO - 2016-02-01 10:05:15,729 DEBUG : BROWSER_OUTPUT: RSS: Main: 162406400 10:05:15 INFO - 2016-02-01 10:05:15,729 DEBUG : BROWSER_OUTPUT: 10:05:17 INFO - 2016-02-01 10:05:17,264 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37409/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:05:17 INFO - 2016-02-01 10:05:17,817 DEBUG : BROWSER_OUTPUT: RSS: Main: 165163008 10:05:17 INFO - 2016-02-01 10:05:17,817 DEBUG : BROWSER_OUTPUT: 10:05:19 INFO - 2016-02-01 10:05:19,553 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37409/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:05:20 INFO - 2016-02-01 10:05:20,155 DEBUG : BROWSER_OUTPUT: RSS: Main: 164683776 10:05:20 INFO - 2016-02-01 10:05:20,155 DEBUG : BROWSER_OUTPUT: 10:05:22 INFO - 2016-02-01 10:05:22,168 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37409/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:05:22 INFO - 2016-02-01 10:05:22,749 DEBUG : BROWSER_OUTPUT: RSS: Main: 169578496 10:05:22 INFO - 2016-02-01 10:05:22,749 DEBUG : BROWSER_OUTPUT: 10:05:25 INFO - 2016-02-01 10:05:25,083 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:05:25 INFO - 2016-02-01 10:05:25,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 177815552 10:05:25 INFO - 2016-02-01 10:05:25,665 DEBUG : BROWSER_OUTPUT: 10:05:28 INFO - 2016-02-01 10:05:28,128 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:05:28 INFO - 2016-02-01 10:05:28,697 DEBUG : BROWSER_OUTPUT: RSS: Main: 176050176 10:05:28 INFO - 2016-02-01 10:05:28,697 DEBUG : BROWSER_OUTPUT: 10:05:30 INFO - 2016-02-01 10:05:30,330 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37409/tests/kraken/driver.html?testName=ai-astar) 10:05:30 INFO - 2016-02-01 10:05:30,581 DEBUG : BROWSER_OUTPUT: RSS: Main: 233332736 10:05:30 INFO - 2016-02-01 10:05:30,581 DEBUG : BROWSER_OUTPUT: 10:05:30 INFO - 2016-02-01 10:05:30,581 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:05:30 INFO - 2016-02-01 10:05:30,581 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:05:30 INFO - 2016-02-01 10:05:30,581 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:05:30 INFO - 2016-02-01 10:05:30,581 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:05:30 INFO - 2016-02-01 10:05:30,581 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;103;108;110;110;99;109;108;108 10:05:30 INFO - 2016-02-01 10:05:30,581 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;129;160;159;122;153;152;122;165;128 10:05:30 INFO - 2016-02-01 10:05:30,581 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;166;160;158;161;159;160;162;161;159 10:05:30 INFO - 2016-02-01 10:05:30,581 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;70;150;74;70;70;71;160;71 10:05:30 INFO - 2016-02-01 10:05:30,582 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;145;92;92;92;136;91;92;142 10:05:30 INFO - 2016-02-01 10:05:30,582 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;109;109 10:05:30 INFO - 2016-02-01 10:05:30,582 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;146;145;145;147;145;146;145;145 10:05:30 INFO - 2016-02-01 10:05:30,582 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;96;95;95;96;96;95;95 10:05:30 INFO - 2016-02-01 10:05:30,582 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;57;59;57;57;58;59;57;55;56 10:05:30 INFO - 2016-02-01 10:05:30,583 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;65;65;64;65;64;64;64;64;64 10:05:30 INFO - 2016-02-01 10:05:30,583 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;76;77;79;80;79;77;77;78;78;77 10:05:30 INFO - 2016-02-01 10:05:30,584 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;112;115;121;109;117;113;119;109;112;113 10:05:30 INFO - 2016-02-01 10:05:30,584 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;134;142;144;142;142;144;140;145;143 10:05:30 INFO - 2016-02-01 10:05:30,584 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;65;62;64;63;65;64;63;61;62 10:05:30 INFO - 2016-02-01 10:05:30,584 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:05:30 INFO - 2016-02-01 10:05:30,584 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:05:30 INFO - 2016-02-01 10:05:30,584 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,901 10:05:30 INFO - 2016-02-01 10:05:30,584 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:05:30 INFO - 2016-02-01 10:05:30,584 DEBUG : BROWSER_OUTPUT: __startTimestamp1454349930580__endTimestamp 10:05:30 INFO - 2016-02-01 10:05:30,585 DEBUG : BROWSER_OUTPUT: 10:05:30 INFO - 2016-02-01 10:05:30,588 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:05:30 INFO - 2016-02-01 10:05:30,588 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:05:30 INFO - 2016-02-01 10:05:30,588 DEBUG : BROWSER_OUTPUT: 10:05:30 INFO - 2016-02-01 10:05:30,588 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.30 Median:109.50 stddev:3.56 (3.3%) stddev-sans-first:3.77 10:05:30 INFO - 2016-02-01 10:05:30,588 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 103.0 108.0 110.0 110.0 99.0 109.0 108.0 108.0 10:05:30 INFO - 2016-02-01 10:05:30,589 DEBUG : BROWSER_OUTPUT: 10:05:30 INFO - 2016-02-01 10:05:30,589 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.30 Median:153.00 stddev:16.98 (11.1%) stddev-sans-first:17.72 10:05:30 INFO - 2016-02-01 10:05:30,589 DEBUG : BROWSER_OUTPUT: Values: 153.0 129.0 160.0 159.0 122.0 153.0 152.0 122.0 165.0 128.0 10:05:30 INFO - 2016-02-01 10:05:30,589 DEBUG : BROWSER_OUTPUT: 10:05:30 INFO - 2016-02-01 10:05:30,589 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:2.25 (1.4%) stddev-sans-first:2.35 10:05:30 INFO - 2016-02-01 10:05:30,589 DEBUG : BROWSER_OUTPUT: Values: 162.0 166.0 160.0 158.0 161.0 159.0 160.0 162.0 161.0 159.0 10:05:30 INFO - 2016-02-01 10:05:30,589 DEBUG : BROWSER_OUTPUT: 10:05:30 INFO - 2016-02-01 10:05:30,589 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.90 Median:71.00 stddev:35.46 (49.9%) stddev-sans-first:37.08 10:05:30 INFO - 2016-02-01 10:05:30,589 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 70.0 150.0 74.0 70.0 70.0 71.0 160.0 71.0 10:05:30 INFO - 2016-02-01 10:05:30,589 DEBUG : BROWSER_OUTPUT: 10:05:30 INFO - 2016-02-01 10:05:30,589 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.80 Median:92.00 stddev:23.71 (25.8%) stddev-sans-first:24.61 10:05:30 INFO - 2016-02-01 10:05:30,590 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 145.0 92.0 92.0 92.0 136.0 91.0 92.0 142.0 10:05:30 INFO - 2016-02-01 10:05:30,590 DEBUG : BROWSER_OUTPUT: 10:05:30 INFO - 2016-02-01 10:05:30,590 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 10:05:30 INFO - 2016-02-01 10:05:30,590 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 10:05:30 INFO - 2016-02-01 10:05:30,590 DEBUG : BROWSER_OUTPUT: 10:05:30 INFO - 2016-02-01 10:05:30,590 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 10:05:30 INFO - 2016-02-01 10:05:30,590 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 146.0 145.0 145.0 147.0 145.0 146.0 145.0 145.0 10:05:30 INFO - 2016-02-01 10:05:30,590 DEBUG : BROWSER_OUTPUT: 10:05:30 INFO - 2016-02-01 10:05:30,590 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 10:05:30 INFO - 2016-02-01 10:05:30,590 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 10:05:30 INFO - 2016-02-01 10:05:30,590 DEBUG : BROWSER_OUTPUT: 10:05:30 INFO - 2016-02-01 10:05:30,591 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.00 stddev:1.23 (2.2%) stddev-sans-first:1.30 10:05:30 INFO - 2016-02-01 10:05:30,591 DEBUG : BROWSER_OUTPUT: Values: 57.0 57.0 59.0 57.0 57.0 58.0 59.0 57.0 55.0 56.0 10:05:30 INFO - 2016-02-01 10:05:30,591 DEBUG : BROWSER_OUTPUT: 10:05:30 INFO - 2016-02-01 10:05:30,591 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 10:05:30 INFO - 2016-02-01 10:05:30,591 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 65.0 64.0 65.0 64.0 64.0 64.0 64.0 64.0 10:05:30 INFO - 2016-02-01 10:05:30,591 DEBUG : BROWSER_OUTPUT: 10:05:30 INFO - 2016-02-01 10:05:30,591 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:77.80 Median:78.00 stddev:1.23 (1.6%) stddev-sans-first:1.12 10:05:30 INFO - 2016-02-01 10:05:30,591 DEBUG : BROWSER_OUTPUT: Values: 76.0 77.0 79.0 80.0 79.0 77.0 77.0 78.0 78.0 77.0 10:05:30 INFO - 2016-02-01 10:05:30,591 DEBUG : BROWSER_OUTPUT: 10:05:30 INFO - 2016-02-01 10:05:30,591 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:114.00 Median:114.00 stddev:4.00 (3.5%) stddev-sans-first:4.18 10:05:30 INFO - 2016-02-01 10:05:30,592 DEBUG : BROWSER_OUTPUT: Values: 112.0 115.0 121.0 109.0 117.0 113.0 119.0 109.0 112.0 113.0 10:05:30 INFO - 2016-02-01 10:05:30,592 DEBUG : BROWSER_OUTPUT: 10:05:30 INFO - 2016-02-01 10:05:30,592 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.30 Median:142.50 stddev:3.43 (2.4%) stddev-sans-first:3.27 10:05:30 INFO - 2016-02-01 10:05:30,592 DEBUG : BROWSER_OUTPUT: Values: 137.0 134.0 142.0 144.0 142.0 142.0 144.0 140.0 145.0 143.0 10:05:30 INFO - 2016-02-01 10:05:30,592 DEBUG : BROWSER_OUTPUT: 10:05:30 INFO - 2016-02-01 10:05:30,592 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:64.00 stddev:1.43 (2.2%) stddev-sans-first:1.39 10:05:30 INFO - 2016-02-01 10:05:30,592 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 62.0 64.0 63.0 65.0 64.0 63.0 61.0 62.0 10:05:30 INFO - 2016-02-01 10:05:30,592 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:05:30 INFO - 2016-02-01 10:05:30,592 DEBUG : BROWSER_OUTPUT: 10:05:31 INFO - 2016-02-01 10:05:31,258 INFO : Browser exited with error code: 0 10:05:31 INFO - 2016-02-01 10:05:31,309 INFO : Completed test kraken (00:00:57) 10:05:31 INFO - 2016-02-01 10:05:31,309 INFO : Starting test v8_7 10:05:31 INFO - 2016-02-01 10:05:31,309 DEBUG : operating with platform_type : linux_ 10:05:31 INFO - 2016-02-01 10:05:31,309 INFO : Initialising browser for v8_7 test... 10:05:31 INFO - 2016-02-01 10:05:31,316 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpui6qxr/profile http://localhost:37409/getInfo.html 10:05:35 INFO - 2016-02-01 10:05:35,376 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:05:35 INFO - 2016-02-01 10:05:35,377 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:05:35 INFO - 2016-02-01 10:05:35,377 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:05:35 INFO - 2016-02-01 10:05:35,377 DEBUG : BROWSER_OUTPUT: __metrics 10:05:35 INFO - 2016-02-01 10:05:35,533 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] 10:05:36 INFO - 2016-02-01 10:05:36,186 INFO : Browser initialized. 10:05:36 INFO - 2016-02-01 10:05:36,187 INFO : Running cycle 1/1 for v8_7 test... 10:05:36 INFO - 2016-02-01 10:05:36,187 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpui6qxr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:05:47 INFO - 2016-02-01 10:05:47,971 DEBUG : BROWSER_OUTPUT: RSS: Main: 134303744 10:05:47 INFO - 2016-02-01 10:05:47,971 DEBUG : BROWSER_OUTPUT: 10:06:09 INFO - 2016-02-01 10:06:09,311 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37409/tests/v8_7/run.html (next: http://localhost:37409/tests/v8_7/run.html) 10:06:09 INFO - 2016-02-01 10:06:09,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 426426368 10:06:09 INFO - 2016-02-01 10:06:09,562 DEBUG : BROWSER_OUTPUT: 10:06:09 INFO - 2016-02-01 10:06:09,563 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:06:09 INFO - 2016-02-01 10:06:09,563 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:06:09 INFO - 2016-02-01 10:06:09,563 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:06:09 INFO - 2016-02-01 10:06:09,563 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:06:09 INFO - 2016-02-01 10:06:09,563 DEBUG : BROWSER_OUTPUT: |0;Richards;168.03898504453034 10:06:09 INFO - 2016-02-01 10:06:09,564 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;166.47244880972198 10:06:09 INFO - 2016-02-01 10:06:09,564 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.56388034665923 10:06:09 INFO - 2016-02-01 10:06:09,564 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 10:06:09 INFO - 2016-02-01 10:06:09,564 DEBUG : BROWSER_OUTPUT: |4;RayTrace;950.5703422053232 10:06:09 INFO - 2016-02-01 10:06:09,565 DEBUG : BROWSER_OUTPUT: |5;Earley;537.6344086021505 10:06:09 INFO - 2016-02-01 10:06:09,565 DEBUG : BROWSER_OUTPUT: |6;Boyer;10562.5 10:06:09 INFO - 2016-02-01 10:06:09,565 DEBUG : BROWSER_OUTPUT: |7;RegExp;26552.63157894737 10:06:09 INFO - 2016-02-01 10:06:09,565 DEBUG : BROWSER_OUTPUT: |8;Splay;514.8870636550308 10:06:09 INFO - 2016-02-01 10:06:09,565 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 10:06:09 INFO - 2016-02-01 10:06:09,565 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:06:09 INFO - 2016-02-01 10:06:09,566 DEBUG : BROWSER_OUTPUT: __startTimestamp1454349969561__endTimestamp 10:06:09 INFO - 2016-02-01 10:06:09,566 DEBUG : BROWSER_OUTPUT: 10:06:09 INFO - 2016-02-01 10:06:09,566 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:06:09 INFO - 2016-02-01 10:06:09,566 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:06:09 INFO - 2016-02-01 10:06:09,566 DEBUG : BROWSER_OUTPUT: 10:06:09 INFO - 2016-02-01 10:06:09,567 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.04 Median:168.04 stddev:0.00 (0.0%) 10:06:09 INFO - 2016-02-01 10:06:09,567 DEBUG : BROWSER_OUTPUT: Values: 168.0 10:06:09 INFO - 2016-02-01 10:06:09,567 DEBUG : BROWSER_OUTPUT: 10:06:09 INFO - 2016-02-01 10:06:09,567 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:166.47 Median:166.47 stddev:0.00 (0.0%) 10:06:09 INFO - 2016-02-01 10:06:09,567 DEBUG : BROWSER_OUTPUT: Values: 166.5 10:06:09 INFO - 2016-02-01 10:06:09,568 DEBUG : BROWSER_OUTPUT: 10:06:09 INFO - 2016-02-01 10:06:09,568 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.56 Median:279.56 stddev:0.00 (0.0%) 10:06:09 INFO - 2016-02-01 10:06:09,568 DEBUG : BROWSER_OUTPUT: Values: 279.6 10:06:09 INFO - 2016-02-01 10:06:09,569 DEBUG : BROWSER_OUTPUT: 10:06:09 INFO - 2016-02-01 10:06:09,569 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 10:06:09 INFO - 2016-02-01 10:06:09,569 DEBUG : BROWSER_OUTPUT: Values: 5186.5 10:06:09 INFO - 2016-02-01 10:06:09,569 DEBUG : BROWSER_OUTPUT: 10:06:09 INFO - 2016-02-01 10:06:09,569 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:950.57 Median:950.57 stddev:0.00 (0.0%) 10:06:09 INFO - 2016-02-01 10:06:09,571 DEBUG : BROWSER_OUTPUT: Values: 950.6 10:06:09 INFO - 2016-02-01 10:06:09,571 DEBUG : BROWSER_OUTPUT: 10:06:09 INFO - 2016-02-01 10:06:09,571 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:537.63 Median:537.63 stddev:0.00 (0.0%) 10:06:09 INFO - 2016-02-01 10:06:09,571 DEBUG : BROWSER_OUTPUT: Values: 537.6 10:06:09 INFO - 2016-02-01 10:06:09,571 DEBUG : BROWSER_OUTPUT: 10:06:09 INFO - 2016-02-01 10:06:09,571 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10562.50 Median:10562.50 stddev:0.00 (0.0%) 10:06:09 INFO - 2016-02-01 10:06:09,571 DEBUG : BROWSER_OUTPUT: Values: 10562.5 10:06:09 INFO - 2016-02-01 10:06:09,572 DEBUG : BROWSER_OUTPUT: 10:06:09 INFO - 2016-02-01 10:06:09,572 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26552.63 Median:26552.63 stddev:0.00 (0.0%) 10:06:09 INFO - 2016-02-01 10:06:09,572 DEBUG : BROWSER_OUTPUT: Values: 26552.6 10:06:09 INFO - 2016-02-01 10:06:09,572 DEBUG : BROWSER_OUTPUT: 10:06:09 INFO - 2016-02-01 10:06:09,572 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:514.89 Median:514.89 stddev:0.00 (0.0%) 10:06:09 INFO - 2016-02-01 10:06:09,572 DEBUG : BROWSER_OUTPUT: Values: 514.9 10:06:09 INFO - 2016-02-01 10:06:09,572 DEBUG : BROWSER_OUTPUT: 10:06:09 INFO - 2016-02-01 10:06:09,573 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 10:06:09 INFO - 2016-02-01 10:06:09,573 DEBUG : BROWSER_OUTPUT: Values: 4835.7 10:06:09 INFO - 2016-02-01 10:06:09,573 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:06:09 INFO - 2016-02-01 10:06:09,573 DEBUG : BROWSER_OUTPUT: 10:06:10 INFO - 2016-02-01 10:06:10,206 INFO : Browser exited with error code: 0 10:06:10 INFO - 2016-02-01 10:06:10,223 INFO : Completed test v8_7 (00:00:38) 10:06:10 INFO - 2016-02-01 10:06:10,636 INFO : Completed test suite (00:20:06) 10:06:10 INFO - 2016-02-01 10:06:10,636 DEBUG : Working with test: dromaeo_css 10:06:10 INFO - 2016-02-01 10:06:10,636 DEBUG : Generating results file: dromaeo_css 10:06:10 INFO - 2016-02-01 10:06:10,638 DEBUG : Working with test: kraken 10:06:10 INFO - 2016-02-01 10:06:10,638 DEBUG : Generating results file: kraken 10:06:10 INFO - 2016-02-01 10:06:10,638 INFO : javascript benchmark 10:06:10 INFO - 2016-02-01 10:06:10,638 DEBUG : Working with test: v8_7 10:06:10 INFO - 2016-02-01 10:06:10,638 DEBUG : Generating results file: v8_7 10:06:10 INFO - 2016-02-01 10:06:10,639 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:06:10 INFO - 2016-02-01 10:06:10,692 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 10:06:10 INFO - 2016-02-01 10:06:10,692 DEBUG : process_Request line: dromaeo_css 7446.94 graph.html#tests=[[72,53,35]] 10:06:10 INFO - 2016-02-01 10:06:10,693 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:06:10 INFO - 2016-02-01 10:06:10,725 DEBUG : process_Request line: kraken 1475.00 graph.html#tests=[[232,53,35]] 10:06:10 INFO - 2016-02-01 10:06:10,725 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:06:10 INFO - 2016-02-01 10:06:10,769 DEBUG : process_Request line: v8_7 23090.11 graph.html#tests=[[230,53,35]] 10:06:10 INFO - 2016-02-01 10:06:10,770 INFO : javascript benchmark 10:06:10 INFO - 2016-02-01 10:06:10,774 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3275.312184441267, 3313.2213929726495, 3383.01892451189, 3395.966040339596, 3395.998180536743, 5520.365158006831, 5548.195511650818, 5564.638298510599, 5566.137248726443, 5580.190872323511, 5503.064479038563, 5524.751386187621, 5573.331200255965, 5583.413741557129, 5594.356648985368, 4835.661503694742, 5058.190689489682, 5088.872778180556, 5157.510036546522, 5171.974140129313, 4918.655694101414, 4975.3283306753665, 4984.87537811554, 4987.326710894019, 4989.276554899556, 4965.627577931651, 4968.056069346831, 4971.726555039471, 5056.115179843531, 5088.389393272812, 5044.646874718771, 5070.163423035232, 5076.137056700333, 5083.7712302946275, 5105.974470127663, 4927.728974906378, 5003.92494112585, 5037.143685573461, 5047.545720885101, 5054.595632349403, 5169.276301317818, 5221.530062294374, 5279.260903473517, 5316.9202461963105, 5326.360836699582, 5852.15143804146, 5888.411158884121, 5891.234139561872, 5892.499137573312, 5902.2622172228475, 5597.692126933017, 5926.674032928187, 5931.851703707399, 5934.7922822701, 5938.198343223653, 5368.8389348319615, 5473.261109750172, 5532.75102620387, 5534.252875861787, 5559.694216818073, 5997.160397544348, 5999.760009599654, 6001.969990150022, 6003.159557661931, 6013.428724271187, 5624.29696287964, 5721.342045664718, 5751.4536119068625, 5811.070228763462, 5812.7674893003805, 5869.8239052828485, 5952.613080149777, 5954.01758709808, 5962.672053037125, 5998.040313549811, 5859.472647461749, 5895.764169433174, 5909.970450147722, 5911.113333000085, 5911.822645320647, 5614.63504872182, 5652.378238393773, 5727.0, 5896.292444906639, 5905.881882362329, 4510.391097201836, 4513.187626227311, 4514.6614003949835, 4539.614132798749, 4541.500434952152, 4056.127932494528, 4061.289274376972, 4061.4923134608175, 4065.654419374327, 4083.387491876183, 5386.380566234855, 5542.501174894198, 5557.833265002057, 5614.775408983676, 5621.353544342453, 5877.794277200277, 5890.67601281925, 5923.555733320019, 5928.288605367384, 5938.6436813791315, 5647.29408823897, 5661.2923384576925, 5665.915011274834, 5672.262605861211, 5681.687507187062, 5017.598592112622, 5070.087384270793, 5132.56373208274, 5176.327077479904, 5180.948190518122, 6061.7575296987625, 6103.298120716086, 6104.481119104837, 6107.328193898667, 6127.509799216052, 5873.0, 5960.195373624505, 5966.612170208922, 5967.433093856251, 5970.910436343545, 5885.911711324419, 5941.108833674811, 6011.729472173675, 6146.139540464428, 6156.907646385218, 5809.128630705428, 5890.410958904246, 5891.23413956183, 5902.61632993854, 5918.993771059017, 5964.433378829004, 5994.3705910878725, 5995.400459953969, 5996.4603185713495, 5997.610155339889, 5469.589780766538, 5640.041192997118, 5667.8866422672145, 5745.798897038583, 5839.124131380327, 5770.076787713946, 5826.563007774349, 5828.562857785768, 5832.096025116114, 5834.0, 5723.084306510938, 5736.196932429547, 5741.081426971665, 5743.396943321059, 5746.080627099644, 5600.663960162403, 5680.659160450221, 5702.572307077069, 5832.9708351457975, 5852.736626851717, 5648.23748793924, 5670.461306175906, 5671.971640141773, 5680.886382272414, 5730.426957304403], "unit": "ms", "name": "dojo.html", "value": 5443.076105873078}, {"lowerIsBetter": false, "replicates": [592.1236569876583, 627.504271625416, 633.21165149389, 635.9682015899207, 639.434100820774, 40601.59398406015, 41688.0, 41727.374089388686, 41769.79115104424, 41829.58170418302, 45636.0, 45717.54282457174, 46198.538014619844, 46239.53760462395, 46275.76862115693, 8081.0, 8186.0, 8986.865197022067, 9241.49171795551, 10548.261621686484, 10813.243072984895, 10920.235583509157, 10921.399323037229, 10947.397893115876, 10954.39750813705, 10878.564857405694, 10976.341419514814, 10980.725481862937, 10987.175961802857, 10989.340639561611, 10824.72938176544, 10907.127429805636, 10922.017018468296, 10928.562857485731, 10930.0, 10688.519016644192, 10837.133029357632, 10844.457777111193, 10845.295055821347, 10846.891531084746, 42587.36118958218, 42857.57142428567, 42928.0, 43053.138937221396, 43107.35338969918, 3577.338192434408, 3619.077135330474, 3729.1795804923145, 4035.8587798636113, 4256.702030857841, 32431.51352729711, 32994.17514562131, 33028.0, 33037.0, 33401.16497087568, 4287.442632457792, 4320.697551171419, 4343.0, 4386.174253723907, 4547.136044151601, 314023.0, 314862.0, 315531.0, 315532.0, 315853.99999999773, 64026.67986660037, 65350.673246633465, 72499.27500724925, 73102.0, 73691.0, 64750.67624661847, 64755.0, 64972.67513662401, 65021.0, 65207.347926520124, 17538.736918946226, 17773.555661108574, 17785.19966601506, 17834.0, 17834.19746111428, 12878.549250776177, 13083.215007099605, 13086.14940028895, 13166.341682915816, 13168.275744834125, 21686.24098156557, 21927.232546860785, 22010.33968980933, 22049.669254961187, 22066.779332206792, 7857.685692572348, 8053.758387248392, 8073.31376832964, 8167.959160204161, 8178.836423271501, 1033.503918119307, 1058.6347710040025, 1078.3745427651943, 1119.5186069989982, 1139.9886001140048, 30489.237769055508, 30517.824719458007, 30729.231769205948, 31097.53353699696, 31140.0, 1105.886103694256, 1123.8763735989035, 1183.148133343991, 1200.6038007457519, 1284.3000564692265, 13322.533711320057, 14510.0, 14614.634634134232, 14941.551753447415, 16455.506334809976, 366008.0, 374899.0, 376189.0, 376260.0, 376519.0, 58542.0, 58883.0, 58939.0, 59074.0, 59220.70389648024, 1465.9853401465848, 1481.4370539195038, 1487.152323175801, 1497.7453832848441, 1504.4959938420532, 30592.235194120323, 30858.382832342777, 31299.530507041956, 31352.686473134978, 31595.684043160192, 55734.442655574545, 56982.7150864243, 57084.42915570791, 57156.714216430315, 57166.42833571611, 221707.0, 223717.0, 223829.0, 224634.0, 225347.0, 31011.534826977164, 31420.371592567564, 34257.48613770845, 45139.77430112829, 45278.320825188304, 48129.278060828416, 50674.23988640247, 51209.743951281496, 52106.739466302424, 52485.475145248056, 41524.3771343424, 41932.37101443542, 42017.57982420137, 42380.36429453499, 43232.78383608188, 39089.80455097706, 42267.0, 42269.78865105655, 44331.77834110809, 45925.31112033389, 40606.79696601498, 40631.1873762529, 40861.38707919443, 41228.38157427701, 44949.32576011297, 38855.418687325546, 39546.2090758189, 41016.384754228115, 42803.57196427996, 43770.56229437792, 32445.675543244266, 32636.347273054882, 32936.505952411215, 33045.66954330426, 33093.83453082719], "unit": "ms", "name": "ext.html", "value": 20858.934628227576}, {"lowerIsBetter": false, "replicates": [361.021631378963, 367.07497107289646, 374.32621281692946, 382.0553383279109, 388.19837036519584, 15209.239538023083, 15768.605784855356, 17122.26788160324, 20128.09423575939, 20510.589788204226, 18082.0, 18138.909305453486, 18426.262949482003, 18609.441716748486, 18611.069446527687, 4592.058627981272, 6070.696465176746, 6198.535109866755, 6225.035119556476, 6226.533010024244, 4816.51834816519, 4844.515548445145, 4853.369062021932, 6773.356531129535, 7007.474439417038, 6818.556793808387, 6956.547824391424, 6978.581285122909, 6979.546329488592, 6984.895226571605, 6867.278935711754, 6897.41371983382, 6901.447884169254, 6906.75826346078, 6911.101556797609, 6166.07508873668, 6172.969135154295, 6173.444390004921, 6175.845603859894, 6301.243850737895, 22574.661380079313, 22923.197688080836, 23299.0, 23369.948352324187, 24309.1491797788, 2540.2633236361617, 2548.617707343895, 2551.9362015949564, 2672.3319170207446, 2779.596958441035, 14785.630359240997, 14809.333579988926, 14845.554633361016, 15082.170480623561, 15128.546143615598, 2082.854200205986, 2131.11558703138, 2158.568286342738, 2160.4922843131853, 2166.4042388343173, 74140.0, 78635.0, 79527.0, 80118.19881801166, 80328.19671803266, 15378.0, 16377.83622163787, 16496.17519124039, 16499.257533410786, 16549.669006620043, 25086.749132508805, 25145.497090058096, 25278.241652750447, 25394.238172854843, 25437.10970116074, 9827.624132621439, 9874.80250394988, 9881.901180988098, 9923.801523969625, 9930.50347482623, 8379.748607541784, 8416.410851240476, 8427.494350338999, 8453.70412035588, 8503.404761666749, 4415.602595766396, 6723.949497212842, 8077.596120193967, 8144.633491492897, 8222.876656850152, 1785.7946336171506, 1806.8102849200645, 1821.5901422180168, 1835.2108593305006, 1884.7455593494976, 828.7513745876213, 982.9531548900541, 1007.6221416968637, 1015.7155996321042, 1078.223678951154, 17380.65238695219, 17703.0, 17775.73336399955, 18038.36865709694, 18262.0, 977.4868194198103, 997.665781963036, 1022.728976821143, 1041.2919214933765, 1046.8011077895176, 10100.646477373257, 10329.896701033043, 10370.429626370622, 10376.16990640747, 10414.0, 631717.0, 632187.0, 646094.0, 647546.0, 651079.0, 82621.0, 84412.0, 85071.0, 86838.0, 87923.0, 1142.8285757136496, 1154.6189757380043, 1154.96535103947, 1156.485364013023, 1174.5771522251982, 15633.14017729036, 15972.201389930224, 16176.191190440666, 16343.182840858148, 16943.882014748157, 20549.075291611614, 35259.82370088133, 36020.45969310515, 37743.0, 39121.82634520969, 48676.0, 49688.75155624199, 50065.24902126398, 50641.240381395044, 52143.21785173301, 9925.702228932854, 10014.449205293779, 10184.490775461345, 10211.897881021094, 10226.693199204035, 11964.282143071443, 12022.038236941198, 14274.785878211627, 18564.0, 18805.15376808074, 14275.14349139055, 14416.639584010483, 15725.213739313218, 15757.133357665438, 15786.695351640235, 14946.476873309382, 15232.3907043717, 15524.68950621004, 15909.284082216096, 15958.04251744899, 15279.923600381928, 15345.0, 15931.362745490514, 16209.0, 16452.83547164513, 10171.54228059754, 10210.030047145508, 10252.948735256276, 10465.90108038645, 10472.371657700258, 14525.491607793676, 14662.63343416423, 14853.0, 15617.45338913178, 16011.19944002772], "unit": "ms", "name": "jquery.html", "value": 10240.957946249884}, {"lowerIsBetter": false, "replicates": [1495.95512134636, 1501.1368463133701, 1648.0, 1791.7222830461276, 1811.2392795026092, 7431.554106753599, 7803.453758236926, 7817.413693972946, 7824.217578242173, 7828.882566761503, 6956.269591692875, 7083.5749855008735, 7174.533655312401, 7402.22276660951, 7767.22327767223, 2244.102359056378, 2252.68462415262, 2281.030562011147, 2282.897269622871, 2284.1091974130104, 2004.368623883472, 2260.6156953317895, 2290.4502919299416, 2320.9419764505938, 2322.581935251654, 1986.7814540400545, 2221.7222847144108, 2254.9887250563725, 2263.54729054189, 2263.864168149908, 2132.402927180392, 2154.7306586676664, 2164.2100633268824, 2170.2621108822996, 2175.2060497918305, 2238.798508134276, 2254.5829021631052, 2258.5821622999797, 2260.4348912771807, 2264.705588273514, 7711.0746710395115, 7760.961195194044, 7769.0, 7781.766547003599, 7793.220677932161, 4411.470623525165, 4461.665375096881, 4497.707649002837, 4507.706999045052, 4512.390827238313, 3021.561873528326, 3042.863071161803, 3066.877324907023, 3071.9078427647205, 3085.8148511089407, 1058.2645061682133, 1067.0343339277965, 1076.7792602516465, 1079.96220132295, 1104.3981030338484, 10533.420661863594, 10558.52486638103, 10559.260851740304, 10561.894381056169, 10572.894271057268, 3999.140184860211, 4021.1354558770004, 4023.3160362738404, 4094.0992981544014, 4116.794160291974, 9015.549222538846, 9103.0, 9115.908840911507, 9116.863247051167, 9123.680671176477, 4451.08752705701, 4461.888452788707, 4490.865274041784, 4494.16857881293, 4500.977495112504, 4113.609207125318, 4152.5432202457705, 4154.459920210354, 4157.521884983205, 4157.937630935538, 3690.2435000824767, 3751.9249615007548, 3754.605766394544, 3759.2293579816073, 3786.7159963002887, 1086.435053772034, 1211.8121691137887, 1218.482145088334, 1223.7063104854772, 1230.6185082624415, 970.0687340153531, 1166.935818529989, 1181.5510106159604, 1349.6153596225224, 1434.3043623842427, 7347.669354879044, 7370.77887663371, 7399.963000184965, 7410.184879663233, 7474.177840437547, 1135.3641960502146, 1141.611851970334, 1148.494662348564, 1161.4134861894688, 1181.480148734554, 5761.337446193657, 5866.208061911672, 5871.3541510433815, 5872.2366092408565, 5881.176635271066, 9111.68109116191, 9120.954395227982, 9201.355905086713, 9332.90667093334, 9380.95309523448, 9151.130642588943, 9157.77105572366, 9178.954105229432, 9264.536773161315, 9280.582373793195, 7400.259974002557, 7400.555966642019, 7563.9621801891735, 7572.280633339824, 7587.317141457295, 7474.03128641185, 7560.395168386626, 7611.3530349920875, 7620.542767433972, 7622.5426474411715, 8547.615357308812, 8664.566771661266, 8763.737087887119, 8776.341774367076, 8778.288233794348, 8522.74431767048, 8817.735467935972, 8881.023087460504, 8890.555472226233, 8901.955490222766, 6671.099401580918, 6713.664316784044, 6742.325767423218, 6744.190697116377, 6745.5952642841585, 7065.116860392451, 7075.221725610076, 7108.822279443055, 7152.070230869954, 7157.570545767062, 6402.775902843378, 6711.295313992156, 6818.284080171709, 7144.142702875688, 7238.710451581877, 6460.321666224979, 6656.700448479927, 6876.828079298058, 6889.827754306182, 6947.3747362737595, 7004.439644828503, 7005.01929729828, 7041.014258003986, 7045.718171273092, 7048.753293634698, 6463.644499552382, 6506.707198175999, 6507.511936604868, 6510.5117116217425, 6518.380753828379, 6603.933960660332, 6636.535442518977, 6646.268910419946, 6647.335266473314, 6653.800385988428], "unit": "ms", "name": "mootools.html", "value": 4482.749373768091}, {"lowerIsBetter": false, "replicates": [329.4087113631032, 336.4381482923518, 337.7281288562706, 343.99038821060174, 347.1927767939541, 6021.548383871211, 6056.545759068071, 6058.818235452933, 6097.054956481741, 6115.266168059828, 6010.338862725108, 6011.639301641893, 6013.338532761392, 6023.698815059241, 6029.397060293968, 4614.976925115387, 4623.976880115595, 4624.653151013671, 4626.074785043005, 4628.514006029369, 4498.820047198108, 4628.30575413689, 4631.235846085392, 4655.88360290992, 4658.464276608182, 4588.564086411786, 4589.79345929434, 4596.655250856183, 4597.977010114945, 4608.285715714053, 4421.977890110545, 4528.818847246106, 4546.795394207235, 4602.9769851150695, 4610.76946152691, 4073.0, 4100.159467309224, 4104.9121982674615, 4105.712600117993, 4111.033907031845, 5709.514691251248, 5709.942900570983, 5715.085586306171, 5715.228444160027, 5727.1695604137585, 5144.717040562768, 5259.789608415659, 5311.0, 5435.782568697247, 5444.074507333763, 6362.459190968773, 6374.139491168679, 6374.426301632829, 6376.904346434807, 6387.680615969183, 4542.568455996675, 4547.3179023146795, 4549.863504094882, 4550.8862278442975, 4554.70190995568, 6491.772787952446, 6596.868062638769, 6674.966625166891, 6679.933200668028, 6690.866182676319, 4521.3896124023495, 4538.205813982539, 4564.246899261585, 4565.292379681155, 4567.063751930847, 4615.676902616785, 4621.376114224604, 4621.722696638145, 4624.5144259852905, 4624.815007399667, 5315.123004704181, 5321.574274058066, 5326.680399176062, 5331.067063263913, 5334.1732031535175, 6314.526410519229, 6419.037144428373, 6425.389587989133, 6439.452646525004, 6444.355564443518, 1640.2946732904966, 1665.4837000529874, 1666.558362034062, 1667.7915260592426, 1668.5316921109345, 1095.3427943233996, 1113.1317572293624, 1118.1781390677845, 1132.5413207650915, 1155.7861795567846, 6359.332270111571, 6359.872802543923, 6361.5546911716665, 6363.204599425072, 6363.713632886531, 6630.171228596426, 6631.3700198481065, 6636.800895973032, 6640.966795165993, 6646.202455705346, 6224.62652240867, 6324.0, 6348.301686814447, 6363.681815909186, 6365.586236894587, 3548.769329993542, 3588.659077387644, 3601.117726157056, 3615.7830530168276, 3620.25784714133, 6986.476014298846, 6992.475564332695, 7000.159980802337, 7001.824954376079, 7008.859822803515, 6594.802155935329, 6754.932450675528, 6772.729090836311, 6873.965630171817, 6886.51794374389, 6942.791716248521, 6959.791206263719, 6980.162380514269, 6986.790396288119, 6995.615241161683, 6661.0, 6689.5986240825705, 6695.765648202289, 6700.530962832555, 6710.83222919431, 6479.967600161969, 6600.63696496678, 6610.636414997029, 6611.966940165268, 6612.669366531558, 6970.337817907291, 6970.860582788418, 6978.406835419046, 6979.930200697928, 6980.860382792417, 4568.086382723535, 4598.724076555283, 4601.309803529363, 4601.93097103537, 4606.032733126081, 6582.407583317525, 6700.49746269022, 6710.496712746662, 6729.663516824237, 6740.258571557027, 6535.248446428532, 6559.868802624016, 6560.8359791005605, 6572.4084832365315, 6573.079768832463, 6521.152250207443, 6545.312742162005, 6547.279799222177, 6558.049082883051, 6562.146920900253, 6287.465565426807, 6428.774992875227, 6443.516736244706, 6445.387688169616, 6448.226212854487, 6561.835954100995, 6567.113439685581, 6573.5398522103, 6577.079208910852, 6577.375149360803, 6397.520185985976, 6400.615963042233, 6404.871902561829, 6410.743570257137, 6414.711337989708], "unit": "ms", "name": "prototype.html", "value": 4882.260861351207}, {"lowerIsBetter": false, "replicates": [833.704035067551, 890.6660002499067, 948.9134940493134, 951.3973027191292, 968.1383568623921, 13993.790093148611, 14025.789613155797, 14039.649008774786, 14046.0, 14050.859491405083, 13479.742900268902, 13623.93188034061, 13671.248081355521, 13698.246596437191, 13710.314484275772, 884.6240347852154, 898.640543782489, 900.5542256583001, 902.3773596218621, 903.5482258870564, 896.3411892259185, 900.0999000999001, 901.8286525560155, 902.3367824648877, 903.421810041574, 922.8200500902327, 925.4354843545432, 934.7336009237368, 934.8878134623855, 935.4013431403907, 925.3615005646083, 927.2767241551601, 928.22029495224, 929.5120061967453, 929.6513807322254, 675.3516624040926, 677.2854638356532, 679.9932000680029, 681.3527149208222, 681.9761308354184, 12941.741165176738, 12995.350232488337, 13043.739125217537, 13058.673533161747, 13074.084814063019, 11723.531058757639, 11888.167828251939, 11954.282743035359, 12031.097667674872, 12321.383930803513, 10223.795524089477, 10266.897331026668, 10375.325603835727, 10497.632582859564, 10500.737481562946, 3861.6717579005817, 3887.1448281378052, 3890.0663840678317, 3923.3330333843314, 3954.6440820326306, 43498.130037399074, 47471.287930681065, 49898.25152622713, 51142.7442862787, 51191.23213151843, 11125.443727813577, 11142.0, 11232.831507527393, 11379.374134422686, 11418.771624567627, 19901.303454379027, 19924.3026494072, 19961.500962476053, 19997.700034499496, 20001.799982000284, 7842.29419352261, 7998.600069996477, 8017.559034253172, 8078.474899131537, 8311.916880831235, 4494.056248187851, 4584.609589516372, 4605.976970115128, 4614.3309220163555, 4723.031778485402, 3026.8637911294045, 3055.2667359833927, 3058.98470507646, 3061.0816754973866, 3064.080775767261, 565.135342925325, 572.5391060196582, 577.8382053025159, 579.0677010013874, 582.0309185206584, 653.1345966594282, 661.1339145719123, 693.3378623414627, 723.6098876762385, 738.3576288628927, 8676.175763302475, 8809.33929955256, 8918.866217006751, 8983.955080224558, 9064.184223419792, 664.8803215421174, 679.5514960126293, 708.624429052603, 729.7664747280819, 730.1364306419829, 4342.457192850894, 4374.950011997098, 4390.385346051556, 4403.207422663887, 4536.319552067216, 61245.08132378018, 61555.69222153861, 62127.068093978625, 62232.68883655643, 62307.6884615574, 51359.48038970772, 53927.0, 53954.73022634862, 54043.72978135084, 54540.727296363264, 43680.0, 45093.0, 54389.45610543844, 55463.445365546635, 57240.99999999917, 9155.221806146552, 9194.448333100036, 9374.95312523433, 9421.528923553931, 9440.008799076273, 35409.698369605896, 36211.637883620824, 36717.0, 36790.08024799402, 37712.0, 46820.531794681614, 46838.29742553933, 47046.52953470559, 47261.763691181324, 47327.52672473231, 10908.181886358396, 11112.555497779998, 11187.552497899993, 11250.7749845001, 11271.267367621407, 12829.166104203197, 13369.997250206468, 13379.665508361979, 13504.054716170167, 13580.660483487596, 11738.647840564796, 11804.58683946092, 11899.881001189877, 12132.090093242865, 12343.75312493763, 11833.763324733629, 11980.161388703056, 12027.45876435545, 12142.696432589257, 12319.692007699521, 11397.259178153394, 11570.710732231762, 11775.275098896735, 12092.334921579397, 12137.514499419924, 10827.458627068772, 10950.178736594627, 10990.120790336914, 10994.505247263733, 11239.213255072067, 9564.378315409476, 9966.152877005246, 9998.450085245382, 10184.787279759488, 10703.19726020536], "unit": "ms", "name": "yui.html", "value": 6701.61733824801}], "name": "dromaeo_css", "value": 7446.936519957531}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 103.0, 108.0, 110.0, 110.0, 99.0, 109.0, 108.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 107.3}, {"lowerIsBetter": true, "replicates": [153.0, 129.0, 160.0, 159.0, 122.0, 153.0, 152.0, 122.0, 165.0, 128.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.3}, {"lowerIsBetter": true, "replicates": [162.0, 166.0, 160.0, 158.0, 161.0, 159.0, 160.0, 162.0, 161.0, 159.0], "unit": "ms", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 70.0, 150.0, 74.0, 70.0, 70.0, 71.0, 160.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 87.9}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 145.0, 92.0, 92.0, 92.0, 136.0, 91.0, 92.0, 142.0], "unit": "ms", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 147.0, 145.0, 146.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 59.0, 57.0, 57.0, 58.0, 59.0, 57.0, 55.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 65.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.3}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 79.0, 80.0, 79.0, 77.0, 77.0, 78.0, 78.0, 77.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 77.8}, {"lowerIsBetter": true, "replicates": [112.0, 115.0, 121.0, 109.0, 117.0, 113.0, 119.0, 109.0, 112.0, 113.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 114.0}, {"lowerIsBetter": true, "replicates": [137.0, 134.0, 142.0, 144.0, 142.0, 142.0, 144.0, 140.0, 145.0, 143.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 141.3}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 62.0, 64.0, 63.0, 65.0, 64.0, 63.0, 61.0, 62.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.4}], "name": "kraken", "value": 1475.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.03898504453034], "unit": "score", "name": "Richards", "value": 210.08220199999997}, {"lowerIsBetter": false, "replicates": [166.47244880972198], "unit": "score", "name": "DeltaBlue", "value": 397.17082600000003}, {"lowerIsBetter": false, "replicates": [279.56388034665923], "unit": "score", "name": "Encrypt", "value": 952.1294369999999}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [950.5703422053232], "unit": "score", "name": "RayTrace", "value": 778.4684279999997}, {"lowerIsBetter": false, "replicates": [537.6344086021505], "unit": "score", "name": "Earley", "value": 1239.62118}, {"lowerIsBetter": false, "replicates": [10562.5], "unit": "score", "name": "Boyer", "value": 63.09708875739642}, {"lowerIsBetter": false, "replicates": [26552.63157894737], "unit": "score", "name": "RegExp", "value": 34.3086521308226}, {"lowerIsBetter": false, "replicates": [514.8870636550308], "unit": "score", "name": "Splay", "value": 158.26965902293128}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 23090.10588529507}]} 10:06:10 INFO - RETURN: dromaeo_css: 7446.94 10:06:10 INFO - RETURN: kraken: 1475.00 10:06:10 INFO - RETURN: v8_7: 23090.11 10:06:10 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23090.11"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1475.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7446.94"}}} 10:06:10 INFO - Return code: 0 10:06:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:06:10 INFO - # TBPL SUCCESS # 10:06:10 INFO - Running post-action listener: _resource_record_post_action 10:06:10 INFO - Running post-run listener: _resource_record_post_run 10:06:11 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 4096; Write bytes: 260575232; Read time: 200; Write time: 175168 10:06:11 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 593920; Read time: 0; Write time: 48 10:06:12 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 4096; Write bytes: 259981312; Read time: 200; Write time: 175120 10:06:12 INFO - Running post-run listener: _upload_blobber_files 10:06:12 INFO - Blob upload gear active. 10:06:12 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:06:12 INFO - Copying logs to upload dir... 10:06:12 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1378.513441 ========= master_lag: 0.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 58 secs) (at 2016-02-01 10:06:12.178051) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-01 10:06:12.185250) ========= 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-1454348372.207926-887817633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454337867/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010058 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454337867/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.50 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-01 10:06:12.698303) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 10:06:12.698631) ========= 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-1454348372.207926-887817633 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004542 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 10:06:12.715235) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-01 10:06:12.715551) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-01 10:06:12.715857) ========= ========= Total master_lag: 0.88 =========