builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1455731546.11 results: success (0) buildid: 20160217072354 builduid: 6c6f83a3d4f0443ab03b8e72be0ba340 revision: 339b62e92a29 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 09:52:26.109584) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 09:52:26.110121) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-17 09:52:26.110529) ========= 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=fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006365 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-17 09:52:26.134927) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-17 09:52:26.135297) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-17 09:52:26.151210) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 09:52:26.151559) ========= 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=fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004626 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 09:52:26.201120) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 09:52:26.201442) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 09:52:26.201847) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 09:52:26.202157) ========= 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=fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-17 09:52:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-02-17 09:52:26 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168807 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 09:52:26.384700) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 09:52:26.385075) ========= 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=fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017062 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 09:52:26.436569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 09:52:26.437013) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 339b62e92a29 --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 339b62e92a29 --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=fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-17 09:52:26,916 Setting DEBUG logging. 2016-02-17 09:52:26,917 attempt 1/10 2016-02-17 09:52:26,917 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/339b62e92a29?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-17 09:52:27,222 unpacking tar archive at: mozilla-beta-339b62e92a29/testing/mozharness/ program finished with exit code 0 elapsedTime=0.899725 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 09:52:27.353757) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 09:52:27.354465) ========= echo 339b62e92a29 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'339b62e92a29'] 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=fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 339b62e92a29 program finished with exit code 0 elapsedTime=0.004531 script_repo_revision: '339b62e92a29' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 09:52:27.408595) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 09:52:27.409206) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 09:52:27.421822) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-02-17 09:52:27.422459) ========= /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=fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:52:27 INFO - MultiFileLogger online at 20160217 09:52:27 in /builds/slave/test-pgo 09:52:27 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:52:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:52:27 INFO - {'append_to_log': False, 09:52:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:52:27 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:52:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:52:27 INFO - 'branch': 'Mozilla-Beta', 09:52:27 INFO - 'buildbot_json_path': 'buildprops.json', 09:52:27 INFO - 'config_files': ('talos/linux_config.py',), 09:52:27 INFO - 'default_actions': ('clobber', 09:52:27 INFO - 'read-buildbot-config', 09:52:27 INFO - 'download-and-extract', 09:52:27 INFO - 'populate-webroot', 09:52:27 INFO - 'create-virtualenv', 09:52:27 INFO - 'install', 09:52:27 INFO - 'run-tests'), 09:52:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:52:27 INFO - 'download_minidump_stackwalk': True, 09:52:27 INFO - 'download_symbols': 'ondemand', 09:52:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:52:27 INFO - 'tooltool.py': '/tools/tooltool.py', 09:52:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:52:27 INFO - '/tools/misc-python/virtualenv.py')}, 09:52:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:52:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:52:27 INFO - 'installer_path': 'installer.exe', 09:52:27 INFO - 'log_level': 'info', 09:52:27 INFO - 'log_name': 'talos', 09:52:27 INFO - 'log_to_console': True, 09:52:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:52:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:52:27 INFO - 'opt_config_files': (), 09:52:27 INFO - 'pip_index': False, 09:52:27 INFO - 'sps_profile': False, 09:52:27 INFO - 'sps_profile_interval': 0, 09:52:27 INFO - 'suite': 'dromaeojs', 09:52:27 INFO - 'system_bits': '32', 09:52:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:52:27 INFO - 'title': 'talos-linux64-ix-048', 09:52:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:52:27 INFO - 'use_talos_json': True, 09:52:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:52:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:52:27 INFO - 'work_dir': 'build'} 09:52:27 INFO - ##### 09:52:27 INFO - ##### Running clobber step. 09:52:27 INFO - ##### 09:52:27 INFO - Running pre-action listener: _resource_record_pre_action 09:52:27 INFO - Running main action method: clobber 09:52:27 INFO - rmtree: /builds/slave/test-pgo/build 09:52:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:52:28 INFO - Running post-action listener: _resource_record_post_action 09:52:28 INFO - ##### 09:52:28 INFO - ##### Running read-buildbot-config step. 09:52:28 INFO - ##### 09:52:28 INFO - Running pre-action listener: _resource_record_pre_action 09:52:28 INFO - Running main action method: read_buildbot_config 09:52:28 INFO - Using buildbot properties: 09:52:28 INFO - { 09:52:28 INFO - "properties": { 09:52:28 INFO - "buildnumber": 126, 09:52:28 INFO - "product": "firefox", 09:52:28 INFO - "script_repo_revision": "production", 09:52:28 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 09:52:28 INFO - "repository": "", 09:52:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 09:52:28 INFO - "buildid": "20160217072354", 09:52:28 INFO - "slavename": "talos-linux64-ix-048", 09:52:28 INFO - "pgo_build": "True", 09:52:28 INFO - "basedir": "/builds/slave/test-pgo", 09:52:28 INFO - "project": "", 09:52:28 INFO - "platform": "ubuntu64_hw", 09:52:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:52:28 INFO - "slavebuilddir": "test", 09:52:28 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 09:52:28 INFO - "branch": "mozilla-beta", 09:52:28 INFO - "repo_path": "releases/mozilla-beta", 09:52:28 INFO - "stage_platform": "linux64-pgo", 09:52:28 INFO - "builduid": "6c6f83a3d4f0443ab03b8e72be0ba340", 09:52:28 INFO - "revision": "339b62e92a29" 09:52:28 INFO - }, 09:52:28 INFO - "sourcestamp": { 09:52:28 INFO - "repository": "", 09:52:28 INFO - "hasPatch": false, 09:52:28 INFO - "project": "", 09:52:28 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 09:52:28 INFO - "changes": [ 09:52:28 INFO - { 09:52:28 INFO - "category": null, 09:52:28 INFO - "files": [ 09:52:28 INFO - { 09:52:28 INFO - "url": null, 09:52:28 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455722634/firefox-45.0.en-US.linux-x86_64.tar.bz2" 09:52:28 INFO - } 09:52:28 INFO - ], 09:52:28 INFO - "repository": "", 09:52:28 INFO - "rev": "339b62e92a29", 09:52:28 INFO - "who": "sendchange", 09:52:28 INFO - "when": 1455731513, 09:52:28 INFO - "number": 7616694, 09:52:28 INFO - "comments": "Bug 1244292 - [1.2] Release decoder on init failure. r=snorp, a=lizzard", 09:52:28 INFO - "project": "", 09:52:28 INFO - "at": "Wed 17 Feb 2016 09:51:53", 09:52:28 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 09:52:28 INFO - "revlink": "", 09:52:28 INFO - "properties": [ 09:52:28 INFO - [ 09:52:28 INFO - "buildid", 09:52:28 INFO - "20160217072354", 09:52:28 INFO - "Change" 09:52:28 INFO - ], 09:52:28 INFO - [ 09:52:28 INFO - "builduid", 09:52:28 INFO - "6c6f83a3d4f0443ab03b8e72be0ba340", 09:52:28 INFO - "Change" 09:52:28 INFO - ], 09:52:28 INFO - [ 09:52:28 INFO - "pgo_build", 09:52:28 INFO - "True", 09:52:28 INFO - "Change" 09:52:28 INFO - ] 09:52:28 INFO - ], 09:52:28 INFO - "revision": "339b62e92a29" 09:52:28 INFO - } 09:52:28 INFO - ], 09:52:28 INFO - "revision": "339b62e92a29" 09:52:28 INFO - } 09:52:28 INFO - } 09:52:28 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455722634/firefox-45.0.en-US.linux-x86_64.tar.bz2. 09:52:28 INFO - Running post-action listener: _resource_record_post_action 09:52:28 INFO - ##### 09:52:28 INFO - ##### Running download-and-extract step. 09:52:28 INFO - ##### 09:52:28 INFO - Running pre-action listener: _resource_record_pre_action 09:52:28 INFO - Running main action method: download_and_extract 09:52:28 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:28 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455722634/test_packages.json 09:52:28 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455722634/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:52:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455722634/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:52:28 INFO - Downloaded 1270 bytes. 09:52:28 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:52:28 INFO - Using the following test package requirements: 09:52:28 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 09:52:28 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:52:28 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 09:52:28 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:52:28 INFO - u'jsshell-linux-x86_64.zip'], 09:52:28 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:52:28 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 09:52:28 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 09:52:28 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:52:28 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 09:52:28 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:52:28 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 09:52:28 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:52:28 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 09:52:28 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 09:52:28 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 09:52:28 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 09:52:28 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:28 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455722634/firefox-45.0.en-US.linux-x86_64.common.tests.zip 09:52:28 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455722634/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:52:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455722634/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:52:29 INFO - Downloaded 22211619 bytes. 09:52:29 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:52:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 09:52:29 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:52:30 INFO - Return code: 0 09:52:30 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:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:30 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455722634/firefox-45.0.en-US.linux-x86_64.common.tests.zip 09:52:30 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455722634/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:52:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455722634/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:52:30 INFO - Downloaded 22211619 bytes. 09:52:30 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:52:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 09:52:30 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:52:32 INFO - Return code: 0 09:52: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:52:32 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455722634/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 09:52:32 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455722634/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:52:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455722634/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:52:32 INFO - Downloaded 11132038 bytes. 09:52:32 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:52:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 09:52:32 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:52:32 INFO - Return code: 0 09:52: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:52:32 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455722634/firefox-45.0.en-US.linux-x86_64.tar.bz2 09:52:32 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455722634/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:52:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455722634/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:52:35 INFO - Downloaded 58293216 bytes. 09:52:35 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455722634/firefox-45.0.en-US.linux-x86_64.tar.bz2 09:52:35 INFO - mkdir: /builds/slave/test-pgo/properties 09:52:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:52:35 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:52:35 INFO - Contents: 09:52:35 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455722634/firefox-45.0.en-US.linux-x86_64.tar.bz2 09:52:35 INFO - Running post-action listener: _resource_record_post_action 09:52:35 INFO - Running post-action listener: set_extra_try_arguments 09:52:35 INFO - ##### 09:52:35 INFO - ##### Running populate-webroot step. 09:52:35 INFO - ##### 09:52:35 INFO - Running pre-action listener: _resource_record_pre_action 09:52:35 INFO - Running main action method: populate_webroot 09:52:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:52:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:52:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:52:35 INFO - '--tppagecycles', 09:52:35 INFO - '7'], 09:52:35 INFO - 'tests': ['tsvgm']}}, 09:52:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:52:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:52:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:52:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:52:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:52:35 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:52:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:52:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:35 INFO - 'talos_options': ['--e10s'], 09:52:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:52:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:35 INFO - 'tests': ['damp', 'tps']}, 09:52:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:35 INFO - 'talos_options': ['--e10s'], 09:52:35 INFO - 'tests': ['damp', 'tps']}, 09:52:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:52:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:52:35 INFO - 'other': {'tests': ['a11yr', 09:52:35 INFO - 'ts_paint', 09:52:35 INFO - 'tpaint', 09:52:35 INFO - 'sessionrestore', 09:52:35 INFO - 'sessionrestore_no_auto_restore']}, 09:52:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:52:35 INFO - 'tests': ['a11yr', 09:52:35 INFO - 'ts_paint', 09:52:35 INFO - 'tpaint', 09:52:35 INFO - 'sessionrestore', 09:52:35 INFO - 'sessionrestore_no_auto_restore']}, 09:52:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:52:35 INFO - 'tests': ['a11yr', 09:52:35 INFO - 'ts_paint', 09:52:35 INFO - 'tpaint', 09:52:35 INFO - 'sessionrestore', 09:52:35 INFO - 'sessionrestore_no_auto_restore']}, 09:52:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:52:35 INFO - 'tests': ['a11yr', 09:52:35 INFO - 'ts_paint', 09:52:35 INFO - 'tpaint', 09:52:35 INFO - 'sessionrestore', 09:52:35 INFO - 'sessionrestore_no_auto_restore']}, 09:52:35 INFO - 'other_l64': {'tests': ['a11yr', 09:52:35 INFO - 'ts_paint', 09:52:35 INFO - 'tpaint', 09:52:35 INFO - 'sessionrestore', 09:52:35 INFO - 'sessionrestore_no_auto_restore']}, 09:52:35 INFO - 'other_nol64': {'tests': ['a11yr', 09:52:35 INFO - 'ts_paint', 09:52:35 INFO - 'tpaint', 09:52:35 INFO - 'sessionrestore', 09:52:35 INFO - 'sessionrestore_no_auto_restore']}, 09:52:35 INFO - 'svgr': {'tests': ['tsvgx', 09:52:35 INFO - 'tsvgr_opacity', 09:52:35 INFO - 'tart', 09:52:35 INFO - 'tscrollx', 09:52:35 INFO - 'cart']}, 09:52:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:52:35 INFO - 'tests': ['tsvgx', 09:52:35 INFO - 'tsvgr_opacity', 09:52:35 INFO - 'tart', 09:52:35 INFO - 'tscrollx', 09:52:35 INFO - 'cart']}, 09:52:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:35 INFO - 'tests': ['tp5o']}, 09:52:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:35 INFO - 'talos_options': ['--e10s'], 09:52:35 INFO - 'tests': ['tp5o']}, 09:52:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:35 INFO - 'talos_options': ['--xperf_path', 09:52:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:52:35 INFO - 'tests': ['tp5n']}, 09:52:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:52:35 INFO - 'talos_options': ['--e10s', 09:52:35 INFO - '--xperf_path', 09:52:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:52:35 INFO - 'tests': ['tp5n']}}, 09:52:35 INFO - 'talos.zip': {'path': '', 09:52:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:52:35 INFO - Running post-action listener: _resource_record_post_action 09:52:35 INFO - ##### 09:52:35 INFO - ##### Running create-virtualenv step. 09:52:35 INFO - ##### 09:52:35 INFO - Running pre-action listener: _resource_record_pre_action 09:52:35 INFO - Running main action method: create_virtualenv 09:52:35 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:52:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 09:52:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:52:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:52:36 INFO - Using real prefix '/usr' 09:52:36 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:52:36 INFO - Installing distribute.............................................................................................................................................................................................done. 09:52:38 INFO - Installing pip.................done. 09:52:38 INFO - Return code: 0 09:52:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:52: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:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52: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:52:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:38 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 0x7f10fff22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e8600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a77350>, '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 0x2a78250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a786e0>, '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': 'fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499', '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:52:38 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:52:38 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:52:38 INFO - Using env: {'DISPLAY': ':0', 09:52:38 INFO - 'HOME': '/home/cltbld', 09:52:38 INFO - 'LANG': 'en_US.UTF-8', 09:52:38 INFO - 'LANGUAGE': 'en_US:en', 09:52:38 INFO - 'LOGNAME': 'cltbld', 09:52:38 INFO - 'MAIL': '/var/mail/cltbld', 09:52:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:38 INFO - 'MOZ_NO_REMOTE': '1', 09:52:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:38 INFO - 'NO_EM_RESTART': '1', 09:52:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:52:38 INFO - 'PWD': '/builds/slave/test-pgo', 09:52:38 INFO - 'SHELL': '/bin/bash', 09:52:38 INFO - 'SHLVL': '1', 09:52:38 INFO - 'TERM': 'linux', 09:52:38 INFO - 'TMOUT': '86400', 09:52:38 INFO - 'USER': 'cltbld', 09:52:38 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499', 09:52:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:38 INFO - '_': '/tools/buildbot/bin/python'} 09:52:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:52:38 INFO - Cleaning up... 09:52:38 INFO - Return code: 0 09:52:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:52: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:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52: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:52:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:38 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 0x7f10fff22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e8600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a77350>, '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 0x2a78250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a786e0>, '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': 'fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499', '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:52:38 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:52:38 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:52:38 INFO - Using env: {'DISPLAY': ':0', 09:52:38 INFO - 'HOME': '/home/cltbld', 09:52:38 INFO - 'LANG': 'en_US.UTF-8', 09:52:38 INFO - 'LANGUAGE': 'en_US:en', 09:52:38 INFO - 'LOGNAME': 'cltbld', 09:52:38 INFO - 'MAIL': '/var/mail/cltbld', 09:52:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:38 INFO - 'MOZ_NO_REMOTE': '1', 09:52:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:38 INFO - 'NO_EM_RESTART': '1', 09:52:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:52:38 INFO - 'PWD': '/builds/slave/test-pgo', 09:52:38 INFO - 'SHELL': '/bin/bash', 09:52:38 INFO - 'SHLVL': '1', 09:52:38 INFO - 'TERM': 'linux', 09:52:38 INFO - 'TMOUT': '86400', 09:52:38 INFO - 'USER': 'cltbld', 09:52:38 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499', 09:52:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:38 INFO - '_': '/tools/buildbot/bin/python'} 09:52:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:39 INFO - Downloading/unpacking psutil>=0.7.1 09:52:39 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:52:39 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:52:39 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:52:39 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:52:39 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:52:39 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:52:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:52:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:52:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:52:40 INFO - Installing collected packages: psutil 09:52:40 INFO - Running setup.py install for psutil 09:52:41 INFO - building 'psutil._psutil_linux' extension 09:52:41 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:52:41 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:52:41 INFO - building 'psutil._psutil_posix' extension 09:52:41 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:52:41 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:52:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:52:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:52:41 INFO - Successfully installed psutil 09:52:41 INFO - Cleaning up... 09:52:41 INFO - Return code: 0 09:52:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:41 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 0x7f10fff22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e8600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a77350>, '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 0x2a78250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a786e0>, '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': 'fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499', '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:52:41 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:52:41 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:52:41 INFO - Using env: {'DISPLAY': ':0', 09:52:41 INFO - 'HOME': '/home/cltbld', 09:52:41 INFO - 'LANG': 'en_US.UTF-8', 09:52:41 INFO - 'LANGUAGE': 'en_US:en', 09:52:41 INFO - 'LOGNAME': 'cltbld', 09:52:41 INFO - 'MAIL': '/var/mail/cltbld', 09:52:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:41 INFO - 'MOZ_NO_REMOTE': '1', 09:52:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:41 INFO - 'NO_EM_RESTART': '1', 09:52:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:52:41 INFO - 'PWD': '/builds/slave/test-pgo', 09:52:41 INFO - 'SHELL': '/bin/bash', 09:52:41 INFO - 'SHLVL': '1', 09:52:41 INFO - 'TERM': 'linux', 09:52:41 INFO - 'TMOUT': '86400', 09:52:41 INFO - 'USER': 'cltbld', 09:52:41 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499', 09:52:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:41 INFO - '_': '/tools/buildbot/bin/python'} 09:52:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:52:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:52:43 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:52:43 INFO - Installing collected packages: mozsystemmonitor 09:52:43 INFO - Running setup.py install for mozsystemmonitor 09:52:43 INFO - Successfully installed mozsystemmonitor 09:52:43 INFO - Cleaning up... 09:52:43 INFO - Return code: 0 09:52:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:43 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 0x7f10fff22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e8600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a77350>, '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 0x2a78250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a786e0>, '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': 'fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499', '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:52:43 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:52:43 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:52:43 INFO - Using env: {'DISPLAY': ':0', 09:52:43 INFO - 'HOME': '/home/cltbld', 09:52:43 INFO - 'LANG': 'en_US.UTF-8', 09:52:43 INFO - 'LANGUAGE': 'en_US:en', 09:52:43 INFO - 'LOGNAME': 'cltbld', 09:52:43 INFO - 'MAIL': '/var/mail/cltbld', 09:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:43 INFO - 'MOZ_NO_REMOTE': '1', 09:52:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:43 INFO - 'NO_EM_RESTART': '1', 09:52:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:52:43 INFO - 'PWD': '/builds/slave/test-pgo', 09:52:43 INFO - 'SHELL': '/bin/bash', 09:52:43 INFO - 'SHLVL': '1', 09:52:43 INFO - 'TERM': 'linux', 09:52:43 INFO - 'TMOUT': '86400', 09:52:43 INFO - 'USER': 'cltbld', 09:52:43 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499', 09:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:43 INFO - '_': '/tools/buildbot/bin/python'} 09:52:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:43 INFO - Downloading/unpacking blobuploader==1.2.4 09:52:43 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:52:43 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:52:43 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:52:43 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:52:43 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:52:43 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:52:45 INFO - Downloading blobuploader-1.2.4.tar.gz 09:52:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:52:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:52: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:52: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:52: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:52: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:52: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:52: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:52:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:52:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:52: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:52: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:52: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:52: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:52: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:52: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:52:46 INFO - Downloading docopt-0.6.1.tar.gz 09:52:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:52:46 INFO - Installing collected packages: blobuploader, requests, docopt 09:52:46 INFO - Running setup.py install for blobuploader 09:52:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:52:46 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:52:46 INFO - Running setup.py install for requests 09:52:46 INFO - Running setup.py install for docopt 09:52:47 INFO - Successfully installed blobuploader requests docopt 09:52:47 INFO - Cleaning up... 09:52:47 INFO - Return code: 0 09:52:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:47 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 0x7f10fff22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e8600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a77350>, '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 0x2a78250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a786e0>, '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': 'fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499', '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:52:47 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:52:47 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:52:47 INFO - Using env: {'DISPLAY': ':0', 09:52:47 INFO - 'HOME': '/home/cltbld', 09:52:47 INFO - 'LANG': 'en_US.UTF-8', 09:52:47 INFO - 'LANGUAGE': 'en_US:en', 09:52:47 INFO - 'LOGNAME': 'cltbld', 09:52:47 INFO - 'MAIL': '/var/mail/cltbld', 09:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:47 INFO - 'MOZ_NO_REMOTE': '1', 09:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:47 INFO - 'NO_EM_RESTART': '1', 09:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:52:47 INFO - 'PWD': '/builds/slave/test-pgo', 09:52:47 INFO - 'SHELL': '/bin/bash', 09:52:47 INFO - 'SHLVL': '1', 09:52:47 INFO - 'TERM': 'linux', 09:52:47 INFO - 'TMOUT': '86400', 09:52:47 INFO - 'USER': 'cltbld', 09:52:47 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499', 09:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:47 INFO - '_': '/tools/buildbot/bin/python'} 09:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:52:47 INFO - Running setup.py (path:/tmp/pip-XUbxJp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:52:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:52:47 INFO - Running setup.py (path:/tmp/pip-qrV5gz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:52:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:52:47 INFO - Running setup.py (path:/tmp/pip-3_zCqh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:52:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:52:47 INFO - Running setup.py (path:/tmp/pip-7QuMrL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:52:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:52:47 INFO - Running setup.py (path:/tmp/pip-7RzEOP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:52:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:52:47 INFO - Running setup.py (path:/tmp/pip-cMkXui-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:52:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:52:47 INFO - Running setup.py (path:/tmp/pip-15v_NE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:52:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:52:47 INFO - Running setup.py (path:/tmp/pip-pkKRbX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:52:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:52:47 INFO - Running setup.py (path:/tmp/pip-KToOG7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:52:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:52:47 INFO - Running setup.py (path:/tmp/pip-0EfZYF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:52:48 INFO - Running setup.py (path:/tmp/pip-kJrLbz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:52:48 INFO - Running setup.py (path:/tmp/pip-0Z0eSo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:52:48 INFO - Running setup.py (path:/tmp/pip-2ldKD1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:52:48 INFO - Running setup.py (path:/tmp/pip-vxiBfZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:52:48 INFO - Running setup.py (path:/tmp/pip-FojzJt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:52:48 INFO - Running setup.py (path:/tmp/pip-n5YUUR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:52:48 INFO - Running setup.py (path:/tmp/pip-wk3uwk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:52:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:52:48 INFO - Running setup.py install for manifestparser 09:52:48 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:52:48 INFO - Running setup.py install for mozcrash 09:52:48 INFO - Running setup.py install for mozdebug 09:52:48 INFO - Running setup.py install for mozdevice 09:52:48 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:52:48 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:52:48 INFO - Running setup.py install for mozfile 09:52:49 INFO - Running setup.py install for mozhttpd 09:52:49 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:52:49 INFO - Running setup.py install for mozinfo 09:52:49 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:52:49 INFO - Running setup.py install for mozInstall 09:52:49 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:52:49 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:52:49 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:52:49 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:52:49 INFO - Running setup.py install for mozleak 09:52:49 INFO - Running setup.py install for mozlog 09:52:49 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:52:49 INFO - Running setup.py install for moznetwork 09:52:49 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:52:49 INFO - Running setup.py install for mozprocess 09:52:49 INFO - Running setup.py install for mozprofile 09:52:49 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:52:49 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:52:49 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:52:49 INFO - Running setup.py install for mozrunner 09:52:49 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:52:49 INFO - Running setup.py install for mozscreenshot 09:52:50 INFO - Running setup.py install for moztest 09:52:50 INFO - Running setup.py install for mozversion 09:52:50 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:52:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:52:50 INFO - Cleaning up... 09:52:50 INFO - Return code: 0 09:52:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:50 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 0x7f10fff22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e8600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a77350>, '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 0x2a78250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a786e0>, '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': 'fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499', '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:52:50 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:52:50 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:52:50 INFO - Using env: {'DISPLAY': ':0', 09:52:50 INFO - 'HOME': '/home/cltbld', 09:52:50 INFO - 'LANG': 'en_US.UTF-8', 09:52:50 INFO - 'LANGUAGE': 'en_US:en', 09:52:50 INFO - 'LOGNAME': 'cltbld', 09:52:50 INFO - 'MAIL': '/var/mail/cltbld', 09:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:50 INFO - 'MOZ_NO_REMOTE': '1', 09:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:50 INFO - 'NO_EM_RESTART': '1', 09:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:52:50 INFO - 'PWD': '/builds/slave/test-pgo', 09:52:50 INFO - 'SHELL': '/bin/bash', 09:52:50 INFO - 'SHLVL': '1', 09:52:50 INFO - 'TERM': 'linux', 09:52:50 INFO - 'TMOUT': '86400', 09:52:50 INFO - 'USER': 'cltbld', 09:52:50 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499', 09:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:50 INFO - '_': '/tools/buildbot/bin/python'} 09:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:52:50 INFO - Running setup.py (path:/tmp/pip-f_xmV0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:52:50 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:52:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:52:50 INFO - Running setup.py (path:/tmp/pip-vR80gr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:52:50 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:52:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:52:50 INFO - Running setup.py (path:/tmp/pip-itjGny-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:52:50 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:52:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:52:50 INFO - Running setup.py (path:/tmp/pip-6sdaDo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:52:50 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:52:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:52:50 INFO - Running setup.py (path:/tmp/pip-GP6oAp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:52:50 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:52:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:52:50 INFO - Running setup.py (path:/tmp/pip-oDRPsK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:52:50 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:52:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:52:50 INFO - Running setup.py (path:/tmp/pip-uCU_Em-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:52:51 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:52:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:52:51 INFO - Running setup.py (path:/tmp/pip-dR43I3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:52:51 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:52:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:52:51 INFO - Running setup.py (path:/tmp/pip-51upcM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:52:51 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:52:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:52:51 INFO - Running setup.py (path:/tmp/pip-UIZ1_a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:52:51 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:52:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:52:51 INFO - Running setup.py (path:/tmp/pip-4zwBPR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:52:51 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:52:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:52:51 INFO - Running setup.py (path:/tmp/pip-A5ic6_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:52:51 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:52:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:52:51 INFO - Running setup.py (path:/tmp/pip-TldUNe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:52:51 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:52:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:52:51 INFO - Running setup.py (path:/tmp/pip-8uTC2q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:52:51 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:52:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:52:51 INFO - Running setup.py (path:/tmp/pip-1qTSH6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:52:51 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:52:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:52:51 INFO - Running setup.py (path:/tmp/pip-L4FoP2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:52:51 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:52:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:52:51 INFO - Running setup.py (path:/tmp/pip-51fnQB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:52:51 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:52:51 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:52:51 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:52:51 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:52:51 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:52:51 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:52:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:52:51 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:52:51 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:52:51 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:52:51 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:52:51 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:52:51 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:52:53 INFO - Downloading blessings-1.6.tar.gz 09:52:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:52:53 INFO - Installing collected packages: blessings 09:52:53 INFO - Running setup.py install for blessings 09:52:53 INFO - Successfully installed blessings 09:52:53 INFO - Cleaning up... 09:52:53 INFO - Return code: 0 09:52:53 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:52:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:52:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:52:54 INFO - Reading from file tmpfile_stdout 09:52:54 INFO - Current package versions: 09:52:54 INFO - argparse == 1.2.1 09:52:54 INFO - blessings == 1.6 09:52:54 INFO - blobuploader == 1.2.4 09:52:54 INFO - docopt == 0.6.1 09:52:54 INFO - manifestparser == 1.1 09:52:54 INFO - mozInstall == 1.12 09:52:54 INFO - mozcrash == 0.16 09:52:54 INFO - mozdebug == 0.1 09:52:54 INFO - mozdevice == 0.47 09:52:54 INFO - mozfile == 1.2 09:52:54 INFO - mozhttpd == 0.7 09:52:54 INFO - mozinfo == 0.9 09:52:54 INFO - mozleak == 0.1 09:52:54 INFO - mozlog == 3.1 09:52:54 INFO - moznetwork == 0.27 09:52:54 INFO - mozprocess == 0.22 09:52:54 INFO - mozprofile == 0.27 09:52:54 INFO - mozrunner == 6.11 09:52:54 INFO - mozscreenshot == 0.1 09:52:54 INFO - mozsystemmonitor == 0.0 09:52:54 INFO - moztest == 0.7 09:52:54 INFO - mozversion == 1.4 09:52:54 INFO - psutil == 3.1.1 09:52:54 INFO - requests == 1.2.3 09:52:54 INFO - wsgiref == 0.1.2 09:52:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:54 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 0x7f10fff22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e8600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a77350>, '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 0x2a78250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a786e0>, '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': 'fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499', '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:52:54 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:52:54 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:52:54 INFO - Using env: {'DISPLAY': ':0', 09:52:54 INFO - 'HOME': '/home/cltbld', 09:52:54 INFO - 'LANG': 'en_US.UTF-8', 09:52:54 INFO - 'LANGUAGE': 'en_US:en', 09:52:54 INFO - 'LOGNAME': 'cltbld', 09:52:54 INFO - 'MAIL': '/var/mail/cltbld', 09:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:54 INFO - 'MOZ_NO_REMOTE': '1', 09:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:54 INFO - 'NO_EM_RESTART': '1', 09:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:52:54 INFO - 'PWD': '/builds/slave/test-pgo', 09:52:54 INFO - 'SHELL': '/bin/bash', 09:52:54 INFO - 'SHLVL': '1', 09:52:54 INFO - 'TERM': 'linux', 09:52:54 INFO - 'TMOUT': '86400', 09:52:54 INFO - 'USER': 'cltbld', 09:52:54 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499', 09:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:54 INFO - '_': '/tools/buildbot/bin/python'} 09:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:54 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:52:54 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:52:54 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:52:54 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:52:54 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:52:54 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:52:54 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:52:54 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:52:54 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:52:54 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:52:54 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:52:54 INFO - Cleaning up... 09:52:54 INFO - Return code: 0 09:52:54 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f10fff22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e8600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a77350>, '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 0x2a78250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a786e0>, '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': 'fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499', '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:52:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 09:52:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:52:54 INFO - Using env: {'DISPLAY': ':0', 09:52:54 INFO - 'HOME': '/home/cltbld', 09:52:54 INFO - 'LANG': 'en_US.UTF-8', 09:52:54 INFO - 'LANGUAGE': 'en_US:en', 09:52:54 INFO - 'LOGNAME': 'cltbld', 09:52:54 INFO - 'MAIL': '/var/mail/cltbld', 09:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:54 INFO - 'MOZ_NO_REMOTE': '1', 09:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:54 INFO - 'NO_EM_RESTART': '1', 09:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:52:54 INFO - 'PWD': '/builds/slave/test-pgo', 09:52:54 INFO - 'SHELL': '/bin/bash', 09:52:54 INFO - 'SHLVL': '1', 09:52:54 INFO - 'TERM': 'linux', 09:52:54 INFO - 'TMOUT': '86400', 09:52:54 INFO - 'USER': 'cltbld', 09:52:54 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499', 09:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:54 INFO - '_': '/tools/buildbot/bin/python'} 09:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:54 INFO - Downloading/unpacking jsonschema 09:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:52:56 INFO - Downloading/unpacking functools32 (from jsonschema) 09:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:56 INFO - Downloading functools32-3.2.3-2.tar.gz 09:52:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:52:56 INFO - warning: no files found matching '*.txt' 09:52:56 INFO - no previously-included directories found matching 'build' 09:52:56 INFO - no previously-included directories found matching 'dist' 09:52:56 INFO - no previously-included directories found matching '.git*' 09:52:56 INFO - Installing collected packages: jsonschema, functools32 09:52:56 INFO - Running setup.py install for functools32 09:52:56 INFO - warning: no files found matching '*.txt' 09:52:56 INFO - no previously-included directories found matching 'build' 09:52:56 INFO - no previously-included directories found matching 'dist' 09:52:56 INFO - no previously-included directories found matching '.git*' 09:52:56 INFO - Successfully installed jsonschema functools32 09:52:56 INFO - Cleaning up... 09:52:56 INFO - Return code: 0 09:52:56 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:52:56 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:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:56 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:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:52:56 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 0x7f10fff22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x291b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29e8600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a77350>, '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 0x2a78250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a786e0>, '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': 'fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499', '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:52:56 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:52:56 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:52:56 INFO - Using env: {'DISPLAY': ':0', 09:52:56 INFO - 'HOME': '/home/cltbld', 09:52:56 INFO - 'LANG': 'en_US.UTF-8', 09:52:56 INFO - 'LANGUAGE': 'en_US:en', 09:52:56 INFO - 'LOGNAME': 'cltbld', 09:52:56 INFO - 'MAIL': '/var/mail/cltbld', 09:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:56 INFO - 'MOZ_NO_REMOTE': '1', 09:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:52:56 INFO - 'NO_EM_RESTART': '1', 09:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:52:56 INFO - 'PWD': '/builds/slave/test-pgo', 09:52:56 INFO - 'SHELL': '/bin/bash', 09:52:56 INFO - 'SHLVL': '1', 09:52:56 INFO - 'TERM': 'linux', 09:52:56 INFO - 'TMOUT': '86400', 09:52:56 INFO - 'USER': 'cltbld', 09:52:56 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499', 09:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:56 INFO - '_': '/tools/buildbot/bin/python'} 09:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:52:56 INFO - Downloading/unpacking flake8 09:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:52:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:52:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:52:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:52:59 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:52:59 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:52:59 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:52:59 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:52:59 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:52:59 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:52:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:52:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:52:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:52:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:52:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:52:59 INFO - no previously-included directories found matching 'docs/_build' 09:52:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:52:59 INFO - Running setup.py install for pep8 09:52:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:52:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:52:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:52:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:52:59 INFO - no previously-included directories found matching 'docs/_build' 09:52:59 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:52:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:52:59 INFO - Cleaning up... 09:52:59 INFO - Return code: 0 09:52:59 INFO - Running post-action listener: _resource_record_post_action 09:52:59 INFO - Running post-action listener: _start_resource_monitoring 09:52:59 INFO - Starting resource monitoring. 09:52:59 INFO - ##### 09:52:59 INFO - ##### Running install step. 09:52:59 INFO - ##### 09:52:59 INFO - Running pre-action listener: _resource_record_pre_action 09:52:59 INFO - Running main action method: install 09:52:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:52:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:52:59 INFO - Reading from file tmpfile_stdout 09:52:59 INFO - Detecting whether we're running mozinstall >=1.0... 09:52:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:52:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:53:00 INFO - Reading from file tmpfile_stdout 09:53:00 INFO - Output received: 09:53:00 INFO - Usage: mozinstall [options] installer 09:53:00 INFO - Options: 09:53:00 INFO - -h, --help show this help message and exit 09:53:00 INFO - -d DEST, --destination=DEST 09:53:00 INFO - Directory to install application into. [default: 09:53:00 INFO - "/builds/slave/test-pgo"] 09:53:00 INFO - --app=APP Application being installed. [default: firefox] 09:53:00 INFO - mkdir: /builds/slave/test-pgo/build/application 09:53:00 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:53:00 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:53:14 INFO - Reading from file tmpfile_stdout 09:53:14 INFO - Output received: 09:53:14 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:53:14 INFO - Running post-action listener: _resource_record_post_action 09:53:14 INFO - ##### 09:53:14 INFO - ##### Running run-tests step. 09:53:14 INFO - ##### 09:53:14 INFO - Running pre-action listener: _resource_record_pre_action 09:53:14 INFO - Running main action method: run_tests 09:53:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:53:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:53:14 INFO - Python 2.7.3 09:53:14 INFO - Return code: 0 09:53:14 INFO - grabbing minidump binary from tooltool 09:53: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:53:14 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 0x2a77350>, '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 0x2a78250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a786e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:53:14 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:53:14 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:53:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:53:14 INFO - Return code: 0 09:53:14 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:53:14 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:53:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:53:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:53:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:53:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:53:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:53:15 INFO - Return code: 0 09:53:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', '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/1455722634/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:53:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName 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/1455722634/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost 09:53:15 INFO - Using env: {'DISPLAY': ':0', 09:53:15 INFO - 'HOME': '/home/cltbld', 09:53:15 INFO - 'LANG': 'en_US.UTF-8', 09:53:15 INFO - 'LANGUAGE': 'en_US:en', 09:53:15 INFO - 'LOGNAME': 'cltbld', 09:53:15 INFO - 'MAIL': '/var/mail/cltbld', 09:53:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:53:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:53:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:53:15 INFO - 'MOZ_NO_REMOTE': '1', 09:53:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:53:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:53:15 INFO - 'NO_EM_RESTART': '1', 09:53:15 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:53:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:53:15 INFO - 'PWD': '/builds/slave/test-pgo', 09:53:15 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:53:15 INFO - 'SHELL': '/bin/bash', 09:53:15 INFO - 'SHLVL': '1', 09:53:15 INFO - 'TERM': 'linux', 09:53:15 INFO - 'TMOUT': '86400', 09:53:15 INFO - 'USER': 'cltbld', 09:53:15 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499', 09:53:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:53:15 INFO - '_': '/tools/buildbot/bin/python'} 09:53:15 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/1455722634/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost'] with output_timeout 3600 09:53:15 INFO - mozversion INFO | application_buildid: 20160217072354 09:53:15 INFO - mozversion INFO | application_changeset: 339b62e92a292ada4c19f7fb7aa4455952d00930 09:53:15 INFO - mozversion INFO | application_display_name: Nightly 09:53:15 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:53:15 INFO - mozversion INFO | application_name: Firefox 09:53:15 INFO - mozversion INFO | application_remotingname: firefox 09:53:15 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:53:15 INFO - mozversion INFO | application_vendor: Mozilla 09:53:15 INFO - mozversion INFO | application_version: 45.0 09:53:15 INFO - mozversion INFO | platform_buildid: 20160217072354 09:53:15 INFO - mozversion INFO | platform_changeset: 339b62e92a292ada4c19f7fb7aa4455952d00930 09:53:15 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:53:15 INFO - mozversion INFO | platform_version: 45.0 09:53:15 INFO - 2016-02-17 09:53:15,964 DEBUG : using testdate: 1455731595 09:53:15 INFO - 2016-02-17 09:53:15,964 DEBUG : actual date: 1455731595 09:53:16 INFO - 2016-02-17 09:53:16,011 INFO : starting webserver on 'localhost:57499' 09:53:16 INFO - 2016-02-17 09:53:16,012 INFO : Starting test suite talos-linux64-ix-048 09:53:16 INFO - 2016-02-17 09:53:16,012 INFO : Starting test dromaeo_css 09:53:16 INFO - 2016-02-17 09:53:16,012 DEBUG : operating with platform_type : linux_ 09:53:16 INFO - 2016-02-17 09:53:16,013 INFO : Initialising browser for dromaeo_css test... 09:53:16 INFO - 2016-02-17 09:53:16,026 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmph8dd1k/profile http://localhost:57499/getInfo.html 09:53:20 INFO - 2016-02-17 09:53:20,160 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:53:20 INFO - 2016-02-17 09:53:20,160 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:53:20 INFO - 2016-02-17 09:53:20,160 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:53:20 INFO - 2016-02-17 09:53:20,160 DEBUG : BROWSER_OUTPUT: __metrics 09:53:20 INFO - 2016-02-17 09:53:20,309 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:53:21 INFO - 2016-02-17 09:53:21,136 INFO : Browser initialized. 09:53:21 INFO - 2016-02-17 09:53:21,136 INFO : Running cycle 1/1 for dromaeo_css test... 09:53:21 INFO - 2016-02-17 09:53:21,137 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmph8dd1k/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:53:32 INFO - 2016-02-17 09:53:32,809 DEBUG : BROWSER_OUTPUT: RSS: Main: 135061504 09:53:32 INFO - 2016-02-17 09:53:32,810 DEBUG : BROWSER_OUTPUT: 09:54:23 INFO - 2016-02-17 09:54:23,584 DEBUG : BROWSER_OUTPUT: 1455731663579 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:56:31 INFO - 2016-02-17 09:56:31,810 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57499/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57499/tests/dromaeo/cssquery-ext.html) 09:56:32 INFO - 2016-02-17 09:56:32,907 DEBUG : BROWSER_OUTPUT: RSS: Main: 212901888 09:56:32 INFO - 2016-02-17 09:56:32,908 DEBUG : BROWSER_OUTPUT: 09:59:34 INFO - 2016-02-17 09:59:34,969 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57499/tests/dromaeo/cssquery-ext.html (next: http://localhost:57499/tests/dromaeo/cssquery-jquery.html) 09:59:35 INFO - 2016-02-17 09:59:35,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 209510400 09:59:35 INFO - 2016-02-17 09:59:35,536 DEBUG : BROWSER_OUTPUT: 10:02:37 INFO - 2016-02-17 10:02:37,165 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57499/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57499/tests/dromaeo/cssquery-mootools.html) 10:02:37 INFO - 2016-02-17 10:02:37,727 DEBUG : BROWSER_OUTPUT: RSS: Main: 205455360 10:02:37 INFO - 2016-02-17 10:02:37,727 DEBUG : BROWSER_OUTPUT: 10:05:39 INFO - 2016-02-17 10:05:39,437 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57499/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57499/tests/dromaeo/cssquery-prototype.html) 10:05:39 INFO - 2016-02-17 10:05:39,999 DEBUG : BROWSER_OUTPUT: RSS: Main: 196120576 10:05:40 INFO - 2016-02-17 10:05:39,999 DEBUG : BROWSER_OUTPUT: 10:08:42 INFO - 2016-02-17 10:08:42,327 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57499/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57499/tests/dromaeo/cssquery-yui.html) 10:08:42 INFO - 2016-02-17 10:08:42,893 DEBUG : BROWSER_OUTPUT: RSS: Main: 199114752 10:08:42 INFO - 2016-02-17 10:08:42,894 DEBUG : BROWSER_OUTPUT: 10:11:45 INFO - 2016-02-17 10:11:45,043 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57499/tests/dromaeo/cssquery-yui.html (next: http://localhost:57499/tests/dromaeo/cssquery-dojo.html) 10:11:45 INFO - 2016-02-17 10:11:45,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 242606080 10:11:45 INFO - 2016-02-17 10:11:45,301 DEBUG : BROWSER_OUTPUT: 10:11:45 INFO - 2016-02-17 10:11:45,301 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:11:45 INFO - 2016-02-17 10:11:45,302 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:11:45 INFO - 2016-02-17 10:11:45,302 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:11:45 INFO - 2016-02-17 10:11:45,302 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:11:45 INFO - 2016-02-17 10:11:45,302 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3328;3383.357162139192;3397.1507123219194;3405.7615966882313;3428.931421371572;5577.9163312550345;5603.691796951166;5607.551395888329;5613.326400831901;5623.634463759853;5622.91565626516;5623.578231632634;5647.407022262665;5655.3779084300695;5656.490915817576;4941.950580494203;5049.368828896388;5122.8207012754565;5131.846044618667;5186.611004174683;5071.670341427795;5089.770960306795;5091.592672586203;5095.6178286628465;5097.05704444677;5074.06129865976;5077.213031980049;5108;5117.309163262949;5193.402758682762;5138.871528211787;5172.715500647463;5177.844664660066;5184.455632158644;5185.222216667492;5028.446870844205;5092.337996060489;5156.458571849939;5166.896662066738;5207.817726379559;5290.735463226823;5354.41101478837;5386.245925570423;5454.91817622736;5457.372402173761;5914.585978981473;5933.525317974551;5940.732667029951;5943.227380440559;6032.065029920369;5555.250041244421;5988.071848863433;5993.130996005555;5997.640141591475;6015.0375939849855;5658.858528536778;5704.800331988402;5775.682337471438;5786.276715410574;5813.418658134195;6135.07973803933;6135.877282454326;6138.600990935575;6146.692665366714;6176;5775.133729940459;5867.530597552186;5963.850903727442;5966.254218222723;5976.61152025117;5980.252468441445;6021.397860214031;6039.1545183674325;6045.909311360333;6050.152978583002;5999.250093738283;6055.212822333068;6087.482563982023;6093.238345206849;6096.573239873166;5829.242198514166;5912.674802885796;5973.79091731796;6084.939150608526;6087.147799308101;4536.88657783558;4592.747398893093;4615.5845973862515;4619.653525985565;4619.676622636383;4188.32986722123;4194.706370554032;4195.475565554306;4195.664346852244;4229.048464095554;5643.746031428595;5816.2148110005455;5816.534677225812;5828.125781132864;5831.94168058314;6005.3694362091355;6043.2748070231855;6122.245686735438;6128.601640893327;6137.754489820447;5778.3354914184565;5823.301203855564;5863.2670916135485;5867.119932010147;5875.148103524965;4895.167821470287;4996.4503904570465;5146.511081447256;5156.432792392834;5156.535911767959;6080.635161890301;6162.599431036968;6171.259448866164;6172.043333283348;6173.104899789416;6051.485623722033;6102.237220347457;6154.907676384947;6166.753329866755;6174.845628859314;6079.179310792986;6140.324564298013;6174.351693072163;6298.968505157628;6300.1809764732125;5920.8815823684145;5921.437463440966;5923.940760592339;5955.434233747787;6001.939980600313;5974.2233509643465;6031.728572214349;6034.456898879122;6035.245594300713;6044.425779550936;5754.4533269339345;5769.076947688518;5871.823845284648;5872.911906321323;5910.822675319747;5940.435658612425;5947.434993675594;5949.613275137102;5951.315598706205;5985.880282394241;5831.979403604268;5848.883022339614;5854.0340843760305;5855.912161317498;5864.266966629171;5544.667319960815;5567.693776842312;5822.76708931655;5896.734646940812;5902.61632993854;5813.651180929158;5816.476517113311;5816.563757718272;5819.709014549171;5883.058710606454 10:11:45 INFO - 2016-02-17 10:11:45,302 DEBUG : BROWSER_OUTPUT: |1;ext.html;587.4947545111206;620.3889169168369;637.7225906730571;665.4510029225889;682.569980912025;42681.35977960329;43366.56633433668;43505.564944350546;43517.7824110879;43525.12949741003;46759.29861052087;47322.29016564746;47323.290150647765;47355.76322118384;47372.76313618427;8114.837703245931;8229.053658829222;9163.08369163085;9352.345335826494;10449.634262800804;10742.140628749681;10865.130789536817;10871.45642717861;10876.673699789018;10877.07544858688;10871.67384978448;10953.123750100012;10983.560657573687;10985.231033827635;10987.61543345983;10792.406417647066;10869.239153259276;10884.510197041152;10888.945555272252;10896.673099807018;10585.100266477359;10690.412027338492;10704.732381690521;10705.1435885129;10712.25014249003;44518.33222501665;44882.32676509855;44949;45058.32412513815;45158.774206129085;3579.1052236940764;3626.3577694516252;3788.772673639563;3956.7823769692654;4409.889752756175;32929;33117.17207069819;33175;33200.66799332;34621.6537834621;4332.91334173318;4356.324769660708;4385;4446.088551846864;4482.5069242383315;295255;296704;297006;297546;430839.84580077213;53341.46658533443;72637;73806;73975.63012185012;74570;65454.67272663606;65888.6705566469;66024.66987665127;66079.33920660827;66102;16672.249748761093;16884.155792210342;16889.324427023028;16891.577710557336;16915.746263806053;12427.93786031064;12520.1235913487;12544.184627999151;12545.121841471191;12553.497860085678;21410.143594256057;21537.461563460725;21543.353699389045;21569.892150539148;21642.242521511987;7723.729669461542;7893.092294386219;7954.085280192852;8044.839103217902;8140.552269625109;1002.674130907458;1045.602670985036;1103.426218366445;1148.5004023249912;1183.1954271095738;30670.53994190089;30921.343844030627;31066.378672426876;31303.373932521223;31520.527192092137;1148.4372657397814;1156.5489459110954;1183.355071486042;1184.8696643369221;1236.4436003798328;13427.932860335832;15727.921360393124;16185.4335098271;16362.833220005876;16405.343786248417;363098;363132;363572;363657;364194;57823;58089.999999999156;58140;58260.70869645625;58292.708536457045;1484.6585285384422;1500.0474698566488;1504.473434298009;1505.473084420466;1525.9847401526065;31106.270514940225;31211.687883120878;31482.52776208313;31782.523262150622;31883.840580796947;51882;52239.73880130575;52402;52419;52487;339440;340300;341850;341980;342404;30542.083737487912;30711.2322191947;34938.12654683653;35218.295634087684;37086.814565927;39905.40141897816;40002.1999560013;40563;40875.591244087176;40910.38634420546;34033.829830850686;35384;38266.426003610526;38374.6795543183;38706.4194037084;32434.837825811665;37986.62013379831;38050.80974595109;38831.6116838828;39728.80135599303;35063.29873402569;38954.415683765335;39252.607473924894;39448.2110357797;39815.203695926495;29847.253818654706;30936.226594335323;31147.221319467193;31333.843330783202;32150.19624509406;24522.75477245276;24883.626745598467;25215.117470888432;26839.865800670872;27046.594301085894 10:11:45 INFO - 2016-02-17 10:11:45,302 DEBUG : BROWSER_OUTPUT: |2;jquery.html;374.35797607103814;381.95989421110767;383.7639851491333;387.4382145888462;390.50210980999225;17895.284188632457;19602.705959410585;19716;20560.588788224228;20575.176992920304;18136.727949080774;18141.90929045353;18328.083595820222;18383.81616183841;18479.538011549717;5637.46444087811;5771.365149833515;5776.018076926922;5782.768689252446;5787.363390027093;1700.7533907583393;1702.1659386900392;5675.594643214059;5688.488036076752;5732.111522713986;3305.7355411567137;4272.743635381887;4393.626541743955;5600.551955843523;5624.831255062355;4448.621867141297;6038.547108966845;6225.470834979033;6229.563930524842;6232.283287421959;5100.897982040338;5250.159974404077;5254.7635356409055;5564.248826408464;5611.551075913958;10205.591776328938;11402.258853174517;12311.138220324581;12762.872371276262;12840.807387889188;2359.1742889988536;2403.927882163538;2405.6992875890514;2463.19946017545;2494.77547020769;9361.344705870591;9760.609575617038;9946.204303655762;11315.83026254607;13275.668108297274;1921.269917431367;1958.1775654225116;1984.2658216460002;1989.9303524376721;2031.2484380779058;57136.714316428566;57236;58951.41048589502;59377.70311148417;60338;9929.65246216379;9964.352317099365;9967.252456065824;10055.29612927088;10138.188944884392;13141.67145821343;13185.274809885548;13198.27409492468;13201.867981320256;13209.603711888658;7948.165442628557;7979.162187970295;7999.36005119589;8020.639071241808;8046.074701409413;7853.136155022943;7879.448438609357;7890.921090789134;7928.207179282025;7952.642131104114;4325.632321252666;4344.9348259776125;4360.542143074931;4361.520232774392;4459.843905463294;1836.9908150459162;1916.875403098794;1948.6589846776758;1993.3521605478277;1995.580928005135;977.8044391121804;1033.2081261769324;1036.5231993283023;1069.3961350249708;1084.978300433987;17382.130893455276;17415.216315265843;17456.563585910455;17723.025233612276;17902.641947160984;904.4754042655244;959.3140904253353;972.8617517504537;980.221938914714;1031.865857438528;9550.95224523873;9684.854727179098;9688.515574221261;9769.853452198222;9822.017798220264;453612;604557;608372;608942;635441;85158;86145.56927215324;86909.56545217233;88917.55541222253;89841.55079224693;1205.168433780706;1221.8045112781913;1232.1067226260889;1237.4678888078033;1237.8205160251714;15955.441559545361;15980.840191597936;16062.919685401499;16116.355345786038;16465.25906334194;37207.627923720414;37597;37667;38109.809450953675;38509.614903851725;50616;50905.490945090074;51158.74420627873;54125.75245485284;55124.72437637786;10340.53467593945;10419.270651054354;10537.683869483928;10559;10559.102476289601;17576.38482653101;18149.911005339192;18330.72503912469;18418.539536511693;18705.719414208525;14957.551273461813;15120.848791511944;15191.544253672408;15249.695006100037;15665.68668626644;14677.633059173606;15040.097594144387;15172.393104275705;15396.84603153954;15633.765493517834;14869.256537173314;15065.924670377017;15113.848861511244;15359.846401535842;15473.071615703095;10362.326448780805;10392.48037598102;10506.106980906708;10523;10534.42060686639;15149.545513634608;15210.847891520943;15444.22778861075;15485.764778122202;15695.450659226872 10:11:45 INFO - 2016-02-17 10:11:45,302 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1511.31235287944;1525.4355888321322;1722.5892732389875;1779.9555011124721;1826.032202932446;7660.119086305077;7735.574543400111;7736.187700291466;7736.26505481979;7742.458027938046;7752.379809615231;7846;7856.882146767789;7857.764267071982;7882.132965373804;2332.9650055249185;2337.684412604298;2367.396313939943;2371.8932648030795;2372.7034120734907;2417.286900364397;2444.828861979662;2451.8283720139507;2452.963205551909;2453.6319552067152;1999.4801351648603;2047.8464115191346;2325.046730840356;2368.3605426534828;2443.7067551893797;2363.1728894886737;2380.666706661069;2394.784469397754;2398.8560686358874;2402.3513651314047;2364.881755912215;2418.117387153694;2419.8548087114655;2421.3462365161486;2422.2369953464777;6933.479989000794;7143.821404464878;7611.847763044763;7826.217378262185;7838.980932478741;4937.333459982929;4982.327385802906;5020.322256495363;5020.799168033274;5024.171011783052;3299.3236386540702;3304.1574398528223;3324.6675332466803;3326.1518312830317;3371.0729549373873;1056.9630062947838;1063.346042184059;1102.895224953628;1120.1654767198409;1123.8258069999163;10904.836427453594;11019.504122314514;11023.44882755867;11034.337939723642;11041.785403605598;4415.492218394861;4425.491068527161;4428.180786554498;4449;4461.04087621163;9342.392744471588;9381.624735010522;9382.5308734563;9388.436693798394;9389.154976052052;4933.407991041098;4942.950570494321;4988.975055124701;4990.8752281193265;4991.925121123186;4540.704854184468;4542.88642783933;4543.909121817545;4552.795124219418;4553.362529245908;3781.2815565042556;3837.5394952605866;3857.7492462989817;3877.185790983925;3879.4568760373004;1217.2635555488978;1224.357212463446;1228.4287806170173;1233.6730766346925;1241.416534228911;1145.352875625269;1146.060230610891;1259.6787819106069;1398.1960372785688;1417.376354404059;7610.9238907611325;7669.884951725729;7676.692932282646;7810.218978102144;7825.530468171814;1213.9635810925686;1216.8296438498617;1221.8717034711406;1243.347242697591;1243.564752336675;5741.712914354265;5746.511546518593;6189.04069869171;6230.7819226326865;6248.968755156195;9224.354295199406;9513.571889265;9639.132478077006;9684.41893486393;9710.6115755369;8895.822083558422;9080.137386948229;9243.90756092444;9647.276454265959;9687.321887467951;7464.738734144279;7602.42981776369;7604.619769011638;7607.505512141693;7614.086309642878;7468.925310746823;7481.476296659182;7491.9625401872645;7566.924330756622;7567.659455324634;8390.412671112963;8419.242268195892;8443.788905277417;8606.698765543177;8657.52383618907;8609.526476043628;8697.391182617155;8700;8876.068012858557;8885.333599979898;7144.749933752294;7159.570425774262;7164.176119746087;7175.605341706257;7239.674214660458;7537.359324457482;7710.344620707303;7721.382289416945;7740.225977402215;7748.263914928073;7019.719211231493;7101.964490177516;7198.74804381865;7278.890816637861;7369.520981136209;7088;7091.042709234187;7125.608091555015;7177.354038136593;7201.71193152268;6930.237673855771;7084.822879428056;7194.856102878018;7243.384312333511;7258.383037441666;6711.395974362331;6734.528582999143;6738.157730283715;6749.595024298558;6751.56114852533;6714.227863795726;6734.898976515258;6741.258461569321;6742.6628668567355;6753.020811982334 10:11:45 INFO - 2016-02-17 10:11:45,303 DEBUG : BROWSER_OUTPUT: |4;prototype.html;357.51735157537325;359.4015963420903;359.44824694094564;362.76239063413476;369.3831301726117;6028.668423236721;6033.336333003372;6082.391760823915;6095.3599872013465;6106.206193194889;6012.939870601293;6013.1581578579035;6015.578909476339;6026.548008899339;6049.697515124237;4478.373027776114;4639.8376056838015;4731.668783185179;4738.6919850209715;4740.71555706657;4640.048789998059;4675.251959686434;4677.298405239224;4693.36639553661;4701.835435759749;4632.768361581908;4653.418322709661;4658.138244424776;4660.254359302512;4666.1367646985245;4402.07556413152;4471.441069866267;4531.841385551523;4594.793234304464;4597.977010114962;4054.1283624020684;4058.7767672777986;4074.8777536673947;4078.714489985702;4087.3460246360737;5524.088525393306;5643.887122257573;5680.659160450345;5704;5731.512821410185;5261.0793111205385;5382.569394448435;5394.8921021579745;5396.244525766396;5407.351117865842;6362.395572420613;6363.236411630588;6372.076048972919;6374.362563743635;6379.808605741835;4506.797194126272;4509.526499717548;4512.864614061584;4523.411956445641;4528.07174529224;6374.458171055466;6590.835229119262;6593.637349945751;6597.60414375139;6600.141981542417;4595.770211489412;4596.678232523758;4597.0346227291975;4598.103369842848;4599.011212589309;4656.790444429941;4665.9766701166955;4667.766611669403;4668.3697700810635;4671.04243630055;5223.947760522422;5362.249285100089;5367;5369.624126311121;5384.084705599979;6414.807555773335;6424.38968298011;6437.581557198767;6439.420452159328;6444.516661250425;1619.9514014579581;1642.5236681362271;1644.3587001069593;1645.1116397145647;1646.7941507311587;1100.1968562949091;1115.6039605939936;1116.8380584815318;1132.2583707671488;1137.419915842926;6225.937740622627;6249.812505624838;6265.091561723524;6269.185005949197;6277.435030847246;6626.966865165643;6630.469562434993;6631.933680663132;6632.071509988606;6633.2703402625675;6117.082437634391;6248.187735594434;6251.343608921089;6256.280527739368;6266;3553.9822300888845;3579.1231148368297;3596.9820150899077;3602.7838329700303;3604.062943634621;6819.556728812611;6827.146606674166;6835.624040677711;6838.1794184697155;6844.691988860513;6569.737210511526;6643.069970204078;6738.966305168541;6741.123653925057;6759.391654751096;6880;6890.276520965327;6899.93100069003;6906.689198985957;6915.723371065202;6626.701798418986;6654.401103900672;6662.367075127855;6668.766593169215;6678.465722742266;6438.774642887476;6551.705173267119;6559.868802624016;6585.835354116185;6601.834954126185;6852.109225800614;6879.449644028566;6884.931150688429;6892.276310987274;6896.551724137915;4621.468531118964;4647.8140874366;4658.045100754405;4659.93010104842;4660.8135674574;6539.70571324282;6639.634820084942;6674.399304062657;6675.531383095711;6681.76613818514;6502.934970650422;6517.902231466626;6522.5760325578685;6522.836929076811;6522.967385163044;6471.385218404244;6472.385123413268;6473.514486413632;6482.935170648422;6485.092087107903;6280.277768056732;6393.8721225576155;6398.424141827258;6403.743850245938;6414.326495718069;6521.934780652323;6523.869522609616;6524.836879077871;6531.575447595891;6532.869342613216;6354.745810167541;6369.235691717024;6374.203224596926;6376.266729326001;6380.9361906380345 10:11:45 INFO - 2016-02-17 10:11:45,304 DEBUG : BROWSER_OUTPUT: |5;yui.html;809.2959125560759;866.0386970462786;885.2829208341244;947.4741518457262;950.3442624589034;12994.74010519789;13159.276239806806;13162.078654494166;13210.603681889535;13229.14010589311;12262.264264144158;12305.753884922296;12864.871351286485;12927.806082908764;12931.224126552414;742.2317900972495;751.6805357722973;902.8961669408004;910.7905181808188;918.3663272342096;920.1718453391934;923.4367036107968;931.7903471718877;932.4638332958542;932.6222879733684;968.2592816495387;977.4868194198067;977.8191034658611;978.4569563892037;978.7406337320616;774.8798936164875;786.9213078692143;935.8128374325128;964.4743614729989;969.1519920069939;716.4877112864327;717.5945590741214;719.8092505486051;720.718919621348;720.7873677265219;12686.80969785454;12806.935965320114;12810.29543375114;12818.61544153677;12836.39545056868;12007.93996030023;12426.316552589604;12518.561850335194;12565.434555445026;12749.362531873368;10029.799404011952;10108.292419530635;10272.845907311395;10338.844917326247;10354.63758768447;3720.8325625346924;3732.3841566141555;3757.4176002719623;3761.567419746709;3766.510353654035;46714.53285467136;47259.52740472586;48328.758356207996;48965.75517122427;49212.26181607243;9662.75843103914;9781.41311521311;9796.755081122887;9884.357516761387;9970.102690757867;19070;19338.226470941285;19341;19373.51566210856;19384.70922936157;7615.276548727862;7692.000039994765;7697.807554811063;7991.160928102582;8004.839903201903;4328.567143285709;4351.586599273064;4430.490493593214;4447.310666846644;4556.977215113903;3085.5834462347743;3096.210466331071;3100.3954228925595;3115.5793967814056;3120.1263646179104;557.2783245696833;578.2511647416605;578.4880380862967;582.2663444060514;592.0083859535262;636.2682914648192;660.6102399584269;671.000209687562;680.9523333366716;722.3643193989361;8041.356691464785;8211.753647390467;8563.785905352415;8907.73276801697;8935.865962010575;517.9223116532551;519.4831143012651;630.9621422714652;738.3502517784423;745.228688307599;3801.50580424543;3804.6195380462286;3869.8258578364043;3956.149427873021;4005.819738111792;60297.69851150716;60634.39365606376;61061.69469152626;61349.38650613437;61371;51995.74002129965;54308.72845635826;54373.72813135909;54699;55040.44959550433;48230;48715.269270960256;49242;49307;50466.495335046915;7719.575423351769;8019.719309824128;8025.8796118059445;8159.959200204198;8217.712380066669;34877.82561087178;35288.29423411466;35596.466053008706;35791.82104089463;36647.45028824516;43585.56414435815;43607.12785744331;44570.77714611406;48934.510654893;49322;11772.352520611448;11895.167338286583;12051.156419050933;12182.878171218174;12292.201006934522;11924.821127683264;12195.695107622381;12203.938980305042;12458;12678.3770558925;11169.218154729091;11565.479553420284;11727.765444690887;11735.413229338328;11908.940455297668;11744.530218791153;11775.52897884075;11805.350705711267;11976.401179941142;12102.273863568214;10371.377717336984;10377.429241391494;10476.63331783384;10644.574217031543;10731.678049658523;9845.261605379483;10084.848727269244;10105.646302379675;10221.693349199535;10462.110720588835;8616.956915215384;9868.605255789687;10129.89870101319;10186.796264074825;10221.23340749432 10:11:45 INFO - 2016-02-17 10:11:45,305 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:11:45 INFO - 2016-02-17 10:11:45,305 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:11:45 INFO - 2016-02-17 10:11:45,305 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,842 10:11:45 INFO - 2016-02-17 10:11:45,305 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:11:45 INFO - 2016-02-17 10:11:45,305 DEBUG : BROWSER_OUTPUT: __startTimestamp1455732705295__endTimestamp 10:11:45 INFO - 2016-02-17 10:11:45,305 DEBUG : BROWSER_OUTPUT: 10:11:45 INFO - 2016-02-17 10:11:45,305 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:11:45 INFO - 2016-02-17 10:11:45,305 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:11:45 INFO - 2016-02-17 10:11:45,305 DEBUG : BROWSER_OUTPUT: 10:11:45 INFO - 2016-02-17 10:11:45,305 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5594.11 Median:5829.24 stddev:618.70 (10.6%) stddev-sans-first:594.51 10:11:45 INFO - 2016-02-17 10:11:45,305 DEBUG : BROWSER_OUTPUT: Values: 3328.0 3383.4 3397.2 3405.8 3428.9 5577.9 5603.7 5607.6 5613.3 5623.6 5622.9 5623.6 5647.4 5655.4 5656.5 4942.0 5049.4 5122.8 5131.8 5186.6 5071.7 5089.8 5091.6 5095.6 5097.1 5074.1 5077.2 5108.0 5117.3 5193.4 5138.9 5172.7 5177.8 5184.5 5185.2 5028.4 5092.3 5156.5 5166.9 5207.8 5290.7 5354.4 5386.2 5454.9 5457.4 5914.6 5933.5 5940.7 5943.2 6032.1 5555.3 5988.1 5993.1 5997.6 6015.0 5658.9 5704.8 5775.7 5786.3 5813.4 6135.1 6135.9 6138.6 6146.7 6176.0 5775.1 5867.5 5963.9 5966.3 5976.6 5980.3 6021.4 6039.2 6045.9 6050.2 5999.3 6055.2 6087.5 6093.2 6096.6 5829.2 5912.7 5973.8 6084.9 6087.1 4536.9 4592.7 4615.6 4619.7 4619.7 4188.3 4194.7 4195.5 4195.7 4229.0 5643.7 5816.2 5816.5 5828.1 5831.9 6005.4 6043.3 6122.2 6128.6 6137.8 5778.3 5823.3 5863.3 5867.1 5875.1 4895.2 4996.5 5146.5 5156.4 5156.5 6080.6 6162.6 6171.3 6172.0 6173.1 6051.5 6102.2 6154.9 6166.8 6174.8 6079.2 6140.3 6174.4 6299.0 6300.2 5920.9 5921.4 5923.9 5955.4 6001.9 5974.2 6031.7 6034.5 6035.2 6044.4 5754.5 5769.1 5871.8 5872.9 5910.8 5940.4 5947.4 5949.6 5951.3 5985.9 5832.0 5848.9 5854.0 5855.9 5864.3 5544.7 5567.7 5822.8 5896.7 5902.6 5813.7 5816.5 5816.6 5819.7 5883.1 10:11:45 INFO - 2016-02-17 10:11:45,305 DEBUG : BROWSER_OUTPUT: 10:11:45 INFO - 2016-02-17 10:11:45,305 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:52472.92 Median:341915.00 stddev:90314.90 (26.4%) stddev-sans-first:90484.24 10:11:45 INFO - 2016-02-17 10:11:45,305 DEBUG : BROWSER_OUTPUT: Values: 587.5 620.4 637.7 665.5 682.6 42681.4 43366.6 43505.6 43517.8 43525.1 46759.3 47322.3 47323.3 47355.8 47372.8 8114.8 8229.1 9163.1 9352.3 10449.6 10742.1 10865.1 10871.5 10876.7 10877.1 10871.7 10953.1 10983.6 10985.2 10987.6 10792.4 10869.2 10884.5 10888.9 10896.7 10585.1 10690.4 10704.7 10705.1 10712.3 44518.3 44882.3 44949.0 45058.3 45158.8 3579.1 3626.4 3788.8 3956.8 4409.9 32929.0 33117.2 33175.0 33200.7 34621.7 4332.9 4356.3 4385.0 4446.1 4482.5 295255.0 296704.0 297006.0 297546.0 430839.8 53341.5 72637.0 73806.0 73975.6 74570.0 65454.7 65888.7 66024.7 66079.3 66102.0 16672.2 16884.2 16889.3 16891.6 16915.7 12427.9 12520.1 12544.2 12545.1 12553.5 21410.1 21537.5 21543.4 21569.9 21642.2 7723.7 7893.1 7954.1 8044.8 8140.6 1002.7 1045.6 1103.4 1148.5 1183.2 30670.5 30921.3 31066.4 31303.4 31520.5 1148.4 1156.5 1183.4 1184.9 1236.4 13427.9 15727.9 16185.4 16362.8 16405.3 363098.0 363132.0 363572.0 363657.0 364194.0 57823.0 58090.0 58140.0 58260.7 58292.7 1484.7 1500.0 1504.5 1505.5 1526.0 31106.3 31211.7 31482.5 31782.5 31883.8 51882.0 52239.7 52402.0 52419.0 52487.0 339440.0 340300.0 341850.0 341980.0 342404.0 30542.1 30711.2 34938.1 35218.3 37086.8 39905.4 40002.2 40563.0 40875.6 40910.4 34033.8 35384.0 38266.4 38374.7 38706.4 32434.8 37986.6 38050.8 38831.6 39728.8 35063.3 38954.4 39252.6 39448.2 39815.2 29847.3 30936.2 31147.2 31333.8 32150.2 24522.8 24883.6 25215.1 26839.9 27046.6 10:11:45 INFO - 2016-02-17 10:11:45,306 DEBUG : BROWSER_OUTPUT: 10:11:45 INFO - 2016-02-17 10:11:45,307 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:30602.12 Median:11467.18 stddev:95782.40 (835.3%) stddev-sans-first:96024.20 10:11:45 INFO - 2016-02-17 10:11:45,307 DEBUG : BROWSER_OUTPUT: Values: 374.4 382.0 383.8 387.4 390.5 17895.3 19602.7 19716.0 20560.6 20575.2 18136.7 18141.9 18328.1 18383.8 18479.5 5637.5 5771.4 5776.0 5782.8 5787.4 1700.8 1702.2 5675.6 5688.5 5732.1 3305.7 4272.7 4393.6 5600.6 5624.8 4448.6 6038.5 6225.5 6229.6 6232.3 5100.9 5250.2 5254.8 5564.2 5611.6 10205.6 11402.3 12311.1 12762.9 12840.8 2359.2 2403.9 2405.7 2463.2 2494.8 9361.3 9760.6 9946.2 11315.8 13275.7 1921.3 1958.2 1984.3 1989.9 2031.2 57136.7 57236.0 58951.4 59377.7 60338.0 9929.7 9964.4 9967.3 10055.3 10138.2 13141.7 13185.3 13198.3 13201.9 13209.6 7948.2 7979.2 7999.4 8020.6 8046.1 7853.1 7879.4 7890.9 7928.2 7952.6 4325.6 4344.9 4360.5 4361.5 4459.8 1837.0 1916.9 1948.7 1993.4 1995.6 977.8 1033.2 1036.5 1069.4 1085.0 17382.1 17415.2 17456.6 17723.0 17902.6 904.5 959.3 972.9 980.2 1031.9 9551.0 9684.9 9688.5 9769.9 9822.0 453612.0 604557.0 608372.0 608942.0 635441.0 85158.0 86145.6 86909.6 88917.6 89841.6 1205.2 1221.8 1232.1 1237.5 1237.8 15955.4 15980.8 16062.9 16116.4 16465.3 37207.6 37597.0 37667.0 38109.8 38509.6 50616.0 50905.5 51158.7 54125.8 55124.7 10340.5 10419.3 10537.7 10559.0 10559.1 17576.4 18149.9 18330.7 18418.5 18705.7 14957.6 15120.8 15191.5 15249.7 15665.7 14677.6 15040.1 15172.4 15396.8 15633.8 14869.3 15065.9 15113.8 15359.8 15473.1 10362.3 10392.5 10506.1 10523.0 10534.4 15149.5 15210.8 15444.2 15485.8 15695.5 10:11:45 INFO - 2016-02-17 10:11:45,307 DEBUG : BROWSER_OUTPUT: 10:11:45 INFO - 2016-02-17 10:11:45,307 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5629.11 Median:6712.81 stddev:2846.82 (42.4%) stddev-sans-first:2837.98 10:11:45 INFO - 2016-02-17 10:11:45,307 DEBUG : BROWSER_OUTPUT: Values: 1511.3 1525.4 1722.6 1780.0 1826.0 7660.1 7735.6 7736.2 7736.3 7742.5 7752.4 7846.0 7856.9 7857.8 7882.1 2333.0 2337.7 2367.4 2371.9 2372.7 2417.3 2444.8 2451.8 2453.0 2453.6 1999.5 2047.8 2325.0 2368.4 2443.7 2363.2 2380.7 2394.8 2398.9 2402.4 2364.9 2418.1 2419.9 2421.3 2422.2 6933.5 7143.8 7611.8 7826.2 7839.0 4937.3 4982.3 5020.3 5020.8 5024.2 3299.3 3304.2 3324.7 3326.2 3371.1 1057.0 1063.3 1102.9 1120.2 1123.8 10904.8 11019.5 11023.4 11034.3 11041.8 4415.5 4425.5 4428.2 4449.0 4461.0 9342.4 9381.6 9382.5 9388.4 9389.2 4933.4 4943.0 4989.0 4990.9 4991.9 4540.7 4542.9 4543.9 4552.8 4553.4 3781.3 3837.5 3857.7 3877.2 3879.5 1217.3 1224.4 1228.4 1233.7 1241.4 1145.4 1146.1 1259.7 1398.2 1417.4 7610.9 7669.9 7676.7 7810.2 7825.5 1214.0 1216.8 1221.9 1243.3 1243.6 5741.7 5746.5 6189.0 6230.8 6249.0 9224.4 9513.6 9639.1 9684.4 9710.6 8895.8 9080.1 9243.9 9647.3 9687.3 7464.7 7602.4 7604.6 7607.5 7614.1 7468.9 7481.5 7492.0 7566.9 7567.7 8390.4 8419.2 8443.8 8606.7 8657.5 8609.5 8697.4 8700.0 8876.1 8885.3 7144.7 7159.6 7164.2 7175.6 7239.7 7537.4 7710.3 7721.4 7740.2 7748.3 7019.7 7102.0 7198.7 7278.9 7369.5 7088.0 7091.0 7125.6 7177.4 7201.7 6930.2 7084.8 7194.9 7243.4 7258.4 6711.4 6734.5 6738.2 6749.6 6751.6 6714.2 6734.9 6741.3 6742.7 6753.0 10:11:45 INFO - 2016-02-17 10:11:45,307 DEBUG : BROWSER_OUTPUT: 10:11:45 INFO - 2016-02-17 10:11:45,307 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5391.05 Median:6171.51 stddev:1613.66 (26.1%) stddev-sans-first:1573.34 10:11:45 INFO - 2016-02-17 10:11:45,307 DEBUG : BROWSER_OUTPUT: Values: 357.5 359.4 359.4 362.8 369.4 6028.7 6033.3 6082.4 6095.4 6106.2 6012.9 6013.2 6015.6 6026.5 6049.7 4478.4 4639.8 4731.7 4738.7 4740.7 4640.0 4675.3 4677.3 4693.4 4701.8 4632.8 4653.4 4658.1 4660.3 4666.1 4402.1 4471.4 4531.8 4594.8 4598.0 4054.1 4058.8 4074.9 4078.7 4087.3 5524.1 5643.9 5680.7 5704.0 5731.5 5261.1 5382.6 5394.9 5396.2 5407.4 6362.4 6363.2 6372.1 6374.4 6379.8 4506.8 4509.5 4512.9 4523.4 4528.1 6374.5 6590.8 6593.6 6597.6 6600.1 4595.8 4596.7 4597.0 4598.1 4599.0 4656.8 4666.0 4667.8 4668.4 4671.0 5223.9 5362.2 5367.0 5369.6 5384.1 6414.8 6424.4 6437.6 6439.4 6444.5 1620.0 1642.5 1644.4 1645.1 1646.8 1100.2 1115.6 1116.8 1132.3 1137.4 6225.9 6249.8 6265.1 6269.2 6277.4 6627.0 6630.5 6631.9 6632.1 6633.3 6117.1 6248.2 6251.3 6256.3 6266.0 3554.0 3579.1 3597.0 3602.8 3604.1 6819.6 6827.1 6835.6 6838.2 6844.7 6569.7 6643.1 6739.0 6741.1 6759.4 6880.0 6890.3 6899.9 6906.7 6915.7 6626.7 6654.4 6662.4 6668.8 6678.5 6438.8 6551.7 6559.9 6585.8 6601.8 6852.1 6879.4 6884.9 6892.3 6896.6 4621.5 4647.8 4658.0 4659.9 4660.8 6539.7 6639.6 6674.4 6675.5 6681.8 6502.9 6517.9 6522.6 6522.8 6523.0 6471.4 6472.4 6473.5 6482.9 6485.1 6280.3 6393.9 6398.4 6403.7 6414.3 6521.9 6523.9 6524.8 6531.6 6532.9 6354.7 6369.2 6374.2 6376.3 6380.9 10:11:45 INFO - 2016-02-17 10:11:45,307 DEBUG : BROWSER_OUTPUT: 10:11:45 INFO - 2016-02-17 10:11:45,307 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14147.47 Median:46987.03 stddev:16657.70 (35.5%) stddev-sans-first:16674.32 10:11:45 INFO - 2016-02-17 10:11:45,309 DEBUG : BROWSER_OUTPUT: Values: 809.3 866.0 885.3 947.5 950.3 12994.7 13159.3 13162.1 13210.6 13229.1 12262.3 12305.8 12864.9 12927.8 12931.2 742.2 751.7 902.9 910.8 918.4 920.2 923.4 931.8 932.5 932.6 968.3 977.5 977.8 978.5 978.7 774.9 786.9 935.8 964.5 969.2 716.5 717.6 719.8 720.7 720.8 12686.8 12806.9 12810.3 12818.6 12836.4 12007.9 12426.3 12518.6 12565.4 12749.4 10029.8 10108.3 10272.8 10338.8 10354.6 3720.8 3732.4 3757.4 3761.6 3766.5 46714.5 47259.5 48328.8 48965.8 49212.3 9662.8 9781.4 9796.8 9884.4 9970.1 19070.0 19338.2 19341.0 19373.5 19384.7 7615.3 7692.0 7697.8 7991.2 8004.8 4328.6 4351.6 4430.5 4447.3 4557.0 3085.6 3096.2 3100.4 3115.6 3120.1 557.3 578.3 578.5 582.3 592.0 636.3 660.6 671.0 681.0 722.4 8041.4 8211.8 8563.8 8907.7 8935.9 517.9 519.5 631.0 738.4 745.2 3801.5 3804.6 3869.8 3956.1 4005.8 60297.7 60634.4 61061.7 61349.4 61371.0 51995.7 54308.7 54373.7 54699.0 55040.4 48230.0 48715.3 49242.0 49307.0 50466.5 7719.6 8019.7 8025.9 8160.0 8217.7 34877.8 35288.3 35596.5 35791.8 36647.5 43585.6 43607.1 44570.8 48934.5 49322.0 11772.4 11895.2 12051.2 12182.9 12292.2 11924.8 12195.7 12203.9 12458.0 12678.4 11169.2 11565.5 11727.8 11735.4 11908.9 11744.5 11775.5 11805.4 11976.4 12102.3 10371.4 10377.4 10476.6 10644.6 10731.7 9845.3 10084.8 10105.6 10221.7 10462.1 8617.0 9868.6 10129.9 10186.8 10221.2 10:11:45 INFO - 2016-02-17 10:11:45,309 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:11:45 INFO - 2016-02-17 10:11:45,309 DEBUG : BROWSER_OUTPUT: 10:11:45 INFO - 2016-02-17 10:11:45,868 INFO : Browser exited with error code: 0 10:11:45 INFO - 2016-02-17 10:11:45,886 INFO : Completed test dromaeo_css (00:18:29) 10:11:45 INFO - 2016-02-17 10:11:45,886 INFO : Starting test kraken 10:11:45 INFO - 2016-02-17 10:11:45,887 DEBUG : operating with platform_type : linux_ 10:11:45 INFO - 2016-02-17 10:11:45,887 INFO : Initialising browser for kraken test... 10:11:45 INFO - 2016-02-17 10:11:45,893 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7uhLAV/profile http://localhost:57499/getInfo.html 10:11:49 INFO - 2016-02-17 10:11:49,702 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:11:49 INFO - 2016-02-17 10:11:49,702 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:11:49 INFO - 2016-02-17 10:11:49,702 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:11:49 INFO - 2016-02-17 10:11:49,702 DEBUG : BROWSER_OUTPUT: __metrics 10:11:49 INFO - 2016-02-17 10:11:49,965 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:11:50 INFO - 2016-02-17 10:11:50,940 INFO : Browser initialized. 10:11:50 INFO - 2016-02-17 10:11:50,940 INFO : Running cycle 1/1 for kraken test... 10:11:50 INFO - 2016-02-17 10:11:50,941 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7uhLAV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:12:02 INFO - 2016-02-17 10:12:02,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 132927488 10:12:02 INFO - 2016-02-17 10:12:02,653 DEBUG : BROWSER_OUTPUT: 10:12:05 INFO - 2016-02-17 10:12:05,073 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57499/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57499/tests/kraken/driver.html?testName=audio-beat-detection) 10:12:05 INFO - 2016-02-17 10:12:05,655 DEBUG : BROWSER_OUTPUT: RSS: Main: 164663296 10:12:05 INFO - 2016-02-17 10:12:05,655 DEBUG : BROWSER_OUTPUT: 10:12:08 INFO - 2016-02-17 10:12:08,212 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57499/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57499/tests/kraken/driver.html?testName=audio-dft) 10:12:08 INFO - 2016-02-17 10:12:08,774 DEBUG : BROWSER_OUTPUT: RSS: Main: 162418688 10:12:08 INFO - 2016-02-17 10:12:08,774 DEBUG : BROWSER_OUTPUT: 10:12:11 INFO - 2016-02-17 10:12:11,571 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57499/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57499/tests/kraken/driver.html?testName=audio-fft) 10:12:12 INFO - 2016-02-17 10:12:12,132 DEBUG : BROWSER_OUTPUT: RSS: Main: 158830592 10:12:12 INFO - 2016-02-17 10:12:12,133 DEBUG : BROWSER_OUTPUT: 10:12:14 INFO - 2016-02-17 10:12:14,068 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57499/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57499/tests/kraken/driver.html?testName=audio-oscillator) 10:12:14 INFO - 2016-02-17 10:12:14,650 DEBUG : BROWSER_OUTPUT: RSS: Main: 159318016 10:12:14 INFO - 2016-02-17 10:12:14,650 DEBUG : BROWSER_OUTPUT: 10:12:16 INFO - 2016-02-17 10:12:16,837 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57499/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57499/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:12:17 INFO - 2016-02-17 10:12:17,398 DEBUG : BROWSER_OUTPUT: RSS: Main: 157167616 10:12:17 INFO - 2016-02-17 10:12:17,398 DEBUG : BROWSER_OUTPUT: 10:12:20 INFO - 2016-02-17 10:12:20,249 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57499/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57499/tests/kraken/driver.html?testName=imaging-darkroom) 10:12:20 INFO - 2016-02-17 10:12:20,823 DEBUG : BROWSER_OUTPUT: RSS: Main: 157986816 10:12:20 INFO - 2016-02-17 10:12:20,823 DEBUG : BROWSER_OUTPUT: 10:12:24 INFO - 2016-02-17 10:12:24,175 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57499/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57499/tests/kraken/driver.html?testName=imaging-desaturate) 10:12:24 INFO - 2016-02-17 10:12:24,743 DEBUG : BROWSER_OUTPUT: RSS: Main: 158695424 10:12:24 INFO - 2016-02-17 10:12:24,743 DEBUG : BROWSER_OUTPUT: 10:12:27 INFO - 2016-02-17 10:12:27,424 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57499/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57499/tests/kraken/driver.html?testName=json-parse-financial) 10:12:27 INFO - 2016-02-17 10:12:27,998 DEBUG : BROWSER_OUTPUT: RSS: Main: 158007296 10:12:27 INFO - 2016-02-17 10:12:27,998 DEBUG : BROWSER_OUTPUT: 10:12:29 INFO - 2016-02-17 10:12:29,526 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57499/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57499/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:12:30 INFO - 2016-02-17 10:12:30,088 DEBUG : BROWSER_OUTPUT: RSS: Main: 166330368 10:12:30 INFO - 2016-02-17 10:12:30,088 DEBUG : BROWSER_OUTPUT: 10:12:31 INFO - 2016-02-17 10:12:31,827 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57499/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57499/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:12:32 INFO - 2016-02-17 10:12:32,429 DEBUG : BROWSER_OUTPUT: RSS: Main: 163971072 10:12:32 INFO - 2016-02-17 10:12:32,429 DEBUG : BROWSER_OUTPUT: 10:12:34 INFO - 2016-02-17 10:12:34,402 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57499/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57499/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:12:34 INFO - 2016-02-17 10:12:34,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 169062400 10:12:34 INFO - 2016-02-17 10:12:34,969 DEBUG : BROWSER_OUTPUT: 10:12:37 INFO - 2016-02-17 10:12:37,309 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57499/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57499/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:12:37 INFO - 2016-02-17 10:12:37,890 DEBUG : BROWSER_OUTPUT: RSS: Main: 176197632 10:12:37 INFO - 2016-02-17 10:12:37,890 DEBUG : BROWSER_OUTPUT: 10:12:40 INFO - 2016-02-17 10:12:40,306 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57499/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57499/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:12:40 INFO - 2016-02-17 10:12:40,872 DEBUG : BROWSER_OUTPUT: RSS: Main: 174108672 10:12:40 INFO - 2016-02-17 10:12:40,872 DEBUG : BROWSER_OUTPUT: 10:12:42 INFO - 2016-02-17 10:12:42,521 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57499/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57499/tests/kraken/driver.html?testName=ai-astar) 10:12:42 INFO - 2016-02-17 10:12:42,765 DEBUG : BROWSER_OUTPUT: RSS: Main: 231460864 10:12:42 INFO - 2016-02-17 10:12:42,765 DEBUG : BROWSER_OUTPUT: 10:12:42 INFO - 2016-02-17 10:12:42,768 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:12:42 INFO - 2016-02-17 10:12:42,768 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:12:42 INFO - 2016-02-17 10:12:42,769 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:12:42 INFO - 2016-02-17 10:12:42,769 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:12:42 INFO - 2016-02-17 10:12:42,769 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;111;103;107;109;112;97;109;109;107 10:12:42 INFO - 2016-02-17 10:12:42,769 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;141;124;148;153;127;154;150;122;163;121 10:12:42 INFO - 2016-02-17 10:12:42,769 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;159;160;159;160;164;160;161;160;160 10:12:42 INFO - 2016-02-17 10:12:42,769 DEBUG : BROWSER_OUTPUT: |3;audio-fft;69;70;71;139;72;71;71;72;155;70 10:12:42 INFO - 2016-02-17 10:12:42,769 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;92;137;91;93;92;141;92;92;136 10:12:42 INFO - 2016-02-17 10:12:42,769 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;110;109;110;110;110;110 10:12:42 INFO - 2016-02-17 10:12:42,769 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;148;147;145;146;146;146;145;146;146 10:12:42 INFO - 2016-02-17 10:12:42,770 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;95;95;95;96;96;96;96 10:12:42 INFO - 2016-02-17 10:12:42,770 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;56;57;55;55;56;56;55;55;54 10:12:42 INFO - 2016-02-17 10:12:42,770 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;63;63;62;63;65;64;64;64;63 10:12:42 INFO - 2016-02-17 10:12:42,770 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;78;78;79;77;79;87;78;78;78 10:12:42 INFO - 2016-02-17 10:12:42,770 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;114;113;117;110;119;117;121;110;117;110 10:12:42 INFO - 2016-02-17 10:12:42,770 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;133;129;132;140;138;137;139;137;131;140 10:12:42 INFO - 2016-02-17 10:12:42,770 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;63;64;64;65;62;64;64;68;63;62 10:12:42 INFO - 2016-02-17 10:12:42,770 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:12:42 INFO - 2016-02-17 10:12:42,771 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:12:42 INFO - 2016-02-17 10:12:42,771 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,904 10:12:42 INFO - 2016-02-17 10:12:42,771 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:12:42 INFO - 2016-02-17 10:12:42,771 DEBUG : BROWSER_OUTPUT: __startTimestamp1455732762767__endTimestamp 10:12:42 INFO - 2016-02-17 10:12:42,771 DEBUG : BROWSER_OUTPUT: 10:12:42 INFO - 2016-02-17 10:12:42,779 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:12:42 INFO - 2016-02-17 10:12:42,779 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:12:42 INFO - 2016-02-17 10:12:42,779 DEBUG : BROWSER_OUTPUT: 10:12:42 INFO - 2016-02-17 10:12:42,779 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.20 Median:109.00 stddev:4.34 (4.0%) stddev-sans-first:4.59 10:12:42 INFO - 2016-02-17 10:12:42,779 DEBUG : BROWSER_OUTPUT: Values: 108.0 111.0 103.0 107.0 109.0 112.0 97.0 109.0 109.0 107.0 10:12:42 INFO - 2016-02-17 10:12:42,779 DEBUG : BROWSER_OUTPUT: 10:12:42 INFO - 2016-02-17 10:12:42,779 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.30 Median:149.00 stddev:15.52 (10.4%) stddev-sans-first:16.46 10:12:42 INFO - 2016-02-17 10:12:42,779 DEBUG : BROWSER_OUTPUT: Values: 141.0 124.0 148.0 153.0 127.0 154.0 150.0 122.0 163.0 121.0 10:12:42 INFO - 2016-02-17 10:12:42,779 DEBUG : BROWSER_OUTPUT: 10:12:42 INFO - 2016-02-17 10:12:42,779 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.40 Median:160.00 stddev:1.43 (0.9%) stddev-sans-first:1.50 10:12:42 INFO - 2016-02-17 10:12:42,780 DEBUG : BROWSER_OUTPUT: Values: 161.0 159.0 160.0 159.0 160.0 164.0 160.0 161.0 160.0 160.0 10:12:42 INFO - 2016-02-17 10:12:42,780 DEBUG : BROWSER_OUTPUT: 10:12:42 INFO - 2016-02-17 10:12:42,780 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:86.00 Median:71.00 stddev:32.38 (45.6%) stddev-sans-first:33.76 10:12:42 INFO - 2016-02-17 10:12:42,780 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 71.0 139.0 72.0 71.0 71.0 72.0 155.0 70.0 10:12:42 INFO - 2016-02-17 10:12:42,780 DEBUG : BROWSER_OUTPUT: 10:12:42 INFO - 2016-02-17 10:12:42,780 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.90 Median:92.00 stddev:22.19 (24.1%) stddev-sans-first:23.04 10:12:42 INFO - 2016-02-17 10:12:42,780 DEBUG : BROWSER_OUTPUT: Values: 93.0 92.0 137.0 91.0 93.0 92.0 141.0 92.0 92.0 136.0 10:12:42 INFO - 2016-02-17 10:12:42,780 DEBUG : BROWSER_OUTPUT: 10:12:42 INFO - 2016-02-17 10:12:42,780 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 10:12:42 INFO - 2016-02-17 10:12:42,780 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 110.0 109.0 110.0 110.0 110.0 110.0 10:12:42 INFO - 2016-02-17 10:12:42,780 DEBUG : BROWSER_OUTPUT: 10:12:42 INFO - 2016-02-17 10:12:42,780 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:1.26 (0.9%) stddev-sans-first:0.93 10:12:42 INFO - 2016-02-17 10:12:42,780 DEBUG : BROWSER_OUTPUT: Values: 149.0 148.0 147.0 145.0 146.0 146.0 146.0 145.0 146.0 146.0 10:12:42 INFO - 2016-02-17 10:12:42,780 DEBUG : BROWSER_OUTPUT: 10:12:42 INFO - 2016-02-17 10:12:42,780 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 10:12:42 INFO - 2016-02-17 10:12:42,780 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 10:12:42 INFO - 2016-02-17 10:12:42,781 DEBUG : BROWSER_OUTPUT: 10:12:42 INFO - 2016-02-17 10:12:42,781 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.00 stddev:0.85 (1.5%) stddev-sans-first:0.88 10:12:42 INFO - 2016-02-17 10:12:42,781 DEBUG : BROWSER_OUTPUT: Values: 56.0 56.0 57.0 55.0 55.0 56.0 56.0 55.0 55.0 54.0 10:12:42 INFO - 2016-02-17 10:12:42,781 DEBUG : BROWSER_OUTPUT: 10:12:42 INFO - 2016-02-17 10:12:42,781 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:63.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 10:12:42 INFO - 2016-02-17 10:12:42,781 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 63.0 62.0 63.0 65.0 64.0 64.0 64.0 63.0 10:12:42 INFO - 2016-02-17 10:12:42,781 DEBUG : BROWSER_OUTPUT: 10:12:42 INFO - 2016-02-17 10:12:42,781 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:78.00 stddev:2.92 (3.7%) stddev-sans-first:3.02 10:12:42 INFO - 2016-02-17 10:12:42,781 DEBUG : BROWSER_OUTPUT: Values: 77.0 78.0 78.0 79.0 77.0 79.0 87.0 78.0 78.0 78.0 10:12:42 INFO - 2016-02-17 10:12:42,781 DEBUG : BROWSER_OUTPUT: 10:12:42 INFO - 2016-02-17 10:12:42,781 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:114.80 Median:117.00 stddev:3.99 (3.4%) stddev-sans-first:4.23 10:12:42 INFO - 2016-02-17 10:12:42,781 DEBUG : BROWSER_OUTPUT: Values: 114.0 113.0 117.0 110.0 119.0 117.0 121.0 110.0 117.0 110.0 10:12:42 INFO - 2016-02-17 10:12:42,781 DEBUG : BROWSER_OUTPUT: 10:12:42 INFO - 2016-02-17 10:12:42,781 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.60 Median:137.50 stddev:4.01 (2.9%) stddev-sans-first:4.14 10:12:42 INFO - 2016-02-17 10:12:42,781 DEBUG : BROWSER_OUTPUT: Values: 133.0 129.0 132.0 140.0 138.0 137.0 139.0 137.0 131.0 140.0 10:12:42 INFO - 2016-02-17 10:12:42,781 DEBUG : BROWSER_OUTPUT: 10:12:42 INFO - 2016-02-17 10:12:42,782 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:1.73 (2.7%) stddev-sans-first:1.80 10:12:42 INFO - 2016-02-17 10:12:42,782 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 64.0 65.0 62.0 64.0 64.0 68.0 63.0 62.0 10:12:42 INFO - 2016-02-17 10:12:42,782 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:12:42 INFO - 2016-02-17 10:12:42,782 DEBUG : BROWSER_OUTPUT: 10:12:43 INFO - 2016-02-17 10:12:43,436 INFO : Browser exited with error code: 0 10:12:43 INFO - 2016-02-17 10:12:43,494 INFO : Completed test kraken (00:00:57) 10:12:43 INFO - 2016-02-17 10:12:43,495 INFO : Starting test v8_7 10:12:43 INFO - 2016-02-17 10:12:43,495 DEBUG : operating with platform_type : linux_ 10:12:43 INFO - 2016-02-17 10:12:43,495 INFO : Initialising browser for v8_7 test... 10:12:43 INFO - 2016-02-17 10:12:43,501 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6aJ2CY/profile http://localhost:57499/getInfo.html 10:12:47 INFO - 2016-02-17 10:12:47,337 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:12:47 INFO - 2016-02-17 10:12:47,338 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:12:47 INFO - 2016-02-17 10:12:47,338 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:12:47 INFO - 2016-02-17 10:12:47,338 DEBUG : BROWSER_OUTPUT: __metrics 10:12:47 INFO - 2016-02-17 10:12:47,642 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:12:48 INFO - 2016-02-17 10:12:48,560 INFO : Browser initialized. 10:12:48 INFO - 2016-02-17 10:12:48,560 INFO : Running cycle 1/1 for v8_7 test... 10:12:48 INFO - 2016-02-17 10:12:48,561 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6aJ2CY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:13:00 INFO - 2016-02-17 10:13:00,303 DEBUG : BROWSER_OUTPUT: RSS: Main: 133382144 10:13:00 INFO - 2016-02-17 10:13:00,303 DEBUG : BROWSER_OUTPUT: 10:13:21 INFO - 2016-02-17 10:13:21,656 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57499/tests/v8_7/run.html (next: http://localhost:57499/tests/v8_7/run.html) 10:13:21 INFO - 2016-02-17 10:13:21,907 DEBUG : BROWSER_OUTPUT: RSS: Main: 432947200 10:13:21 INFO - 2016-02-17 10:13:21,907 DEBUG : BROWSER_OUTPUT: 10:13:21 INFO - 2016-02-17 10:13:21,907 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:13:21 INFO - 2016-02-17 10:13:21,907 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:13:21 INFO - 2016-02-17 10:13:21,907 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:13:21 INFO - 2016-02-17 10:13:21,907 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:13:21 INFO - 2016-02-17 10:13:21,908 DEBUG : BROWSER_OUTPUT: |0;Richards;172.20595832615808 10:13:21 INFO - 2016-02-17 10:13:21,908 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;170.590242238144 10:13:21 INFO - 2016-02-17 10:13:21,908 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.0083102493075 10:13:21 INFO - 2016-02-17 10:13:21,908 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5096.446700507614 10:13:21 INFO - 2016-02-17 10:13:21,908 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1106.1946902654868 10:13:21 INFO - 2016-02-17 10:13:21,908 DEBUG : BROWSER_OUTPUT: |5;Earley;542.5935973955508 10:13:21 INFO - 2016-02-17 10:13:21,909 DEBUG : BROWSER_OUTPUT: |6;Boyer;10902.173913043478 10:13:21 INFO - 2016-02-17 10:13:21,909 DEBUG : BROWSER_OUTPUT: |7;RegExp;23767.441860465115 10:13:21 INFO - 2016-02-17 10:13:21,909 DEBUG : BROWSER_OUTPUT: |8;Splay;535.0454788657036 10:13:21 INFO - 2016-02-17 10:13:21,909 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 10:13:21 INFO - 2016-02-17 10:13:21,909 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:13:21 INFO - 2016-02-17 10:13:21,910 DEBUG : BROWSER_OUTPUT: __startTimestamp1455732801905__endTimestamp 10:13:21 INFO - 2016-02-17 10:13:21,910 DEBUG : BROWSER_OUTPUT: 10:13:21 INFO - 2016-02-17 10:13:21,910 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:13:21 INFO - 2016-02-17 10:13:21,910 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:13:21 INFO - 2016-02-17 10:13:21,910 DEBUG : BROWSER_OUTPUT: 10:13:21 INFO - 2016-02-17 10:13:21,910 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:172.21 Median:172.21 stddev:0.00 (0.0%) 10:13:21 INFO - 2016-02-17 10:13:21,911 DEBUG : BROWSER_OUTPUT: Values: 172.2 10:13:21 INFO - 2016-02-17 10:13:21,911 DEBUG : BROWSER_OUTPUT: 10:13:21 INFO - 2016-02-17 10:13:21,911 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:170.59 Median:170.59 stddev:0.00 (0.0%) 10:13:21 INFO - 2016-02-17 10:13:21,911 DEBUG : BROWSER_OUTPUT: Values: 170.6 10:13:21 INFO - 2016-02-17 10:13:21,911 DEBUG : BROWSER_OUTPUT: 10:13:21 INFO - 2016-02-17 10:13:21,912 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.01 Median:277.01 stddev:0.00 (0.0%) 10:13:21 INFO - 2016-02-17 10:13:21,912 DEBUG : BROWSER_OUTPUT: Values: 277.0 10:13:21 INFO - 2016-02-17 10:13:21,912 DEBUG : BROWSER_OUTPUT: 10:13:21 INFO - 2016-02-17 10:13:21,912 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5096.45 Median:5096.45 stddev:0.00 (0.0%) 10:13:21 INFO - 2016-02-17 10:13:21,912 DEBUG : BROWSER_OUTPUT: Values: 5096.4 10:13:21 INFO - 2016-02-17 10:13:21,913 DEBUG : BROWSER_OUTPUT: 10:13:21 INFO - 2016-02-17 10:13:21,913 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1106.19 Median:1106.19 stddev:0.00 (0.0%) 10:13:21 INFO - 2016-02-17 10:13:21,913 DEBUG : BROWSER_OUTPUT: Values: 1106.2 10:13:21 INFO - 2016-02-17 10:13:21,913 DEBUG : BROWSER_OUTPUT: 10:13:21 INFO - 2016-02-17 10:13:21,913 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:542.59 Median:542.59 stddev:0.00 (0.0%) 10:13:21 INFO - 2016-02-17 10:13:21,913 DEBUG : BROWSER_OUTPUT: Values: 542.6 10:13:21 INFO - 2016-02-17 10:13:21,914 DEBUG : BROWSER_OUTPUT: 10:13:21 INFO - 2016-02-17 10:13:21,914 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10902.17 Median:10902.17 stddev:0.00 (0.0%) 10:13:21 INFO - 2016-02-17 10:13:21,914 DEBUG : BROWSER_OUTPUT: Values: 10902.2 10:13:21 INFO - 2016-02-17 10:13:21,914 DEBUG : BROWSER_OUTPUT: 10:13:21 INFO - 2016-02-17 10:13:21,914 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23767.44 Median:23767.44 stddev:0.00 (0.0%) 10:13:21 INFO - 2016-02-17 10:13:21,915 DEBUG : BROWSER_OUTPUT: Values: 23767.4 10:13:21 INFO - 2016-02-17 10:13:21,915 DEBUG : BROWSER_OUTPUT: 10:13:21 INFO - 2016-02-17 10:13:21,915 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:535.05 Median:535.05 stddev:0.00 (0.0%) 10:13:21 INFO - 2016-02-17 10:13:21,915 DEBUG : BROWSER_OUTPUT: Values: 535.0 10:13:21 INFO - 2016-02-17 10:13:21,915 DEBUG : BROWSER_OUTPUT: 10:13:21 INFO - 2016-02-17 10:13:21,915 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 10:13:21 INFO - 2016-02-17 10:13:21,916 DEBUG : BROWSER_OUTPUT: Values: 4830.9 10:13:21 INFO - 2016-02-17 10:13:21,916 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:13:21 INFO - 2016-02-17 10:13:21,916 DEBUG : BROWSER_OUTPUT: 10:13:22 INFO - 2016-02-17 10:13:22,596 INFO : Browser exited with error code: 0 10:13:22 INFO - 2016-02-17 10:13:22,613 INFO : Completed test v8_7 (00:00:39) 10:13:22 INFO - 2016-02-17 10:13:22,980 INFO : Completed test suite (00:20:06) 10:13:22 INFO - 2016-02-17 10:13:22,980 DEBUG : Working with test: dromaeo_css 10:13:22 INFO - 2016-02-17 10:13:22,980 DEBUG : Generating results file: dromaeo_css 10:13:22 INFO - 2016-02-17 10:13:22,982 DEBUG : Working with test: kraken 10:13:22 INFO - 2016-02-17 10:13:22,982 DEBUG : Generating results file: kraken 10:13:22 INFO - 2016-02-17 10:13:22,982 INFO : javascript benchmark 10:13:22 INFO - 2016-02-17 10:13:22,982 DEBUG : Working with test: v8_7 10:13:22 INFO - 2016-02-17 10:13:22,983 DEBUG : Generating results file: v8_7 10:13:22 INFO - 2016-02-17 10:13:22,983 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:13:23 INFO - 2016-02-17 10:13:23,046 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 10:13:23 INFO - 2016-02-17 10:13:23,046 DEBUG : process_Request line: dromaeo_css 7317.22 graph.html#tests=[[72,53,35]] 10:13:23 INFO - 2016-02-17 10:13:23,046 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:13:23 INFO - 2016-02-17 10:13:23,091 DEBUG : process_Request line: kraken 1463.50 graph.html#tests=[[232,53,35]] 10:13:23 INFO - 2016-02-17 10:13:23,091 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:13:23 INFO - 2016-02-17 10:13:23,127 DEBUG : process_Request line: v8_7 22759.83 graph.html#tests=[[230,53,35]] 10:13:23 INFO - 2016-02-17 10:13:23,128 INFO : javascript benchmark 10:13:23 INFO - 2016-02-17 10:13:23,132 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3328.0, 3383.357162139192, 3397.1507123219194, 3405.7615966882313, 3428.931421371572, 5577.9163312550345, 5603.691796951166, 5607.551395888329, 5613.326400831901, 5623.634463759853, 5622.91565626516, 5623.578231632634, 5647.407022262665, 5655.3779084300695, 5656.490915817576, 4941.950580494203, 5049.368828896388, 5122.8207012754565, 5131.846044618667, 5186.611004174683, 5071.670341427795, 5089.770960306795, 5091.592672586203, 5095.6178286628465, 5097.05704444677, 5074.06129865976, 5077.213031980049, 5108.0, 5117.309163262949, 5193.402758682762, 5138.871528211787, 5172.715500647463, 5177.844664660066, 5184.455632158644, 5185.222216667492, 5028.446870844205, 5092.337996060489, 5156.458571849939, 5166.896662066738, 5207.817726379559, 5290.735463226823, 5354.41101478837, 5386.245925570423, 5454.91817622736, 5457.372402173761, 5914.585978981473, 5933.525317974551, 5940.732667029951, 5943.227380440559, 6032.065029920369, 5555.250041244421, 5988.071848863433, 5993.130996005555, 5997.640141591475, 6015.0375939849855, 5658.858528536778, 5704.800331988402, 5775.682337471438, 5786.276715410574, 5813.418658134195, 6135.07973803933, 6135.877282454326, 6138.600990935575, 6146.692665366714, 6176.0, 5775.133729940459, 5867.530597552186, 5963.850903727442, 5966.254218222723, 5976.61152025117, 5980.252468441445, 6021.397860214031, 6039.1545183674325, 6045.909311360333, 6050.152978583002, 5999.250093738283, 6055.212822333068, 6087.482563982023, 6093.238345206849, 6096.573239873166, 5829.242198514166, 5912.674802885796, 5973.79091731796, 6084.939150608526, 6087.147799308101, 4536.88657783558, 4592.747398893093, 4615.5845973862515, 4619.653525985565, 4619.676622636383, 4188.32986722123, 4194.706370554032, 4195.475565554306, 4195.664346852244, 4229.048464095554, 5643.746031428595, 5816.2148110005455, 5816.534677225812, 5828.125781132864, 5831.94168058314, 6005.3694362091355, 6043.2748070231855, 6122.245686735438, 6128.601640893327, 6137.754489820447, 5778.3354914184565, 5823.301203855564, 5863.2670916135485, 5867.119932010147, 5875.148103524965, 4895.167821470287, 4996.4503904570465, 5146.511081447256, 5156.432792392834, 5156.535911767959, 6080.635161890301, 6162.599431036968, 6171.259448866164, 6172.043333283348, 6173.104899789416, 6051.485623722033, 6102.237220347457, 6154.907676384947, 6166.753329866755, 6174.845628859314, 6079.179310792986, 6140.324564298013, 6174.351693072163, 6298.968505157628, 6300.1809764732125, 5920.8815823684145, 5921.437463440966, 5923.940760592339, 5955.434233747787, 6001.939980600313, 5974.2233509643465, 6031.728572214349, 6034.456898879122, 6035.245594300713, 6044.425779550936, 5754.4533269339345, 5769.076947688518, 5871.823845284648, 5872.911906321323, 5910.822675319747, 5940.435658612425, 5947.434993675594, 5949.613275137102, 5951.315598706205, 5985.880282394241, 5831.979403604268, 5848.883022339614, 5854.0340843760305, 5855.912161317498, 5864.266966629171, 5544.667319960815, 5567.693776842312, 5822.76708931655, 5896.734646940812, 5902.61632993854, 5813.651180929158, 5816.476517113311, 5816.563757718272, 5819.709014549171, 5883.058710606454], "unit": "ms", "name": "dojo.html", "value": 5554.401125097924}, {"lowerIsBetter": false, "replicates": [587.4947545111206, 620.3889169168369, 637.7225906730571, 665.4510029225889, 682.569980912025, 42681.35977960329, 43366.56633433668, 43505.564944350546, 43517.7824110879, 43525.12949741003, 46759.29861052087, 47322.29016564746, 47323.290150647765, 47355.76322118384, 47372.76313618427, 8114.837703245931, 8229.053658829222, 9163.08369163085, 9352.345335826494, 10449.634262800804, 10742.140628749681, 10865.130789536817, 10871.45642717861, 10876.673699789018, 10877.07544858688, 10871.67384978448, 10953.123750100012, 10983.560657573687, 10985.231033827635, 10987.61543345983, 10792.406417647066, 10869.239153259276, 10884.510197041152, 10888.945555272252, 10896.673099807018, 10585.100266477359, 10690.412027338492, 10704.732381690521, 10705.1435885129, 10712.25014249003, 44518.33222501665, 44882.32676509855, 44949.0, 45058.32412513815, 45158.774206129085, 3579.1052236940764, 3626.3577694516252, 3788.772673639563, 3956.7823769692654, 4409.889752756175, 32929.0, 33117.17207069819, 33175.0, 33200.66799332, 34621.6537834621, 4332.91334173318, 4356.324769660708, 4385.0, 4446.088551846864, 4482.5069242383315, 295255.0, 296704.0, 297006.0, 297546.0, 430839.84580077213, 53341.46658533443, 72637.0, 73806.0, 73975.63012185012, 74570.0, 65454.67272663606, 65888.6705566469, 66024.66987665127, 66079.33920660827, 66102.0, 16672.249748761093, 16884.155792210342, 16889.324427023028, 16891.577710557336, 16915.746263806053, 12427.93786031064, 12520.1235913487, 12544.184627999151, 12545.121841471191, 12553.497860085678, 21410.143594256057, 21537.461563460725, 21543.353699389045, 21569.892150539148, 21642.242521511987, 7723.729669461542, 7893.092294386219, 7954.085280192852, 8044.839103217902, 8140.552269625109, 1002.674130907458, 1045.602670985036, 1103.426218366445, 1148.5004023249912, 1183.1954271095738, 30670.53994190089, 30921.343844030627, 31066.378672426876, 31303.373932521223, 31520.527192092137, 1148.4372657397814, 1156.5489459110954, 1183.355071486042, 1184.8696643369221, 1236.4436003798328, 13427.932860335832, 15727.921360393124, 16185.4335098271, 16362.833220005876, 16405.343786248417, 363098.0, 363132.0, 363572.0, 363657.0, 364194.0, 57823.0, 58089.999999999156, 58140.0, 58260.70869645625, 58292.708536457045, 1484.6585285384422, 1500.0474698566488, 1504.473434298009, 1505.473084420466, 1525.9847401526065, 31106.270514940225, 31211.687883120878, 31482.52776208313, 31782.523262150622, 31883.840580796947, 51882.0, 52239.73880130575, 52402.0, 52419.0, 52487.0, 339440.0, 340300.0, 341850.0, 341980.0, 342404.0, 30542.083737487912, 30711.2322191947, 34938.12654683653, 35218.295634087684, 37086.814565927, 39905.40141897816, 40002.1999560013, 40563.0, 40875.591244087176, 40910.38634420546, 34033.829830850686, 35384.0, 38266.426003610526, 38374.6795543183, 38706.4194037084, 32434.837825811665, 37986.62013379831, 38050.80974595109, 38831.6116838828, 39728.80135599303, 35063.29873402569, 38954.415683765335, 39252.607473924894, 39448.2110357797, 39815.203695926495, 29847.253818654706, 30936.226594335323, 31147.221319467193, 31333.843330783202, 32150.19624509406, 24522.75477245276, 24883.626745598467, 25215.117470888432, 26839.865800670872, 27046.594301085894], "unit": "ms", "name": "ext.html", "value": 20425.3899936614}, {"lowerIsBetter": false, "replicates": [374.35797607103814, 381.95989421110767, 383.7639851491333, 387.4382145888462, 390.50210980999225, 17895.284188632457, 19602.705959410585, 19716.0, 20560.588788224228, 20575.176992920304, 18136.727949080774, 18141.90929045353, 18328.083595820222, 18383.81616183841, 18479.538011549717, 5637.46444087811, 5771.365149833515, 5776.018076926922, 5782.768689252446, 5787.363390027093, 1700.7533907583393, 1702.1659386900392, 5675.594643214059, 5688.488036076752, 5732.111522713986, 3305.7355411567137, 4272.743635381887, 4393.626541743955, 5600.551955843523, 5624.831255062355, 4448.621867141297, 6038.547108966845, 6225.470834979033, 6229.563930524842, 6232.283287421959, 5100.897982040338, 5250.159974404077, 5254.7635356409055, 5564.248826408464, 5611.551075913958, 10205.591776328938, 11402.258853174517, 12311.138220324581, 12762.872371276262, 12840.807387889188, 2359.1742889988536, 2403.927882163538, 2405.6992875890514, 2463.19946017545, 2494.77547020769, 9361.344705870591, 9760.609575617038, 9946.204303655762, 11315.83026254607, 13275.668108297274, 1921.269917431367, 1958.1775654225116, 1984.2658216460002, 1989.9303524376721, 2031.2484380779058, 57136.714316428566, 57236.0, 58951.41048589502, 59377.70311148417, 60338.0, 9929.65246216379, 9964.352317099365, 9967.252456065824, 10055.29612927088, 10138.188944884392, 13141.67145821343, 13185.274809885548, 13198.27409492468, 13201.867981320256, 13209.603711888658, 7948.165442628557, 7979.162187970295, 7999.36005119589, 8020.639071241808, 8046.074701409413, 7853.136155022943, 7879.448438609357, 7890.921090789134, 7928.207179282025, 7952.642131104114, 4325.632321252666, 4344.9348259776125, 4360.542143074931, 4361.520232774392, 4459.843905463294, 1836.9908150459162, 1916.875403098794, 1948.6589846776758, 1993.3521605478277, 1995.580928005135, 977.8044391121804, 1033.2081261769324, 1036.5231993283023, 1069.3961350249708, 1084.978300433987, 17382.130893455276, 17415.216315265843, 17456.563585910455, 17723.025233612276, 17902.641947160984, 904.4754042655244, 959.3140904253353, 972.8617517504537, 980.221938914714, 1031.865857438528, 9550.95224523873, 9684.854727179098, 9688.515574221261, 9769.853452198222, 9822.017798220264, 453612.0, 604557.0, 608372.0, 608942.0, 635441.0, 85158.0, 86145.56927215324, 86909.56545217233, 88917.55541222253, 89841.55079224693, 1205.168433780706, 1221.8045112781913, 1232.1067226260889, 1237.4678888078033, 1237.8205160251714, 15955.441559545361, 15980.840191597936, 16062.919685401499, 16116.355345786038, 16465.25906334194, 37207.627923720414, 37597.0, 37667.0, 38109.809450953675, 38509.614903851725, 50616.0, 50905.490945090074, 51158.74420627873, 54125.75245485284, 55124.72437637786, 10340.53467593945, 10419.270651054354, 10537.683869483928, 10559.0, 10559.102476289601, 17576.38482653101, 18149.911005339192, 18330.72503912469, 18418.539536511693, 18705.719414208525, 14957.551273461813, 15120.848791511944, 15191.544253672408, 15249.695006100037, 15665.68668626644, 14677.633059173606, 15040.097594144387, 15172.393104275705, 15396.84603153954, 15633.765493517834, 14869.256537173314, 15065.924670377017, 15113.848861511244, 15359.846401535842, 15473.071615703095, 10362.326448780805, 10392.48037598102, 10506.106980906708, 10523.0, 10534.42060686639, 15149.545513634608, 15210.847891520943, 15444.22778861075, 15485.764778122202, 15695.450659226872], "unit": "ms", "name": "jquery.html", "value": 9172.73095155052}, {"lowerIsBetter": false, "replicates": [1511.31235287944, 1525.4355888321322, 1722.5892732389875, 1779.9555011124721, 1826.032202932446, 7660.119086305077, 7735.574543400111, 7736.187700291466, 7736.26505481979, 7742.458027938046, 7752.379809615231, 7846.0, 7856.882146767789, 7857.764267071982, 7882.132965373804, 2332.9650055249185, 2337.684412604298, 2367.396313939943, 2371.8932648030795, 2372.7034120734907, 2417.286900364397, 2444.828861979662, 2451.8283720139507, 2452.963205551909, 2453.6319552067152, 1999.4801351648603, 2047.8464115191346, 2325.046730840356, 2368.3605426534828, 2443.7067551893797, 2363.1728894886737, 2380.666706661069, 2394.784469397754, 2398.8560686358874, 2402.3513651314047, 2364.881755912215, 2418.117387153694, 2419.8548087114655, 2421.3462365161486, 2422.2369953464777, 6933.479989000794, 7143.821404464878, 7611.847763044763, 7826.217378262185, 7838.980932478741, 4937.333459982929, 4982.327385802906, 5020.322256495363, 5020.799168033274, 5024.171011783052, 3299.3236386540702, 3304.1574398528223, 3324.6675332466803, 3326.1518312830317, 3371.0729549373873, 1056.9630062947838, 1063.346042184059, 1102.895224953628, 1120.1654767198409, 1123.8258069999163, 10904.836427453594, 11019.504122314514, 11023.44882755867, 11034.337939723642, 11041.785403605598, 4415.492218394861, 4425.491068527161, 4428.180786554498, 4449.0, 4461.04087621163, 9342.392744471588, 9381.624735010522, 9382.5308734563, 9388.436693798394, 9389.154976052052, 4933.407991041098, 4942.950570494321, 4988.975055124701, 4990.8752281193265, 4991.925121123186, 4540.704854184468, 4542.88642783933, 4543.909121817545, 4552.795124219418, 4553.362529245908, 3781.2815565042556, 3837.5394952605866, 3857.7492462989817, 3877.185790983925, 3879.4568760373004, 1217.2635555488978, 1224.357212463446, 1228.4287806170173, 1233.6730766346925, 1241.416534228911, 1145.352875625269, 1146.060230610891, 1259.6787819106069, 1398.1960372785688, 1417.376354404059, 7610.9238907611325, 7669.884951725729, 7676.692932282646, 7810.218978102144, 7825.530468171814, 1213.9635810925686, 1216.8296438498617, 1221.8717034711406, 1243.347242697591, 1243.564752336675, 5741.712914354265, 5746.511546518593, 6189.04069869171, 6230.7819226326865, 6248.968755156195, 9224.354295199406, 9513.571889265, 9639.132478077006, 9684.41893486393, 9710.6115755369, 8895.822083558422, 9080.137386948229, 9243.90756092444, 9647.276454265959, 9687.321887467951, 7464.738734144279, 7602.42981776369, 7604.619769011638, 7607.505512141693, 7614.086309642878, 7468.925310746823, 7481.476296659182, 7491.9625401872645, 7566.924330756622, 7567.659455324634, 8390.412671112963, 8419.242268195892, 8443.788905277417, 8606.698765543177, 8657.52383618907, 8609.526476043628, 8697.391182617155, 8700.0, 8876.068012858557, 8885.333599979898, 7144.749933752294, 7159.570425774262, 7164.176119746087, 7175.605341706257, 7239.674214660458, 7537.359324457482, 7710.344620707303, 7721.382289416945, 7740.225977402215, 7748.263914928073, 7019.719211231493, 7101.964490177516, 7198.74804381865, 7278.890816637861, 7369.520981136209, 7088.0, 7091.042709234187, 7125.608091555015, 7177.354038136593, 7201.71193152268, 6930.237673855771, 7084.822879428056, 7194.856102878018, 7243.384312333511, 7258.383037441666, 6711.395974362331, 6734.528582999143, 6738.157730283715, 6749.595024298558, 6751.56114852533, 6714.227863795726, 6734.898976515258, 6741.258461569321, 6742.6628668567355, 6753.020811982334], "unit": "ms", "name": "mootools.html", "value": 4671.43610201982}, {"lowerIsBetter": false, "replicates": [357.51735157537325, 359.4015963420903, 359.44824694094564, 362.76239063413476, 369.3831301726117, 6028.668423236721, 6033.336333003372, 6082.391760823915, 6095.3599872013465, 6106.206193194889, 6012.939870601293, 6013.1581578579035, 6015.578909476339, 6026.548008899339, 6049.697515124237, 4478.373027776114, 4639.8376056838015, 4731.668783185179, 4738.6919850209715, 4740.71555706657, 4640.048789998059, 4675.251959686434, 4677.298405239224, 4693.36639553661, 4701.835435759749, 4632.768361581908, 4653.418322709661, 4658.138244424776, 4660.254359302512, 4666.1367646985245, 4402.07556413152, 4471.441069866267, 4531.841385551523, 4594.793234304464, 4597.977010114962, 4054.1283624020684, 4058.7767672777986, 4074.8777536673947, 4078.714489985702, 4087.3460246360737, 5524.088525393306, 5643.887122257573, 5680.659160450345, 5704.0, 5731.512821410185, 5261.0793111205385, 5382.569394448435, 5394.8921021579745, 5396.244525766396, 5407.351117865842, 6362.395572420613, 6363.236411630588, 6372.076048972919, 6374.362563743635, 6379.808605741835, 4506.797194126272, 4509.526499717548, 4512.864614061584, 4523.411956445641, 4528.07174529224, 6374.458171055466, 6590.835229119262, 6593.637349945751, 6597.60414375139, 6600.141981542417, 4595.770211489412, 4596.678232523758, 4597.0346227291975, 4598.103369842848, 4599.011212589309, 4656.790444429941, 4665.9766701166955, 4667.766611669403, 4668.3697700810635, 4671.04243630055, 5223.947760522422, 5362.249285100089, 5367.0, 5369.624126311121, 5384.084705599979, 6414.807555773335, 6424.38968298011, 6437.581557198767, 6439.420452159328, 6444.516661250425, 1619.9514014579581, 1642.5236681362271, 1644.3587001069593, 1645.1116397145647, 1646.7941507311587, 1100.1968562949091, 1115.6039605939936, 1116.8380584815318, 1132.2583707671488, 1137.419915842926, 6225.937740622627, 6249.812505624838, 6265.091561723524, 6269.185005949197, 6277.435030847246, 6626.966865165643, 6630.469562434993, 6631.933680663132, 6632.071509988606, 6633.2703402625675, 6117.082437634391, 6248.187735594434, 6251.343608921089, 6256.280527739368, 6266.0, 3553.9822300888845, 3579.1231148368297, 3596.9820150899077, 3602.7838329700303, 3604.062943634621, 6819.556728812611, 6827.146606674166, 6835.624040677711, 6838.1794184697155, 6844.691988860513, 6569.737210511526, 6643.069970204078, 6738.966305168541, 6741.123653925057, 6759.391654751096, 6880.0, 6890.276520965327, 6899.93100069003, 6906.689198985957, 6915.723371065202, 6626.701798418986, 6654.401103900672, 6662.367075127855, 6668.766593169215, 6678.465722742266, 6438.774642887476, 6551.705173267119, 6559.868802624016, 6585.835354116185, 6601.834954126185, 6852.109225800614, 6879.449644028566, 6884.931150688429, 6892.276310987274, 6896.551724137915, 4621.468531118964, 4647.8140874366, 4658.045100754405, 4659.93010104842, 4660.8135674574, 6539.70571324282, 6639.634820084942, 6674.399304062657, 6675.531383095711, 6681.76613818514, 6502.934970650422, 6517.902231466626, 6522.5760325578685, 6522.836929076811, 6522.967385163044, 6471.385218404244, 6472.385123413268, 6473.514486413632, 6482.935170648422, 6485.092087107903, 6280.277768056732, 6393.8721225576155, 6398.424141827258, 6403.743850245938, 6414.326495718069, 6521.934780652323, 6523.869522609616, 6524.836879077871, 6531.575447595891, 6532.869342613216, 6354.745810167541, 6369.235691717024, 6374.203224596926, 6376.266729326001, 6380.9361906380345], "unit": "ms", "name": "prototype.html", "value": 4874.430187773989}, {"lowerIsBetter": false, "replicates": [809.2959125560759, 866.0386970462786, 885.2829208341244, 947.4741518457262, 950.3442624589034, 12994.74010519789, 13159.276239806806, 13162.078654494166, 13210.603681889535, 13229.14010589311, 12262.264264144158, 12305.753884922296, 12864.871351286485, 12927.806082908764, 12931.224126552414, 742.2317900972495, 751.6805357722973, 902.8961669408004, 910.7905181808188, 918.3663272342096, 920.1718453391934, 923.4367036107968, 931.7903471718877, 932.4638332958542, 932.6222879733684, 968.2592816495387, 977.4868194198067, 977.8191034658611, 978.4569563892037, 978.7406337320616, 774.8798936164875, 786.9213078692143, 935.8128374325128, 964.4743614729989, 969.1519920069939, 716.4877112864327, 717.5945590741214, 719.8092505486051, 720.718919621348, 720.7873677265219, 12686.80969785454, 12806.935965320114, 12810.29543375114, 12818.61544153677, 12836.39545056868, 12007.93996030023, 12426.316552589604, 12518.561850335194, 12565.434555445026, 12749.362531873368, 10029.799404011952, 10108.292419530635, 10272.845907311395, 10338.844917326247, 10354.63758768447, 3720.8325625346924, 3732.3841566141555, 3757.4176002719623, 3761.567419746709, 3766.510353654035, 46714.53285467136, 47259.52740472586, 48328.758356207996, 48965.75517122427, 49212.26181607243, 9662.75843103914, 9781.41311521311, 9796.755081122887, 9884.357516761387, 9970.102690757867, 19070.0, 19338.226470941285, 19341.0, 19373.51566210856, 19384.70922936157, 7615.276548727862, 7692.000039994765, 7697.807554811063, 7991.160928102582, 8004.839903201903, 4328.567143285709, 4351.586599273064, 4430.490493593214, 4447.310666846644, 4556.977215113903, 3085.5834462347743, 3096.210466331071, 3100.3954228925595, 3115.5793967814056, 3120.1263646179104, 557.2783245696833, 578.2511647416605, 578.4880380862967, 582.2663444060514, 592.0083859535262, 636.2682914648192, 660.6102399584269, 671.000209687562, 680.9523333366716, 722.3643193989361, 8041.356691464785, 8211.753647390467, 8563.785905352415, 8907.73276801697, 8935.865962010575, 517.9223116532551, 519.4831143012651, 630.9621422714652, 738.3502517784423, 745.228688307599, 3801.50580424543, 3804.6195380462286, 3869.8258578364043, 3956.149427873021, 4005.819738111792, 60297.69851150716, 60634.39365606376, 61061.69469152626, 61349.38650613437, 61371.0, 51995.74002129965, 54308.72845635826, 54373.72813135909, 54699.0, 55040.44959550433, 48230.0, 48715.269270960256, 49242.0, 49307.0, 50466.495335046915, 7719.575423351769, 8019.719309824128, 8025.8796118059445, 8159.959200204198, 8217.712380066669, 34877.82561087178, 35288.29423411466, 35596.466053008706, 35791.82104089463, 36647.45028824516, 43585.56414435815, 43607.12785744331, 44570.77714611406, 48934.510654893, 49322.0, 11772.352520611448, 11895.167338286583, 12051.156419050933, 12182.878171218174, 12292.201006934522, 11924.821127683264, 12195.695107622381, 12203.938980305042, 12458.0, 12678.3770558925, 11169.218154729091, 11565.479553420284, 11727.765444690887, 11735.413229338328, 11908.940455297668, 11744.530218791153, 11775.52897884075, 11805.350705711267, 11976.401179941142, 12102.273863568214, 10371.377717336984, 10377.429241391494, 10476.63331783384, 10644.574217031543, 10731.678049658523, 9845.261605379483, 10084.848727269244, 10105.646302379675, 10221.693349199535, 10462.110720588835, 8616.956915215384, 9868.605255789687, 10129.89870101319, 10186.796264074825, 10221.23340749432], "unit": "ms", "name": "yui.html", "value": 6476.743447582752}], "name": "dromaeo_css", "value": 7317.2209295216635}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 103.0, 107.0, 109.0, 112.0, 97.0, 109.0, 109.0, 107.0], "unit": "ms", "name": "ai-astar", "value": 107.2}, {"lowerIsBetter": true, "replicates": [141.0, 124.0, 148.0, 153.0, 127.0, 154.0, 150.0, 122.0, 163.0, 121.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.3}, {"lowerIsBetter": true, "replicates": [161.0, 159.0, 160.0, 159.0, 160.0, 164.0, 160.0, 161.0, 160.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.4}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 71.0, 139.0, 72.0, 71.0, 71.0, 72.0, 155.0, 70.0], "unit": "ms", "name": "audio-fft", "value": 86.0}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 137.0, 91.0, 93.0, 92.0, 141.0, 92.0, 92.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [149.0, 148.0, 147.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 57.0, 55.0, 55.0, 56.0, 56.0, 55.0, 55.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 55.5}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 63.0, 62.0, 63.0, 65.0, 64.0, 64.0, 64.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.4}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 78.0, 79.0, 77.0, 79.0, 87.0, 78.0, 78.0, 78.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 78.9}, {"lowerIsBetter": true, "replicates": [114.0, 113.0, 117.0, 110.0, 119.0, 117.0, 121.0, 110.0, 117.0, 110.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 114.8}, {"lowerIsBetter": true, "replicates": [133.0, 129.0, 132.0, 140.0, 138.0, 137.0, 139.0, 137.0, 131.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 135.6}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 65.0, 62.0, 64.0, 64.0, 68.0, 63.0, 62.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.9}], "name": "kraken", "value": 1463.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [172.20595832615808], "unit": "score", "name": "Richards", "value": 204.998714}, {"lowerIsBetter": false, "replicates": [170.590242238144], "unit": "score", "name": "DeltaBlue", "value": 387.583716}, {"lowerIsBetter": false, "replicates": [277.0083102493075], "unit": "score", "name": "Encrypt", "value": 960.9134100000001}, {"lowerIsBetter": false, "replicates": [5096.446700507614], "unit": "score", "name": "Decrypt", "value": 52.22874203187249}, {"lowerIsBetter": false, "replicates": [1106.1946902654868], "unit": "score", "name": "RayTrace", "value": 668.9500559999998}, {"lowerIsBetter": false, "replicates": [542.5935973955508], "unit": "score", "name": "Earley", "value": 1228.2913090000002}, {"lowerIsBetter": false, "replicates": [10902.173913043478], "unit": "score", "name": "Boyer", "value": 61.131202392821535}, {"lowerIsBetter": false, "replicates": [23767.441860465115], "unit": "score", "name": "RegExp", "value": 38.329114481408986}, {"lowerIsBetter": false, "replicates": [535.0454788657036], "unit": "score", "name": "Splay", "value": 152.30667899999995}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 22759.82626254374}]} 10:13:23 INFO - RETURN: dromaeo_css: 7317.22 10:13:23 INFO - RETURN: kraken: 1463.50 10:13:23 INFO - RETURN: v8_7: 22759.83 10:13:23 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "22759.83"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1463.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7317.22"}}} 10:13:23 INFO - Return code: 0 10:13:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:13:23 INFO - # TBPL SUCCESS # 10:13:23 INFO - Running post-action listener: _resource_record_post_action 10:13:23 INFO - Running post-run listener: _resource_record_post_run 10:13:24 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 315392; Write bytes: 515428352; Read time: 56; Write time: 640284 10:13:24 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 250937344; Read time: 0; Write time: 443180 10:13:24 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 315392; Write bytes: 263892992; Read time: 56; Write time: 197104 10:13:24 INFO - Running post-run listener: _upload_blobber_files 10:13:24 INFO - Blob upload gear active. 10:13:24 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:13:24 INFO - Copying logs to upload dir... 10:13:24 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1256.531308 ========= master_lag: -0.19 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-02-17 10:13:23.762911) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-17 10:13:23.766800) ========= 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=fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455722634/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009906 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455722634/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-17 10:13:23.817279) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 10:13:23.817648) ========= 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=fa44defc139c4ba8574fe040000001db-1455731441.116191-1501915499 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004865 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 10:13:23.867145) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-17 10:13:23.867494) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-17 10:13:23.867803) ========= ========= Total master_lag: 0.07 =========