builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1455223434.57 results: success (0) buildid: 20160211100234 builduid: 50c5916b1b834ac1b612a78fd6c40e6f revision: c7b4a20b6294 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 12:43:54.575383) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 12:43:54.575909) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 12:43:54.576345) ========= 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=ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006318 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 12:43:54.599386) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 12:43:54.599701) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 12:43:54.613629) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 12:43:54.614301) ========= 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=ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004632 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 12:43:54.665959) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 12:43:54.666293) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 12:43:54.666766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 12:43:54.667382) ========= 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=ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-11 12:43:54-- 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% 46.4M=0s 2016-02-11 12:43:54 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172535 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 12:43:54.856115) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 12:43:54.856478) ========= 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=ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014743 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 12:43:54.908795) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-11 12:43:54.909578) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c7b4a20b6294 --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 c7b4a20b6294 --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=ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-11 12:43:55,037 Setting DEBUG logging. 2016-02-11 12:43:55,037 attempt 1/10 2016-02-11 12:43:55,037 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c7b4a20b6294?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-11 12:43:56,221 unpacking tar archive at: mozilla-beta-c7b4a20b6294/testing/mozharness/ program finished with exit code 0 elapsedTime=1.449489 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-11 12:43:56.376342) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 12:43:56.376741) ========= echo c7b4a20b6294 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c7b4a20b6294'] 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=ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c7b4a20b6294 program finished with exit code 0 elapsedTime=0.004786 script_repo_revision: 'c7b4a20b6294' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 12:43:56.428715) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 12:43:56.429030) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 12:43:56.439854) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-02-11 12:43:56.440176) ========= /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=ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:43:56 INFO - MultiFileLogger online at 20160211 12:43:56 in /builds/slave/test-pgo 12:43:56 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 12:43:56 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:43:56 INFO - {'append_to_log': False, 12:43:56 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:43:56 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:43:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:43:56 INFO - 'branch': 'Mozilla-Beta', 12:43:56 INFO - 'buildbot_json_path': 'buildprops.json', 12:43:56 INFO - 'config_files': ('talos/linux_config.py',), 12:43:56 INFO - 'default_actions': ('clobber', 12:43:56 INFO - 'read-buildbot-config', 12:43:56 INFO - 'download-and-extract', 12:43:56 INFO - 'populate-webroot', 12:43:56 INFO - 'create-virtualenv', 12:43:56 INFO - 'install', 12:43:56 INFO - 'run-tests'), 12:43:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:43:56 INFO - 'download_minidump_stackwalk': True, 12:43:56 INFO - 'download_symbols': 'ondemand', 12:43:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:43:56 INFO - 'tooltool.py': '/tools/tooltool.py', 12:43:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:43:56 INFO - '/tools/misc-python/virtualenv.py')}, 12:43:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:43:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:43:56 INFO - 'installer_path': 'installer.exe', 12:43:56 INFO - 'log_level': 'info', 12:43:56 INFO - 'log_name': 'talos', 12:43:56 INFO - 'log_to_console': True, 12:43:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:43:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:43:56 INFO - 'opt_config_files': (), 12:43:56 INFO - 'pip_index': False, 12:43:56 INFO - 'sps_profile': False, 12:43:56 INFO - 'sps_profile_interval': 0, 12:43:56 INFO - 'suite': 'dromaeojs', 12:43:56 INFO - 'system_bits': '32', 12:43:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:43:56 INFO - 'title': 'talos-linux64-ix-035', 12:43:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:43:56 INFO - 'use_talos_json': True, 12:43:56 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:43:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:43:56 INFO - 'work_dir': 'build'} 12:43:56 INFO - ##### 12:43:56 INFO - ##### Running clobber step. 12:43:56 INFO - ##### 12:43:56 INFO - Running pre-action listener: _resource_record_pre_action 12:43:56 INFO - Running main action method: clobber 12:43:56 INFO - rmtree: /builds/slave/test-pgo/build 12:43:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:43:57 INFO - Running post-action listener: _resource_record_post_action 12:43:57 INFO - ##### 12:43:57 INFO - ##### Running read-buildbot-config step. 12:43:57 INFO - ##### 12:43:57 INFO - Running pre-action listener: _resource_record_pre_action 12:43:57 INFO - Running main action method: read_buildbot_config 12:43:57 INFO - Using buildbot properties: 12:43:57 INFO - { 12:43:57 INFO - "properties": { 12:43:57 INFO - "buildnumber": 79, 12:43:57 INFO - "product": "firefox", 12:43:57 INFO - "script_repo_revision": "production", 12:43:57 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 12:43:57 INFO - "repository": "", 12:43:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 12:43:57 INFO - "buildid": "20160211100234", 12:43:57 INFO - "slavename": "talos-linux64-ix-035", 12:43:57 INFO - "pgo_build": "True", 12:43:57 INFO - "basedir": "/builds/slave/test-pgo", 12:43:57 INFO - "project": "", 12:43:57 INFO - "platform": "ubuntu64_hw", 12:43:57 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:43:57 INFO - "slavebuilddir": "test", 12:43:57 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 12:43:57 INFO - "branch": "mozilla-beta", 12:43:57 INFO - "repo_path": "releases/mozilla-beta", 12:43:57 INFO - "stage_platform": "linux64-pgo", 12:43:57 INFO - "builduid": "50c5916b1b834ac1b612a78fd6c40e6f", 12:43:57 INFO - "revision": "c7b4a20b6294" 12:43:57 INFO - }, 12:43:57 INFO - "sourcestamp": { 12:43:57 INFO - "repository": "", 12:43:57 INFO - "hasPatch": false, 12:43:57 INFO - "project": "", 12:43:57 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 12:43:57 INFO - "changes": [ 12:43:57 INFO - { 12:43:57 INFO - "category": null, 12:43:57 INFO - "files": [ 12:43:57 INFO - { 12:43:57 INFO - "url": null, 12:43:57 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455213754/firefox-45.0.en-US.linux-x86_64.tar.bz2" 12:43:57 INFO - } 12:43:57 INFO - ], 12:43:57 INFO - "repository": "", 12:43:57 INFO - "rev": "c7b4a20b6294", 12:43:57 INFO - "who": "sendchange", 12:43:57 INFO - "when": 1455223257, 12:43:57 INFO - "number": 7596081, 12:43:57 INFO - "comments": "Bug 1238935 - r=jonco a=sylvestre", 12:43:57 INFO - "project": "", 12:43:57 INFO - "at": "Thu 11 Feb 2016 12:40:57", 12:43:57 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 12:43:57 INFO - "revlink": "", 12:43:57 INFO - "properties": [ 12:43:57 INFO - [ 12:43:57 INFO - "buildid", 12:43:57 INFO - "20160211100234", 12:43:57 INFO - "Change" 12:43:57 INFO - ], 12:43:57 INFO - [ 12:43:57 INFO - "builduid", 12:43:57 INFO - "50c5916b1b834ac1b612a78fd6c40e6f", 12:43:57 INFO - "Change" 12:43:57 INFO - ], 12:43:57 INFO - [ 12:43:57 INFO - "pgo_build", 12:43:57 INFO - "True", 12:43:57 INFO - "Change" 12:43:57 INFO - ] 12:43:57 INFO - ], 12:43:57 INFO - "revision": "c7b4a20b6294" 12:43:57 INFO - } 12:43:57 INFO - ], 12:43:57 INFO - "revision": "c7b4a20b6294" 12:43:57 INFO - } 12:43:57 INFO - } 12:43:57 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455213754/firefox-45.0.en-US.linux-x86_64.tar.bz2. 12:43:57 INFO - Running post-action listener: _resource_record_post_action 12:43:57 INFO - ##### 12:43:57 INFO - ##### Running download-and-extract step. 12:43:57 INFO - ##### 12:43:57 INFO - Running pre-action listener: _resource_record_pre_action 12:43:57 INFO - Running main action method: download_and_extract 12:43:57 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:57 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455213754/test_packages.json 12:43:57 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455213754/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:43:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455213754/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 12:43:57 INFO - Downloaded 1270 bytes. 12:43:57 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:43:57 INFO - Using the following test package requirements: 12:43:57 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 12:43:57 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 12:43:57 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:43:57 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 12:43:57 INFO - u'jsshell-linux-x86_64.zip'], 12:43:57 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 12:43:57 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:43:57 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 12:43:57 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 12:43:57 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 12:43:57 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 12:43:57 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 12:43:57 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 12:43:57 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:43:57 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 12:43:57 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 12:43:57 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:43:57 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:57 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455213754/firefox-45.0.en-US.linux-x86_64.common.tests.zip 12:43:57 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455213754/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 12:43:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455213754/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 12:43:57 INFO - Downloaded 21583273 bytes. 12:43:57 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 12:43:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 12:43:57 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 12:43:58 INFO - Return code: 0 12:43:58 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 12:43:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:43:58 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455213754/firefox-45.0.en-US.linux-x86_64.common.tests.zip 12:43:58 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455213754/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 12:43:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455213754/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 12:43:58 INFO - Downloaded 21583273 bytes. 12:43:58 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 12:43:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 12:43:58 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 12:44:00 INFO - Return code: 0 12:44:00 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')]} 12:44:00 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455213754/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 12:44:00 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455213754/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 12:44:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455213754/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 12:44:00 INFO - Downloaded 11132038 bytes. 12:44:00 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 12:44:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 12:44:00 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 12:44:00 INFO - Return code: 0 12:44:00 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')]} 12:44:00 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455213754/firefox-45.0.en-US.linux-x86_64.tar.bz2 12:44:00 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455213754/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 12:44:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455213754/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 12:44:01 INFO - Downloaded 57940971 bytes. 12:44:01 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455213754/firefox-45.0.en-US.linux-x86_64.tar.bz2 12:44:01 INFO - mkdir: /builds/slave/test-pgo/properties 12:44:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:44:01 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:44:01 INFO - Contents: 12:44:01 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455213754/firefox-45.0.en-US.linux-x86_64.tar.bz2 12:44:01 INFO - Running post-action listener: _resource_record_post_action 12:44:01 INFO - Running post-action listener: set_extra_try_arguments 12:44:01 INFO - ##### 12:44:01 INFO - ##### Running populate-webroot step. 12:44:01 INFO - ##### 12:44:01 INFO - Running pre-action listener: _resource_record_pre_action 12:44:01 INFO - Running main action method: populate_webroot 12:44:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:44:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:44:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:44:01 INFO - '--tppagecycles', 12:44:01 INFO - '7'], 12:44:01 INFO - 'tests': ['tsvgm']}}, 12:44:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:44:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:44:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:44:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:44:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:44:01 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:44:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:44:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:01 INFO - 'talos_options': ['--e10s'], 12:44:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:44:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:01 INFO - 'tests': ['damp', 'tps']}, 12:44:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:01 INFO - 'talos_options': ['--e10s'], 12:44:01 INFO - 'tests': ['damp', 'tps']}, 12:44:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:44:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:44:01 INFO - 'other': {'tests': ['a11yr', 12:44:01 INFO - 'ts_paint', 12:44:01 INFO - 'tpaint', 12:44:01 INFO - 'sessionrestore', 12:44:01 INFO - 'sessionrestore_no_auto_restore']}, 12:44:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:44:01 INFO - 'tests': ['a11yr', 12:44:01 INFO - 'ts_paint', 12:44:01 INFO - 'tpaint', 12:44:01 INFO - 'sessionrestore', 12:44:01 INFO - 'sessionrestore_no_auto_restore']}, 12:44:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:44:01 INFO - 'tests': ['a11yr', 12:44:01 INFO - 'ts_paint', 12:44:01 INFO - 'tpaint', 12:44:01 INFO - 'sessionrestore', 12:44:01 INFO - 'sessionrestore_no_auto_restore']}, 12:44:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:44:01 INFO - 'tests': ['a11yr', 12:44:01 INFO - 'ts_paint', 12:44:01 INFO - 'tpaint', 12:44:01 INFO - 'sessionrestore', 12:44:01 INFO - 'sessionrestore_no_auto_restore']}, 12:44:01 INFO - 'other_l64': {'tests': ['a11yr', 12:44:01 INFO - 'ts_paint', 12:44:01 INFO - 'tpaint', 12:44:01 INFO - 'sessionrestore', 12:44:01 INFO - 'sessionrestore_no_auto_restore']}, 12:44:01 INFO - 'other_nol64': {'tests': ['a11yr', 12:44:01 INFO - 'ts_paint', 12:44:01 INFO - 'tpaint', 12:44:01 INFO - 'sessionrestore', 12:44:01 INFO - 'sessionrestore_no_auto_restore']}, 12:44:01 INFO - 'svgr': {'tests': ['tsvgx', 12:44:01 INFO - 'tsvgr_opacity', 12:44:01 INFO - 'tart', 12:44:01 INFO - 'tscrollx', 12:44:01 INFO - 'cart']}, 12:44:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:44:01 INFO - 'tests': ['tsvgx', 12:44:01 INFO - 'tsvgr_opacity', 12:44:01 INFO - 'tart', 12:44:01 INFO - 'tscrollx', 12:44:01 INFO - 'cart']}, 12:44:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:01 INFO - 'tests': ['tp5o']}, 12:44:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:01 INFO - 'talos_options': ['--e10s'], 12:44:01 INFO - 'tests': ['tp5o']}, 12:44:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:01 INFO - 'talos_options': ['--xperf_path', 12:44:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:44:01 INFO - 'tests': ['tp5n']}, 12:44:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:44:01 INFO - 'talos_options': ['--e10s', 12:44:01 INFO - '--xperf_path', 12:44:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:44:01 INFO - 'tests': ['tp5n']}}, 12:44:01 INFO - 'talos.zip': {'path': '', 12:44:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:44:01 INFO - Running post-action listener: _resource_record_post_action 12:44:01 INFO - ##### 12:44:01 INFO - ##### Running create-virtualenv step. 12:44:01 INFO - ##### 12:44:01 INFO - Running pre-action listener: _resource_record_pre_action 12:44:01 INFO - Running main action method: create_virtualenv 12:44:01 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:44:01 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 12:44:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:44:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:44:01 INFO - Using real prefix '/usr' 12:44:01 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:44:02 INFO - Installing distribute.............................................................................................................................................................................................done. 12:44:04 INFO - Installing pip.................done. 12:44:04 INFO - Return code: 0 12:44:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:04 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 0x7f1a0f527f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2776350>, '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 0x2777250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27776e0>, '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': 'ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679', '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 12:44:04 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 12:44:04 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 12:44:04 INFO - Using env: {'DISPLAY': ':0', 12:44:04 INFO - 'HOME': '/home/cltbld', 12:44:04 INFO - 'LANG': 'en_US.UTF-8', 12:44:04 INFO - 'LANGUAGE': 'en_US:en', 12:44:04 INFO - 'LOGNAME': 'cltbld', 12:44:04 INFO - 'MAIL': '/var/mail/cltbld', 12:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:04 INFO - 'MOZ_NO_REMOTE': '1', 12:44:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:04 INFO - 'NO_EM_RESTART': '1', 12:44:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:44:04 INFO - 'PWD': '/builds/slave/test-pgo', 12:44:04 INFO - 'SHELL': '/bin/bash', 12:44:04 INFO - 'SHLVL': '1', 12:44:04 INFO - 'TERM': 'linux', 12:44:04 INFO - 'TMOUT': '86400', 12:44:04 INFO - 'USER': 'cltbld', 12:44:04 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679', 12:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:04 INFO - '_': '/tools/buildbot/bin/python'} 12:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:04 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 12:44:04 INFO - Cleaning up... 12:44:04 INFO - Return code: 0 12:44:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:04 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 0x7f1a0f527f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2776350>, '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 0x2777250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27776e0>, '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': 'ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679', '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 12:44:04 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 12:44:04 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 12:44:04 INFO - Using env: {'DISPLAY': ':0', 12:44:04 INFO - 'HOME': '/home/cltbld', 12:44:04 INFO - 'LANG': 'en_US.UTF-8', 12:44:04 INFO - 'LANGUAGE': 'en_US:en', 12:44:04 INFO - 'LOGNAME': 'cltbld', 12:44:04 INFO - 'MAIL': '/var/mail/cltbld', 12:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:04 INFO - 'MOZ_NO_REMOTE': '1', 12:44:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:04 INFO - 'NO_EM_RESTART': '1', 12:44:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:44:04 INFO - 'PWD': '/builds/slave/test-pgo', 12:44:04 INFO - 'SHELL': '/bin/bash', 12:44:04 INFO - 'SHLVL': '1', 12:44:04 INFO - 'TERM': 'linux', 12:44:04 INFO - 'TMOUT': '86400', 12:44:04 INFO - 'USER': 'cltbld', 12:44:04 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679', 12:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:04 INFO - '_': '/tools/buildbot/bin/python'} 12:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:04 INFO - Downloading/unpacking psutil>=0.7.1 12:44:04 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 12:44:04 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 12:44:04 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 12:44:04 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 12:44:04 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 12:44:04 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 12:44:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:44:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:44:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:44:06 INFO - Installing collected packages: psutil 12:44:06 INFO - Running setup.py install for psutil 12:44:06 INFO - building 'psutil._psutil_linux' extension 12:44:06 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 12:44:06 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 12:44:06 INFO - building 'psutil._psutil_posix' extension 12:44:06 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 12:44:06 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 12:44:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:44:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:44:06 INFO - Successfully installed psutil 12:44:06 INFO - Cleaning up... 12:44:07 INFO - Return code: 0 12:44:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1a0f527f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2776350>, '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 0x2777250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27776e0>, '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': 'ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679', '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 12:44:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 12:44:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:44:07 INFO - Using env: {'DISPLAY': ':0', 12:44:07 INFO - 'HOME': '/home/cltbld', 12:44:07 INFO - 'LANG': 'en_US.UTF-8', 12:44:07 INFO - 'LANGUAGE': 'en_US:en', 12:44:07 INFO - 'LOGNAME': 'cltbld', 12:44:07 INFO - 'MAIL': '/var/mail/cltbld', 12:44:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:07 INFO - 'MOZ_NO_REMOTE': '1', 12:44:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:07 INFO - 'NO_EM_RESTART': '1', 12:44:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:44:07 INFO - 'PWD': '/builds/slave/test-pgo', 12:44:07 INFO - 'SHELL': '/bin/bash', 12:44:07 INFO - 'SHLVL': '1', 12:44:07 INFO - 'TERM': 'linux', 12:44:07 INFO - 'TMOUT': '86400', 12:44:07 INFO - 'USER': 'cltbld', 12:44:07 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679', 12:44:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:07 INFO - '_': '/tools/buildbot/bin/python'} 12:44:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:44:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:44:09 INFO - Installing collected packages: mozsystemmonitor 12:44:09 INFO - Running setup.py install for mozsystemmonitor 12:44:09 INFO - Successfully installed mozsystemmonitor 12:44:09 INFO - Cleaning up... 12:44:09 INFO - Return code: 0 12:44:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:44:09 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')]} 12:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:09 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')]} 12:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:09 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 0x7f1a0f527f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2776350>, '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 0x2777250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27776e0>, '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': 'ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679', '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 12:44:09 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 12:44:09 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 12:44:09 INFO - Using env: {'DISPLAY': ':0', 12:44:09 INFO - 'HOME': '/home/cltbld', 12:44:09 INFO - 'LANG': 'en_US.UTF-8', 12:44:09 INFO - 'LANGUAGE': 'en_US:en', 12:44:09 INFO - 'LOGNAME': 'cltbld', 12:44:09 INFO - 'MAIL': '/var/mail/cltbld', 12:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:09 INFO - 'MOZ_NO_REMOTE': '1', 12:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:09 INFO - 'NO_EM_RESTART': '1', 12:44:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:44:09 INFO - 'PWD': '/builds/slave/test-pgo', 12:44:09 INFO - 'SHELL': '/bin/bash', 12:44:09 INFO - 'SHLVL': '1', 12:44:09 INFO - 'TERM': 'linux', 12:44:09 INFO - 'TMOUT': '86400', 12:44:09 INFO - 'USER': 'cltbld', 12:44:09 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679', 12:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:09 INFO - '_': '/tools/buildbot/bin/python'} 12:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:09 INFO - Downloading/unpacking blobuploader==1.2.4 12:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:44:11 INFO - Downloading blobuploader-1.2.4.tar.gz 12:44:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:44:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:44:11 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 12:44:11 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 12:44:11 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 12:44:11 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 12:44:11 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 12:44:11 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 12:44:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:44:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:44:11 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 12:44:11 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 12:44:11 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 12:44:11 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 12:44:11 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 12:44:11 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 12:44:11 INFO - Downloading docopt-0.6.1.tar.gz 12:44:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:44:11 INFO - Installing collected packages: blobuploader, requests, docopt 12:44:11 INFO - Running setup.py install for blobuploader 12:44:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:44:11 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:44:12 INFO - Running setup.py install for requests 12:44:12 INFO - Running setup.py install for docopt 12:44:12 INFO - Successfully installed blobuploader requests docopt 12:44:12 INFO - Cleaning up... 12:44:12 INFO - Return code: 0 12:44:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:44:12 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')]} 12:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:12 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')]} 12:44:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:12 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 0x7f1a0f527f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2776350>, '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 0x2777250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27776e0>, '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': 'ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679', '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 12:44:12 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 12:44:12 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 12:44:12 INFO - Using env: {'DISPLAY': ':0', 12:44:12 INFO - 'HOME': '/home/cltbld', 12:44:12 INFO - 'LANG': 'en_US.UTF-8', 12:44:12 INFO - 'LANGUAGE': 'en_US:en', 12:44:12 INFO - 'LOGNAME': 'cltbld', 12:44:12 INFO - 'MAIL': '/var/mail/cltbld', 12:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:12 INFO - 'MOZ_NO_REMOTE': '1', 12:44:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:12 INFO - 'NO_EM_RESTART': '1', 12:44:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:44:12 INFO - 'PWD': '/builds/slave/test-pgo', 12:44:12 INFO - 'SHELL': '/bin/bash', 12:44:12 INFO - 'SHLVL': '1', 12:44:12 INFO - 'TERM': 'linux', 12:44:12 INFO - 'TMOUT': '86400', 12:44:12 INFO - 'USER': 'cltbld', 12:44:12 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679', 12:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:12 INFO - '_': '/tools/buildbot/bin/python'} 12:44:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:44:12 INFO - Running setup.py (path:/tmp/pip-n3OVLs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:44:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:44:12 INFO - Running setup.py (path:/tmp/pip-N6BgVu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:44:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:44:12 INFO - Running setup.py (path:/tmp/pip-SPvEbP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:44:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:44:12 INFO - Running setup.py (path:/tmp/pip-bUyMpI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:44:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:44:12 INFO - Running setup.py (path:/tmp/pip-LO0Lta-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:44:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:44:13 INFO - Running setup.py (path:/tmp/pip-6Y8MJ3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:44:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:44:13 INFO - Running setup.py (path:/tmp/pip-TukrZ7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:44:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:44:13 INFO - Running setup.py (path:/tmp/pip-dQfFoo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:44:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:44:13 INFO - Running setup.py (path:/tmp/pip-eFiJhj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:44:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:44:13 INFO - Running setup.py (path:/tmp/pip-Bk2xbw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:44:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:44:13 INFO - Running setup.py (path:/tmp/pip-_pTlLG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:44:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:44:13 INFO - Running setup.py (path:/tmp/pip-rwXkag-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:44:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:44:13 INFO - Running setup.py (path:/tmp/pip-K8Flfl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:44:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:44:13 INFO - Running setup.py (path:/tmp/pip-vC9P4o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:44:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:44:13 INFO - Running setup.py (path:/tmp/pip-jwe8QQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:44:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:44:13 INFO - Running setup.py (path:/tmp/pip-wvdBkT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:44:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:44:13 INFO - Running setup.py (path:/tmp/pip-d919z5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:44:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:44:13 INFO - Running setup.py install for manifestparser 12:44:13 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:44:14 INFO - Running setup.py install for mozcrash 12:44:14 INFO - Running setup.py install for mozdebug 12:44:14 INFO - Running setup.py install for mozdevice 12:44:14 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:44:14 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:44:14 INFO - Running setup.py install for mozfile 12:44:14 INFO - Running setup.py install for mozhttpd 12:44:14 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:44:14 INFO - Running setup.py install for mozinfo 12:44:14 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:44:14 INFO - Running setup.py install for mozInstall 12:44:14 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:44:14 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:44:14 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:44:14 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:44:14 INFO - Running setup.py install for mozleak 12:44:14 INFO - Running setup.py install for mozlog 12:44:14 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:44:14 INFO - Running setup.py install for moznetwork 12:44:15 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:44:15 INFO - Running setup.py install for mozprocess 12:44:15 INFO - Running setup.py install for mozprofile 12:44:15 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:44:15 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:44:15 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:44:15 INFO - Running setup.py install for mozrunner 12:44:15 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:44:15 INFO - Running setup.py install for mozscreenshot 12:44:15 INFO - Running setup.py install for moztest 12:44:15 INFO - Running setup.py install for mozversion 12:44:15 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:44:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:44:15 INFO - Cleaning up... 12:44:15 INFO - Return code: 0 12:44:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:44:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:15 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 0x7f1a0f527f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2776350>, '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 0x2777250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27776e0>, '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': 'ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679', '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 12:44:15 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 12:44:15 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 12:44:15 INFO - Using env: {'DISPLAY': ':0', 12:44:15 INFO - 'HOME': '/home/cltbld', 12:44:15 INFO - 'LANG': 'en_US.UTF-8', 12:44:15 INFO - 'LANGUAGE': 'en_US:en', 12:44:15 INFO - 'LOGNAME': 'cltbld', 12:44:15 INFO - 'MAIL': '/var/mail/cltbld', 12:44:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:15 INFO - 'MOZ_NO_REMOTE': '1', 12:44:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:15 INFO - 'NO_EM_RESTART': '1', 12:44:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:44:15 INFO - 'PWD': '/builds/slave/test-pgo', 12:44:15 INFO - 'SHELL': '/bin/bash', 12:44:15 INFO - 'SHLVL': '1', 12:44:15 INFO - 'TERM': 'linux', 12:44:15 INFO - 'TMOUT': '86400', 12:44:15 INFO - 'USER': 'cltbld', 12:44:15 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679', 12:44:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:15 INFO - '_': '/tools/buildbot/bin/python'} 12:44:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:44:15 INFO - Running setup.py (path:/tmp/pip-3igyG6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:44:15 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)) 12:44:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:44:15 INFO - Running setup.py (path:/tmp/pip-bk3WKf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:44:16 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)) 12:44:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:44:16 INFO - Running setup.py (path:/tmp/pip-RUCzvd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:44:16 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)) 12:44:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:44:16 INFO - Running setup.py (path:/tmp/pip-RjFH32-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:44:16 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)) 12:44:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:44:16 INFO - Running setup.py (path:/tmp/pip-UUy7sk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:44:16 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)) 12:44:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:44:16 INFO - Running setup.py (path:/tmp/pip-QX5z8v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:44:16 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)) 12:44:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:44:16 INFO - Running setup.py (path:/tmp/pip-Aph5Sr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:44:16 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)) 12:44:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:44:16 INFO - Running setup.py (path:/tmp/pip-REcH77-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:44:16 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)) 12:44:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:44:16 INFO - Running setup.py (path:/tmp/pip-kyOazD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:44:16 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)) 12:44:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:44:16 INFO - Running setup.py (path:/tmp/pip-u7CcLg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:44:16 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)) 12:44:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:44:16 INFO - Running setup.py (path:/tmp/pip-fMQDFI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:44:16 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)) 12:44:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:44:16 INFO - Running setup.py (path:/tmp/pip-pKu4Ml-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:44:16 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)) 12:44:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:44:16 INFO - Running setup.py (path:/tmp/pip-a_T3Fm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:44:16 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)) 12:44:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:44:16 INFO - Running setup.py (path:/tmp/pip-sd8og1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:44:16 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)) 12:44:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:44:16 INFO - Running setup.py (path:/tmp/pip-elAxS0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:44:16 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)) 12:44:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:44:16 INFO - Running setup.py (path:/tmp/pip-RSGxh3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:44:17 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)) 12:44:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:44:17 INFO - Running setup.py (path:/tmp/pip-QeGI3f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:44:17 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)) 12:44:17 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)) 12:44:17 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)) 12:44:17 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)) 12:44:17 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)) 12:44:17 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)) 12:44:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:44:17 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 12:44:17 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 12:44:17 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 12:44:17 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 12:44:17 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 12:44:17 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 12:44:18 INFO - Downloading blessings-1.6.tar.gz 12:44:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:44:18 INFO - Installing collected packages: blessings 12:44:18 INFO - Running setup.py install for blessings 12:44:19 INFO - Successfully installed blessings 12:44:19 INFO - Cleaning up... 12:44:19 INFO - Return code: 0 12:44:19 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:44:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:44:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:44:19 INFO - Reading from file tmpfile_stdout 12:44:19 INFO - Current package versions: 12:44:19 INFO - argparse == 1.2.1 12:44:19 INFO - blessings == 1.6 12:44:19 INFO - blobuploader == 1.2.4 12:44:19 INFO - docopt == 0.6.1 12:44:19 INFO - manifestparser == 1.1 12:44:19 INFO - mozInstall == 1.12 12:44:19 INFO - mozcrash == 0.16 12:44:19 INFO - mozdebug == 0.1 12:44:19 INFO - mozdevice == 0.47 12:44:19 INFO - mozfile == 1.2 12:44:19 INFO - mozhttpd == 0.7 12:44:19 INFO - mozinfo == 0.9 12:44:19 INFO - mozleak == 0.1 12:44:19 INFO - mozlog == 3.1 12:44:19 INFO - moznetwork == 0.27 12:44:19 INFO - mozprocess == 0.22 12:44:19 INFO - mozprofile == 0.27 12:44:19 INFO - mozrunner == 6.11 12:44:19 INFO - mozscreenshot == 0.1 12:44:19 INFO - mozsystemmonitor == 0.0 12:44:19 INFO - moztest == 0.7 12:44:19 INFO - mozversion == 1.4 12:44:19 INFO - psutil == 3.1.1 12:44:19 INFO - requests == 1.2.3 12:44:19 INFO - wsgiref == 0.1.2 12:44:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:44:19 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')]} 12:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:19 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')]} 12:44:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:19 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 0x7f1a0f527f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2776350>, '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 0x2777250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27776e0>, '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': 'ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679', '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 12:44:19 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 12:44:19 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 12:44:19 INFO - Using env: {'DISPLAY': ':0', 12:44:19 INFO - 'HOME': '/home/cltbld', 12:44:19 INFO - 'LANG': 'en_US.UTF-8', 12:44:19 INFO - 'LANGUAGE': 'en_US:en', 12:44:19 INFO - 'LOGNAME': 'cltbld', 12:44:19 INFO - 'MAIL': '/var/mail/cltbld', 12:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:19 INFO - 'MOZ_NO_REMOTE': '1', 12:44:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:19 INFO - 'NO_EM_RESTART': '1', 12:44:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:44:19 INFO - 'PWD': '/builds/slave/test-pgo', 12:44:19 INFO - 'SHELL': '/bin/bash', 12:44:19 INFO - 'SHLVL': '1', 12:44:19 INFO - 'TERM': 'linux', 12:44:19 INFO - 'TMOUT': '86400', 12:44:19 INFO - 'USER': 'cltbld', 12:44:19 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679', 12:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:19 INFO - '_': '/tools/buildbot/bin/python'} 12:44:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:19 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)) 12:44:19 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)) 12:44:19 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)) 12:44:19 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)) 12:44:19 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)) 12:44:19 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)) 12:44:19 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)) 12:44:19 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)) 12:44:19 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)) 12:44:19 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)) 12:44:19 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)) 12:44:19 INFO - Cleaning up... 12:44:19 INFO - Return code: 0 12:44:19 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 12:44:19 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')]} 12:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:19 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')]} 12:44:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:19 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 0x7f1a0f527f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2776350>, '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 0x2777250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27776e0>, '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': 'ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679', '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 12:44:19 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 12:44:19 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 12:44:19 INFO - Using env: {'DISPLAY': ':0', 12:44:19 INFO - 'HOME': '/home/cltbld', 12:44:19 INFO - 'LANG': 'en_US.UTF-8', 12:44:19 INFO - 'LANGUAGE': 'en_US:en', 12:44:19 INFO - 'LOGNAME': 'cltbld', 12:44:19 INFO - 'MAIL': '/var/mail/cltbld', 12:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:19 INFO - 'MOZ_NO_REMOTE': '1', 12:44:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:19 INFO - 'NO_EM_RESTART': '1', 12:44:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:44:19 INFO - 'PWD': '/builds/slave/test-pgo', 12:44:19 INFO - 'SHELL': '/bin/bash', 12:44:19 INFO - 'SHLVL': '1', 12:44:19 INFO - 'TERM': 'linux', 12:44:19 INFO - 'TMOUT': '86400', 12:44:19 INFO - 'USER': 'cltbld', 12:44:19 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679', 12:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:19 INFO - '_': '/tools/buildbot/bin/python'} 12:44:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:19 INFO - Downloading/unpacking jsonschema 12:44:19 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 12:44:19 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 12:44:19 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 12:44:19 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 12:44:19 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 12:44:19 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 12:44:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:44:21 INFO - Downloading/unpacking functools32 (from jsonschema) 12:44:21 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 12:44:21 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 12:44:21 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 12:44:21 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 12:44:21 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 12:44:21 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 12:44:21 INFO - Downloading functools32-3.2.3-2.tar.gz 12:44:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 12:44:21 INFO - warning: no files found matching '*.txt' 12:44:21 INFO - no previously-included directories found matching 'build' 12:44:21 INFO - no previously-included directories found matching 'dist' 12:44:21 INFO - no previously-included directories found matching '.git*' 12:44:21 INFO - Installing collected packages: jsonschema, functools32 12:44:21 INFO - Running setup.py install for functools32 12:44:21 INFO - warning: no files found matching '*.txt' 12:44:21 INFO - no previously-included directories found matching 'build' 12:44:21 INFO - no previously-included directories found matching 'dist' 12:44:21 INFO - no previously-included directories found matching '.git*' 12:44:21 INFO - Successfully installed jsonschema functools32 12:44:21 INFO - Cleaning up... 12:44:22 INFO - Return code: 0 12:44:22 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 12:44:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:44:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:44:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:44:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:44:22 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 0x7f1a0f527f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x261a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26e7600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2776350>, '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 0x2777250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27776e0>, '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': 'ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679', '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 12:44:22 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 12:44:22 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 12:44:22 INFO - Using env: {'DISPLAY': ':0', 12:44:22 INFO - 'HOME': '/home/cltbld', 12:44:22 INFO - 'LANG': 'en_US.UTF-8', 12:44:22 INFO - 'LANGUAGE': 'en_US:en', 12:44:22 INFO - 'LOGNAME': 'cltbld', 12:44:22 INFO - 'MAIL': '/var/mail/cltbld', 12:44:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:22 INFO - 'MOZ_NO_REMOTE': '1', 12:44:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:22 INFO - 'NO_EM_RESTART': '1', 12:44:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:44:22 INFO - 'PWD': '/builds/slave/test-pgo', 12:44:22 INFO - 'SHELL': '/bin/bash', 12:44:22 INFO - 'SHLVL': '1', 12:44:22 INFO - 'TERM': 'linux', 12:44:22 INFO - 'TMOUT': '86400', 12:44:22 INFO - 'USER': 'cltbld', 12:44:22 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679', 12:44:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:22 INFO - '_': '/tools/buildbot/bin/python'} 12:44:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:44:22 INFO - Downloading/unpacking flake8 12:44:22 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 12:44:22 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 12:44:22 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 12:44:22 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 12:44:22 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 12:44:22 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 12:44:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:44:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:44:24 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 12:44:24 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 12:44:24 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 12:44:24 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 12:44:24 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 12:44:24 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 12:44:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:44:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:44:24 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 12:44:24 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 12:44:24 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 12:44:24 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 12:44:24 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 12:44:24 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 12:44:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:44:24 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 12:44:24 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 12:44:24 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 12:44:24 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 12:44:24 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 12:44:24 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 12:44:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 12:44:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:44:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:44:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:44:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:44:24 INFO - no previously-included directories found matching 'docs/_build' 12:44:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:44:24 INFO - Running setup.py install for pep8 12:44:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:44:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:44:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:44:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:44:24 INFO - no previously-included directories found matching 'docs/_build' 12:44:24 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 12:44:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:44:24 INFO - Cleaning up... 12:44:24 INFO - Return code: 0 12:44:24 INFO - Running post-action listener: _resource_record_post_action 12:44:24 INFO - Running post-action listener: _start_resource_monitoring 12:44:24 INFO - Starting resource monitoring. 12:44:24 INFO - ##### 12:44:24 INFO - ##### Running install step. 12:44:24 INFO - ##### 12:44:24 INFO - Running pre-action listener: _resource_record_pre_action 12:44:24 INFO - Running main action method: install 12:44:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:44:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:44:25 INFO - Reading from file tmpfile_stdout 12:44:25 INFO - Detecting whether we're running mozinstall >=1.0... 12:44:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:44:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:44:25 INFO - Reading from file tmpfile_stdout 12:44:25 INFO - Output received: 12:44:25 INFO - Usage: mozinstall [options] installer 12:44:25 INFO - Options: 12:44:25 INFO - -h, --help show this help message and exit 12:44:25 INFO - -d DEST, --destination=DEST 12:44:25 INFO - Directory to install application into. [default: 12:44:25 INFO - "/builds/slave/test-pgo"] 12:44:25 INFO - --app=APP Application being installed. [default: firefox] 12:44:25 INFO - mkdir: /builds/slave/test-pgo/build/application 12:44:25 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'] 12:44:25 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 12:44:39 INFO - Reading from file tmpfile_stdout 12:44:39 INFO - Output received: 12:44:39 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:44:39 INFO - Running post-action listener: _resource_record_post_action 12:44:39 INFO - ##### 12:44:39 INFO - ##### Running run-tests step. 12:44:39 INFO - ##### 12:44:39 INFO - Running pre-action listener: _resource_record_pre_action 12:44:39 INFO - Running main action method: run_tests 12:44:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:44:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:44:39 INFO - Python 2.7.3 12:44:39 INFO - Return code: 0 12:44:39 INFO - grabbing minidump binary from tooltool 12:44:39 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')]} 12:44:39 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 0x2776350>, '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 0x2777250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27776e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:44:39 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 12:44:39 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 12:44:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:44:39 INFO - Return code: 0 12:44:39 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:44:39 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:44:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:44:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:44:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:44:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 12:44:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 12:44:40 INFO - Return code: 0 12:44:40 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/1455213754/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 12:44:40 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/1455213754/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost 12:44:40 INFO - Using env: {'DISPLAY': ':0', 12:44:40 INFO - 'HOME': '/home/cltbld', 12:44:40 INFO - 'LANG': 'en_US.UTF-8', 12:44:40 INFO - 'LANGUAGE': 'en_US:en', 12:44:40 INFO - 'LOGNAME': 'cltbld', 12:44:40 INFO - 'MAIL': '/var/mail/cltbld', 12:44:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:44:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:44:40 INFO - 'MOZ_NO_REMOTE': '1', 12:44:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:44:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:44:40 INFO - 'NO_EM_RESTART': '1', 12:44:40 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:44:40 INFO - 'PWD': '/builds/slave/test-pgo', 12:44:40 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:44:40 INFO - 'SHELL': '/bin/bash', 12:44:40 INFO - 'SHLVL': '1', 12:44:40 INFO - 'TERM': 'linux', 12:44:40 INFO - 'TMOUT': '86400', 12:44:40 INFO - 'USER': 'cltbld', 12:44:40 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679', 12:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:44:40 INFO - '_': '/tools/buildbot/bin/python'} 12:44:40 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/1455213754/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost'] with output_timeout 3600 12:44:41 INFO - mozversion INFO | application_buildid: 20160211100234 12:44:41 INFO - mozversion INFO | application_changeset: c7b4a20b6294cb9b1d11f063c5a92dfcf677eab2 12:44:41 INFO - mozversion INFO | application_display_name: Nightly 12:44:41 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:44:41 INFO - mozversion INFO | application_name: Firefox 12:44:41 INFO - mozversion INFO | application_remotingname: firefox 12:44:41 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:44:41 INFO - mozversion INFO | application_vendor: Mozilla 12:44:41 INFO - mozversion INFO | application_version: 45.0 12:44:41 INFO - mozversion INFO | platform_buildid: 20160211100234 12:44:41 INFO - mozversion INFO | platform_changeset: c7b4a20b6294cb9b1d11f063c5a92dfcf677eab2 12:44:41 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:44:41 INFO - mozversion INFO | platform_version: 45.0 12:44:41 INFO - 2016-02-11 12:44:41,146 DEBUG : using testdate: 1455223481 12:44:41 INFO - 2016-02-11 12:44:41,146 DEBUG : actual date: 1455223481 12:44:41 INFO - 2016-02-11 12:44:41,155 INFO : starting webserver on 'localhost:36341' 12:44:41 INFO - 2016-02-11 12:44:41,156 INFO : Starting test suite talos-linux64-ix-035 12:44:41 INFO - 2016-02-11 12:44:41,156 INFO : Starting test dromaeo_css 12:44:41 INFO - 2016-02-11 12:44:41,156 DEBUG : operating with platform_type : linux_ 12:44:41 INFO - 2016-02-11 12:44:41,156 INFO : Initialising browser for dromaeo_css test... 12:44:41 INFO - 2016-02-11 12:44:41,171 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDegPkR/profile http://localhost:36341/getInfo.html 12:44:44 INFO - 2016-02-11 12:44:44,917 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:44:44 INFO - 2016-02-11 12:44:44,917 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:44:44 INFO - 2016-02-11 12:44:44,917 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:44:44 INFO - 2016-02-11 12:44:44,917 DEBUG : BROWSER_OUTPUT: __metrics 12:44:45 INFO - 2016-02-11 12:44:45,019 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] 12:44:45 INFO - 2016-02-11 12:44:45,902 INFO : Browser initialized. 12:44:45 INFO - 2016-02-11 12:44:45,903 INFO : Running cycle 1/1 for dromaeo_css test... 12:44:45 INFO - 2016-02-11 12:44:45,903 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpDegPkR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:44:57 INFO - 2016-02-11 12:44:57,539 DEBUG : BROWSER_OUTPUT: RSS: Main: 132231168 12:44:57 INFO - 2016-02-11 12:44:57,540 DEBUG : BROWSER_OUTPUT: 12:45:48 INFO - 2016-02-11 12:45:48,353 DEBUG : BROWSER_OUTPUT: 1455223548352 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] 12:47:56 INFO - 2016-02-11 12:47:56,553 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36341/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36341/tests/dromaeo/cssquery-ext.html) 12:47:57 INFO - 2016-02-11 12:47:57,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 214618112 12:47:57 INFO - 2016-02-11 12:47:57,563 DEBUG : BROWSER_OUTPUT: 12:50:59 INFO - 2016-02-11 12:50:59,641 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36341/tests/dromaeo/cssquery-ext.html (next: http://localhost:36341/tests/dromaeo/cssquery-jquery.html) 12:51:00 INFO - 2016-02-11 12:51:00,206 DEBUG : BROWSER_OUTPUT: RSS: Main: 220348416 12:51:00 INFO - 2016-02-11 12:51:00,206 DEBUG : BROWSER_OUTPUT: 12:54:01 INFO - 2016-02-11 12:54:01,951 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36341/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36341/tests/dromaeo/cssquery-mootools.html) 12:54:02 INFO - 2016-02-11 12:54:02,512 DEBUG : BROWSER_OUTPUT: RSS: Main: 211664896 12:54:02 INFO - 2016-02-11 12:54:02,512 DEBUG : BROWSER_OUTPUT: 12:57:04 INFO - 2016-02-11 12:57:04,276 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36341/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36341/tests/dromaeo/cssquery-prototype.html) 12:57:04 INFO - 2016-02-11 12:57:04,842 DEBUG : BROWSER_OUTPUT: RSS: Main: 205680640 12:57:04 INFO - 2016-02-11 12:57:04,842 DEBUG : BROWSER_OUTPUT: 13:00:07 INFO - 2016-02-11 13:00:07,185 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36341/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36341/tests/dromaeo/cssquery-yui.html) 13:00:07 INFO - 2016-02-11 13:00:07,747 DEBUG : BROWSER_OUTPUT: RSS: Main: 201011200 13:00:07 INFO - 2016-02-11 13:00:07,747 DEBUG : BROWSER_OUTPUT: 13:03:09 INFO - 2016-02-11 13:03:09,779 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36341/tests/dromaeo/cssquery-yui.html (next: http://localhost:36341/tests/dromaeo/cssquery-dojo.html) 13:03:10 INFO - 2016-02-11 13:03:10,025 DEBUG : BROWSER_OUTPUT: RSS: Main: 243757056 13:03:10 INFO - 2016-02-11 13:03:10,025 DEBUG : BROWSER_OUTPUT: 13:03:10 INFO - 2016-02-11 13:03:10,025 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:03:10 INFO - 2016-02-11 13:03:10,026 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:03:10 INFO - 2016-02-11 13:03:10,026 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:03:10 INFO - 2016-02-11 13:03:10,026 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:03:10 INFO - 2016-02-11 13:03:10,026 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3253.4469140246156;3294.061192560121;3330.5836770403685;3335.0661814691894;3358.4290670586006;5315.468453154687;5355.892882142355;5366.892662146754;5375.301210842595;5389.83830485086;5386.676799392039;5397.62216644835;5409.459054094588;5439.945600543993;5460.290162278908;4945.233488809223;4996.875078123039;5014.022265658207;5047.116754567955;5047.621428392885;5004.099262132815;5060.746962651871;5070.543651071403;5076.314697515843;5081.2886195932415;4992.251162325662;5075.416327122372;5095.490450954893;5105.285260063594;5106.285120083191;5037.1940489521685;5075.822346217883;5129.717865517395;5134;5134.743262836881;5053.772580233898;5110.66780659256;5161.894421229328;5162.199859021857;5192.402873669538;5282.0756367635895;5320.068987927098;5393.325834270716;5503.9174412383845;5504;6008.309044459856;6015.849603759897;6017.63894166347;6019.969900150515;6029.397060293979;6015.969920150415;6019.849503762397;6033.064874944391;6033.3664965178905;6043.848903777397;5421.674699518002;5501.807436739695;5513.862153446155;5566.35986861508;5622.128570071645;6023.307319658208;6076.908846367308;6106.6336019838955;6119.479844213202;6120.326764055951;5940.762369505258;5948.137520059568;5948.375420580864;5950.137230101697;5957.076653118686;5731.828045158652;5833.154192642043;5839.270091238595;5883.970580147072;5916.556258280646;5838.12428135783;5840.474357307778;5846.035404158266;5847.1229315603;5848.2689663792025;5780.826575202751;5900.321463031721;5921.111833225051;5923.822285331361;5925.851853703605;4515;4596.287575425815;4607.14767767964;4623.53764623535;4637.489876113625;4094.4063110849356;4108.219438306772;4110.712250142461;4119.299719047769;4142.130152667974;5374.113271310268;5510.9448905510435;5592.86017849557;5597.692126933058;5603.579731520153;5941.1385349125;5994.6403215807195;6020.578559500793;6029.668368239789;6052.848678783065;5574.554035677136;5612;5612.410696876769;5616.466435688603;5620.494155526022;5087.440381558025;5115.053715062725;5178.352705911761;5204.297419848348;5206.947930520646;6111.728004700595;6143.56995010345;6144.938550614526;6148.292946311142;6150.985087460608;6006.8498287541415;6008.579399441997;6019.668918209541;6037.698115094227;6050.062240352752;6002.0996850472775;6013.398660133952;6127.387261273837;6138.355472675305;6142.447179753844;5863.149843272787;5904.498117659875;5910.438508341701;5920.348761636303;5920.911186332295;5956.493698035715;6009.489193418608;6016.6690832002905;6017.187679663364;6023.30731965812;5616.803411880564;5718.942810571841;5752.07966725322;5822.272215973004;5856.033754430471;5847.532197424111;5894.233749612523;5902.881942361215;5919.526437885045;5929.377415371497;5614.5789065821045;5794.62334948227;5799.8550036249435;5813.418658134153;5821.126830975388;5700.087985922232;5791.8552036199435;5797.507211886868;5809.767609295581;5837.562182836219;5690.032694441872;5697.601167918206;5760.855978600569;5789.797357092481;5792.884142317214 13:03:10 INFO - 2016-02-11 13:03:10,027 DEBUG : BROWSER_OUTPUT: |1;ext.html;630.5113537008817;636.8535236895514;646.3278190681691;651.2413038809789;652.6377860287539;39744.80127599362;40569.59430405699;40612;40617.1876562469;40661.59338406615;45202;45765.31352029722;45791;45824.312635310496;45899;8114.310283625899;8245.917540824576;9091.272698184146;9300;10386.53260603271;10554.366737995706;10662.840057399146;10677.305975111633;10680.732981675443;10682.252242343038;10668.839967400496;10671.359718416881;10751.946240268826;10766;10787.352758834495;10602.045815876569;10699.144068474503;10702.41136737479;10706.571737130505;10708.19688523364;10454.79090418195;10572;10591.84112238317;10599.523021463976;10601.522931468102;42132;42635.36046959298;42959;43022.784886075366;43045.35431968523;3373.089265898194;3384.1370450534955;3387.3733359328603;3444.50054742061;3975.105601239698;32739.6726032739;32814.83592582046;33016.174595635064;33025.83487082573;33156;4299.226139294926;4374.803133858984;4438.3694613239695;4459.643228541709;4478.0148367359125;284091;284206;286428;286950;287724;58670;60471.09293360603;64088.35911640917;64472.35527644664;70931;62492.68753656203;62830.68584657047;63071;63117;63172;17932.551686207687;17977.550561235814;18088.547786305448;18142.909285453752;18155.27378904829;12654.430550625244;12679.366031698379;12701.36493175356;12718.046146538862;12731.55439559611;21105.577888442145;21382.57234855294;21422.46443838885;21475;21475.677864831727;8007.239312265326;8222.17778222173;8257.8348433031;8385.496870187808;8399.62201700925;997.7677568203263;1038.4911393417322;1083.4474418046852;1142.6172232302106;1146.656003199037;28773.136805895858;28798.712012880023;29480.262993425335;29515.85242073776;29750.25624359365;1162.1690491298593;1190.2441949362217;1205.9809461005436;1232.9321887296285;1279.9552015679405;13853.307334633228;14999.17504537239;15235.847641523444;15692.843071569137;17713.557161071076;410159;414637;417413;417965;418909;54262.45737542653;54739.17891231635;55162.724186379615;55398.44601554013;55732.72133639306;1336.358547897015;1338.2305174524492;1450.4198320671605;1485.8811295096366;1534.0948840184121;29796.255093622833;29989.70010299869;33827;34596.481052783725;34719;52356;52394.73802630963;52452.7377363126;52581;52859.207111894124;313076;314177;316184;316742;317635;44185;44446.11107777891;44993.775031124635;45393;45621.08757824892;48469.27296090491;48617;49060.75469622629;49273.507264928325;50316;39931.80034099811;40769.388459172544;40841.79579102086;41646.58353416548;42001.579984199765;40897.795511022254;41757;41848.1630367397;44904;45231.77384113058;38644.80677596594;38982.80508597439;39228.41157382585;39276.607233927294;39381.409278860265;34437.65562344345;34768.652313477556;35123.29753404867;35345.1163720909;35742.821285893406;27218.31954201161;27751;27767.583486248128;27886;27894.44211115807 13:03:10 INFO - 2016-02-11 13:03:10,029 DEBUG : BROWSER_OUTPUT: |2;jquery.html;392.8919547124542;396.071213005502;398.04469273743024;399.26535175277485;401.7950845069015;13513.256770877599;17300.394486192985;19211.13549890255;19573.314933977315;19601.21595136193;18875.811241887575;18890.52773680655;19286.71069933952;19404.902975485104;19456.027198640084;6174.351693072242;6268.247810262752;6299.559030867841;6306.9369306307035;6322.589031712947;5189.896202075956;5345.893082138355;6183.474404675608;6273.874522509547;6279.246490421156;3885.7279990400684;3986.3621820508724;5326.041312563737;5331.840044798643;5333.919991200135;6669.0996715443525;6938.375546200816;6938.653067346638;6968.965155174243;6969.756058537952;6553;6730;6739.292374300726;6744.662766861687;6747.156605424322;22490.100395984304;24458.755412445826;24533.509329813303;25015.249542513753;25941.22176334694;2553.540362734707;2565.9101931432497;2613.9346516337246;2627.0279996401455;2667.5065112954167;15106.39574417022;15218.771718424232;15454.536363909101;15465.458708945132;15660.843391566052;2038.7987779130162;2097.6958341040618;2121.7772133926023;2135.540858715368;2199.373178644095;68618;76809;77009.8448523267;77139.22860771377;77200.61399693022;16251.349946002027;16528.25622846975;16623.750643740354;16632;16663.91668041652;26920.192394228205;27020.729792702215;27352.31619209496;27378.315542111606;27466.862665686545;9726.854097188549;9817.312788104908;9830.606775728891;9866.358686685342;9891.653792117242;8196.811462337928;8226.341892648574;8245.13426090264;8328.08391076981;8364.707235246737;8019.7995050123045;8060.758177254692;8079.313258372987;8087;8121.4721043132;2561.372463746357;3043.802152860057;3112.6887311269143;3147.0558832350202;3163.3673265347024;902.0573500691793;976.2043934193752;1000.0749306891242;1002.5288114586133;1044.9373037617768;16825.663486730442;17202.1398930053;17314.65370692604;17416.303347866196;17788.110594470483;990.980180396388;1013.1742629756725;1042.6924057403085;1049.197364016528;1078.46615925116;9298.209652179641;9713.757156071013;9986.30095893295;10407;10407.427591482541;418196;474429;666555.6722163872;688380;731681;82358;86867;87448.56275718709;87841.56079219563;90678;1196.3659260591726;1197.3474456421272;1211.4185191108318;1216.489074588657;1238.4488902438509;15568.688626227638;15842.12868292255;15949.087603091148;15975.840241597436;16307.510774676779;37137;37164;37279.6272037287;37811.81094094512;38142.237155257295;50327.49672503228;51479.485205147466;51895.48104519057;53628.46371536235;54246.72876635592;9998.550065246936;10100.090991810479;10106.747331316776;10176.542055607664;10239.692809215736;17638.88061331936;17723;18080;18281.634367312847;18668.159932802784;14482.420703171754;14515.05652132608;14551.708965820413;15108.773368399263;15510.069395836286;14975.775363369341;15136.54590362291;15198.392064317746;15459.768103478233;15558.144302063496;15130.243487825785;15358.462453814063;15640.983336083118;15835.445759398366;16047.03717776937;9720.951395242979;9865.654702085392;9904.009599040039;10010.749731256778;10021.699349019542;10451.581936722447;10533.4733263335;12684.429200686176;15210.315535801137;15454.150021748463 13:03:10 INFO - 2016-02-11 13:03:10,032 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1560.8751299896007;1604.6389562348465;1620.8946418482801;1793.1751394358594;1897.8102189781016;7870.173631768661;8047.396445266614;8057.113717491071;8068.717594884173;8079.91920080799;7410.888836667455;7542.132654744706;7563.584002879839;7973.521588704682;8274.669013239478;2288.39357570244;2302.7121609798774;2330.0796185506715;2332.650102484624;2333.8366314358;2316;2323.0707716913203;2451.44842410458;2451.9264422067367;2453.325335532725;1985.2059176329512;2028.4421784009369;2272.0457407888644;2356.1871154451687;2373.6558199061124;2339.5320935812733;2359.1507057459385;2382.2376839411395;2391.6173412254043;2393;2284.4288927768057;2285.0288627333316;2310.0528783198974;2321.2688003278913;2321.7446080931086;8265.669373225064;8340.165983401672;8344.916550834474;8347.874781878276;8348.373871959566;4882.048000639877;4991.875203119915;4993.825216117455;4995.275685025651;4996.550310472075;3220.6296275928335;3221.1624977505785;3269.738420926344;3278.065751260903;3315.1380641033265;1153.532819208222;1153.6942710181809;1156.1964434717875;1192.6958625550517;1207.1067410116539;11501.194916355858;11581.942090289578;11583.131265155063;11643.534258629645;11650.592229271935;4487.461504619401;4498.662600304925;4534.909301814011;4543.863684089482;4550.340200670884;9910;9913.553890074963;9927.106560409453;9941.850872236922;9944.154746846454;4971.975140124348;5008.524190201925;5016.147254966664;5016.899662006739;5021.6735912165595;4499.482559505634;4561.703489273186;4564;4564.315352697122;4573.085382923428;3842.1163132479687;3892.591277915835;3910.413437984268;3914.412838074312;3932.980335098306;1195.462042081067;1227.9508819647292;1237.5049980008068;1239.7148655809215;1267.7527882063093;1096.1614365010773;1101.0750969185922;1149.2759561476216;1295.1193188631632;1394.9930250348684;7585.241475852481;7753.302202801775;7839.137694853562;7848.568328741974;7876.842463150705;935.9672411465566;955.5652178258875;1103.4979084516526;1121.2599684208383;1181.1750844944581;6362.522810789117;6419.871602567922;6425.646589437532;6449.419552240321;6457.031445283151;9651.131398174199;10134.594616215269;10142.746431339128;10321.63874264397;10342.172626189888;10106.898931010743;10130.189584833195;10140;10140.49297535135;10145.94927025375;7600.201978792147;7897.131315555399;7898.210178982055;7903;7906.327962123284;7269.091363579552;7731.072271327476;7732.226777322448;7746.0317460317465;7751.806204844924;8789.472631642122;8989.41568798026;9060.320475964198;9072.319576031692;9183.494907780136;9063.184313411824;9111.772205694911;9120.361574689709;9340.159385655052;9417.62329506812;7296.489245752747;7403.296686814744;7406.888896666446;7408.407327413686;7410.925890741024;7838.686452541834;7886.763397098096;7915.802104947423;7959.960200199193;7971.760847174594;6743.2582415935185;7400.703971841066;7530.811729706801;7594.468387212842;7675.577843218453;6867.969804529161;7636.923630763844;7645.4648174629465;7672.80817979555;7792.649330780015;7774.183710710294;7843.607819608883;7847;7847.607619618882;7847.9607601961625;6808.38724514796;6996.790096297119;7048.612326322102;7088.397486213524;7103.076600041962;6898.931010689829;6902.620355880475;6909.44724422035;6924.272951340238;6954.026436298821 13:03:10 INFO - 2016-02-11 13:03:10,034 DEBUG : BROWSER_OUTPUT: |4;prototype.html;373.2646686028524;373.69730518280176;374.5280946008029;376.77205290799066;383.81576843115306;6075.51395888329;6109.35851735568;6121.296050954142;6154.446099851012;6220.098085777559;5828.679422631753;5941.316748573915;6004.399560043993;6110.327863934964;6133.6626485543275;4741.099191153687;4771.33201351811;4773.641976851733;4778.4265888093305;4791.880202994918;4586.495485496593;4788.712677239359;4794.208955522335;4796.616270698353;4800.087983283182;4616.676832621718;4660.6504512161555;4723.984343366193;4740.146773580754;4751.928721069186;4712.269598212282;4729.266963620645;4729.408823897013;4729.527047295243;4735.550122738335;4221.6833737469815;4226.281532139544;4226.619604235603;4233.089885674594;4236.68224883135;5754.74103665336;5838.6204896682;5839.182514447981;5845.5908086433965;5852.034414321632;5541.27963364764;5549.556035517149;5560.304961879765;5560.944390556083;5561.860953476155;6451.1936007999;6455;6458.192725909262;6460.903086453707;6465.321141280145;4711.646626502992;4715.221988371914;4718.363020992191;4726.196546587088;4737.336772851803;6519.771807986745;6688.799336019927;6722.394984451423;6735.057092007123;6737.157855268091;4632;4639.930401043987;4645.465771436328;4651.744154071491;4656.115338085753;4700.482946875841;4703.6942598730975;4706.529347065334;4707.223308154184;4707.31743897133;5351.464853514617;5417.756200970965;5422.376426710979;5435.1847222916085;5440.183972404171;6524.151860258136;6525.706343214567;6534.411902928759;6539.149910511698;6540.215174179129;1667.624784423495;1688.139049084951;1688.5440930948575;1690.0789069956902;1691.5940174358311;1134.6085600467825;1142.725745820997;1145.799485090106;1155.0470861539095;1166.445938179358;6252.968735156295;6255.186825712719;6259.6870156492;6262.718177682015;6266.592671476339;6550;6755.864882702417;6764.680887226944;6765.255821859591;6767.221769496472;6125.663088530085;6225.6264624121795;6318.336574659686;6322.557420980487;6340.936590634127;3616.764910280823;3646.1431563582537;3655.908602284964;3658.2500587379523;3668.871589494355;6802.319768023158;6951;6953.826154346182;6958.130233720785;6959.756408525677;6912.447004239649;6931.514793964475;6933.2720064393525;6948.096747422803;6958.503921656868;6895.931040689529;6911.03245545624;6950.756723514653;6971.407430368374;6974.407175390149;6654.268030516542;6788.59268443895;6795.626240556817;6797.93202067973;6804.591724496546;6693.196816382066;6696.732130714911;6706.094677218513;6709.597424154566;6712.563683360566;6956.5478243913985;6967.616781077089;6979;6979.232284448808;6985.650717464208;4680.4149481314835;4710.034442939258;4737;4742.762861856824;4746.905061898674;6763.391294783493;6777.6272305023695;6778.356056174655;6781.728730850711;6788.083608712958;6617.07360969455;6619.569727967667;6627.668616569249;6628.038934354588;6629.535932484872;6441.581297215666;6596.2744098148205;6601.339866013553;6608.867822643617;6673.733050677918;6550.443212327005;6554.508411869034;6556.0493728408155;6562.245341785756;6563.9343606563325;6673.132492775908;6674.666266686743;6677.899831502435;6683.331666833278;6683.498737594603;6303.716332764945;6490.935090649033;6505.316941721051;6530.67346632676;6544.54188206821 13:03:10 INFO - 2016-02-11 13:03:10,035 DEBUG : BROWSER_OUTPUT: |5;yui.html;735.5623404074573;784.2627929746039;842.1704620948368;914.3782228084899;931.9906800931989;13337.399817008234;13368.866311336884;13669.316534173277;13684.452621895125;13743.725125497496;12719.30043847588;12788.424520896559;12875.806862897063;12910.93544532276;13252.867471325284;746.7535713214653;750.6546988385322;828.9544075075869;847.2501835875264;890.2877697841701;894.8210357928408;903.7695387676133;911.116217269251;912.2975309012056;913.324140136301;925.1673493855517;946.1153821177187;946.8248374050822;947.1948843483053;947.8388673925449;774.7094839435183;788.2432864450135;920.4891285336636;941.0307383395045;942.7030485397078;691.325957191734;693.8855088910324;701.130598058409;701.7333413302963;702.199492578461;13957.58127256184;13978.440862365493;13980.860191398058;13998.440062397594;14026.92986535071;12651.493940242379;13529.932350338186;13618.250996195206;13691.246981416018;13691.726165476734;10149.949250253701;10179.694609161663;10215.540300686487;10278.229132814993;10342.276040677156;3884.4173373993845;3951.8616848410456;3958.782266975344;3962.2075584883137;3966.1671049079728;46283;46578.53421465776;48428.75785621049;48826.26760598594;49005.26492102585;9858.570507276405;10427.478626068667;10822.296550724177;10843.186760992958;10904.61833835812;18917.7162342565;18941;18948.24207031731;18969.525761856064;19316.227350905807;7909.3277071449575;7983;7990.84018319642;8024.398170137263;8227.794305142299;4460.264056430718;4516.6160876325885;4523.163214805271;4531.13908357411;4669.066186762661;3317.1209629448217;3330.8501117449773;3333.399988002183;3340.883069092619;3343.699067083974;571.8598943258928;578.1645522220351;582.3332284534184;587.3069777662314;597.8774351258069;664.2527156948433;686.993130068703;690.4786885901112;707.487071872888;712.2201189697273;9216.815663686688;9559.06195281816;9840.392544044578;9862.704118876445;9873.111419972238;653.2520264297448;684.1619016704498;696.3697853442643;697.693015073366;713.2653367031966;4174.248635245685;4246.150769845982;4262.232798096373;4385.6710746694125;4449.28811390176;58039.709801451565;58138.418615814146;58354;58614.41385586175;60884.69557652184;52369.21446178311;53385.466145338825;53618.19572706413;54326;55862.441375585724;48646.270305945436;48864.26703599378;49519.50480495221;49526.75236623866;49718.751406242736;9182.724518264462;9329.067093290616;9439.386439881386;9510.572024258787;9669.854952175863;35929.82035089912;36526.26947460983;37902.8104859474;38230.23539529138;38299;46475.76762116168;46955;47182;47502.76248618873;47612.761936190094;11653.242539234923;11734.765304694029;12014.819777703167;12300;12331.876681233432;13170.209787412787;13190.208587484782;13225.40485678166;13245;13269.933650331686;12340.197887137307;12423.31671758026;12505.187162834387;12563.623091307276;12744.42650080767;12101.152919295917;12479.251244925334;12485.375731213222;12693.365331733192;12755.80866287025;9084.214557129802;11464.25482343645;11680.532778688757;11692;11951.282923024646;10444;11070;11111.72220694489;11118.49966751482;11206.887931120911;10119.59521619127;10430.426326552113;10547.156227501628;10559.472026398804;10630.893691062991 13:03:10 INFO - 2016-02-11 13:03:10,035 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:03:10 INFO - 2016-02-11 13:03:10,035 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:03:10 INFO - 2016-02-11 13:03:10,036 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,759 13:03:10 INFO - 2016-02-11 13:03:10,036 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:03:10 INFO - 2016-02-11 13:03:10,036 DEBUG : BROWSER_OUTPUT: __startTimestamp1455224590024__endTimestamp 13:03:10 INFO - 2016-02-11 13:03:10,036 DEBUG : BROWSER_OUTPUT: 13:03:10 INFO - 2016-02-11 13:03:10,037 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:03:10 INFO - 2016-02-11 13:03:10,037 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:03:10 INFO - 2016-02-11 13:03:10,037 DEBUG : BROWSER_OUTPUT: 13:03:10 INFO - 2016-02-11 13:03:10,037 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5521.06 Median:5752.08 stddev:611.50 (10.6%) stddev-sans-first:586.93 13:03:10 INFO - 2016-02-11 13:03:10,039 DEBUG : BROWSER_OUTPUT: Values: 3253.4 3294.1 3330.6 3335.1 3358.4 5315.5 5355.9 5366.9 5375.3 5389.8 5386.7 5397.6 5409.5 5439.9 5460.3 4945.2 4996.9 5014.0 5047.1 5047.6 5004.1 5060.7 5070.5 5076.3 5081.3 4992.3 5075.4 5095.5 5105.3 5106.3 5037.2 5075.8 5129.7 5134.0 5134.7 5053.8 5110.7 5161.9 5162.2 5192.4 5282.1 5320.1 5393.3 5503.9 5504.0 6008.3 6015.8 6017.6 6020.0 6029.4 6016.0 6019.8 6033.1 6033.4 6043.8 5421.7 5501.8 5513.9 5566.4 5622.1 6023.3 6076.9 6106.6 6119.5 6120.3 5940.8 5948.1 5948.4 5950.1 5957.1 5731.8 5833.2 5839.3 5884.0 5916.6 5838.1 5840.5 5846.0 5847.1 5848.3 5780.8 5900.3 5921.1 5923.8 5925.9 4515.0 4596.3 4607.1 4623.5 4637.5 4094.4 4108.2 4110.7 4119.3 4142.1 5374.1 5510.9 5592.9 5597.7 5603.6 5941.1 5994.6 6020.6 6029.7 6052.8 5574.6 5612.0 5612.4 5616.5 5620.5 5087.4 5115.1 5178.4 5204.3 5206.9 6111.7 6143.6 6144.9 6148.3 6151.0 6006.8 6008.6 6019.7 6037.7 6050.1 6002.1 6013.4 6127.4 6138.4 6142.4 5863.1 5904.5 5910.4 5920.3 5920.9 5956.5 6009.5 6016.7 6017.2 6023.3 5616.8 5718.9 5752.1 5822.3 5856.0 5847.5 5894.2 5902.9 5919.5 5929.4 5614.6 5794.6 5799.9 5813.4 5821.1 5700.1 5791.9 5797.5 5809.8 5837.6 5690.0 5697.6 5760.9 5789.8 5792.9 13:03:10 INFO - 2016-02-11 13:03:10,039 DEBUG : BROWSER_OUTPUT: 13:03:10 INFO - 2016-02-11 13:03:10,039 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:52637.96 Median:34945.97 stddev:90032.79 (257.6%) stddev-sans-first:90200.67 13:03:10 INFO - 2016-02-11 13:03:10,040 DEBUG : BROWSER_OUTPUT: Values: 630.5 636.9 646.3 651.2 652.6 39744.8 40569.6 40612.0 40617.2 40661.6 45202.0 45765.3 45791.0 45824.3 45899.0 8114.3 8245.9 9091.3 9300.0 10386.5 10554.4 10662.8 10677.3 10680.7 10682.3 10668.8 10671.4 10751.9 10766.0 10787.4 10602.0 10699.1 10702.4 10706.6 10708.2 10454.8 10572.0 10591.8 10599.5 10601.5 42132.0 42635.4 42959.0 43022.8 43045.4 3373.1 3384.1 3387.4 3444.5 3975.1 32739.7 32814.8 33016.2 33025.8 33156.0 4299.2 4374.8 4438.4 4459.6 4478.0 284091.0 284206.0 286428.0 286950.0 287724.0 58670.0 60471.1 64088.4 64472.4 70931.0 62492.7 62830.7 63071.0 63117.0 63172.0 17932.6 17977.6 18088.5 18142.9 18155.3 12654.4 12679.4 12701.4 12718.0 12731.6 21105.6 21382.6 21422.5 21475.0 21475.7 8007.2 8222.2 8257.8 8385.5 8399.6 997.8 1038.5 1083.4 1142.6 1146.7 28773.1 28798.7 29480.3 29515.9 29750.3 1162.2 1190.2 1206.0 1232.9 1280.0 13853.3 14999.2 15235.8 15692.8 17713.6 410159.0 414637.0 417413.0 417965.0 418909.0 54262.5 54739.2 55162.7 55398.4 55732.7 1336.4 1338.2 1450.4 1485.9 1534.1 29796.3 29989.7 33827.0 34596.5 34719.0 52356.0 52394.7 52452.7 52581.0 52859.2 313076.0 314177.0 316184.0 316742.0 317635.0 44185.0 44446.1 44993.8 45393.0 45621.1 48469.3 48617.0 49060.8 49273.5 50316.0 39931.8 40769.4 40841.8 41646.6 42001.6 40897.8 41757.0 41848.2 44904.0 45231.8 38644.8 38982.8 39228.4 39276.6 39381.4 34437.7 34768.7 35123.3 35345.1 35742.8 27218.3 27751.0 27767.6 27886.0 27894.4 13:03:10 INFO - 2016-02-11 13:03:10,040 DEBUG : BROWSER_OUTPUT: 13:03:10 INFO - 2016-02-11 13:03:10,041 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32684.27 Median:14793.85 stddev:99537.36 (672.8%) stddev-sans-first:99787.06 13:03:10 INFO - 2016-02-11 13:03:10,041 DEBUG : BROWSER_OUTPUT: Values: 392.9 396.1 398.0 399.3 401.8 13513.3 17300.4 19211.1 19573.3 19601.2 18875.8 18890.5 19286.7 19404.9 19456.0 6174.4 6268.2 6299.6 6306.9 6322.6 5189.9 5345.9 6183.5 6273.9 6279.2 3885.7 3986.4 5326.0 5331.8 5333.9 6669.1 6938.4 6938.7 6969.0 6969.8 6553.0 6730.0 6739.3 6744.7 6747.2 22490.1 24458.8 24533.5 25015.2 25941.2 2553.5 2565.9 2613.9 2627.0 2667.5 15106.4 15218.8 15454.5 15465.5 15660.8 2038.8 2097.7 2121.8 2135.5 2199.4 68618.0 76809.0 77009.8 77139.2 77200.6 16251.3 16528.3 16623.8 16632.0 16663.9 26920.2 27020.7 27352.3 27378.3 27466.9 9726.9 9817.3 9830.6 9866.4 9891.7 8196.8 8226.3 8245.1 8328.1 8364.7 8019.8 8060.8 8079.3 8087.0 8121.5 2561.4 3043.8 3112.7 3147.1 3163.4 902.1 976.2 1000.1 1002.5 1044.9 16825.7 17202.1 17314.7 17416.3 17788.1 991.0 1013.2 1042.7 1049.2 1078.5 9298.2 9713.8 9986.3 10407.0 10407.4 418196.0 474429.0 666555.7 688380.0 731681.0 82358.0 86867.0 87448.6 87841.6 90678.0 1196.4 1197.3 1211.4 1216.5 1238.4 15568.7 15842.1 15949.1 15975.8 16307.5 37137.0 37164.0 37279.6 37811.8 38142.2 50327.5 51479.5 51895.5 53628.5 54246.7 9998.6 10100.1 10106.7 10176.5 10239.7 17638.9 17723.0 18080.0 18281.6 18668.2 14482.4 14515.1 14551.7 15108.8 15510.1 14975.8 15136.5 15198.4 15459.8 15558.1 15130.2 15358.5 15641.0 15835.4 16047.0 9721.0 9865.7 9904.0 10010.7 10021.7 10451.6 10533.5 12684.4 15210.3 15454.2 13:03:10 INFO - 2016-02-11 13:03:10,041 DEBUG : BROWSER_OUTPUT: 13:03:10 INFO - 2016-02-11 13:03:10,041 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5831.91 Median:5019.29 stddev:3057.89 (60.9%) stddev-sans-first:3049.61 13:03:10 INFO - 2016-02-11 13:03:10,041 DEBUG : BROWSER_OUTPUT: Values: 1560.9 1604.6 1620.9 1793.2 1897.8 7870.2 8047.4 8057.1 8068.7 8079.9 7410.9 7542.1 7563.6 7973.5 8274.7 2288.4 2302.7 2330.1 2332.7 2333.8 2316.0 2323.1 2451.4 2451.9 2453.3 1985.2 2028.4 2272.0 2356.2 2373.7 2339.5 2359.2 2382.2 2391.6 2393.0 2284.4 2285.0 2310.1 2321.3 2321.7 8265.7 8340.2 8344.9 8347.9 8348.4 4882.0 4991.9 4993.8 4995.3 4996.6 3220.6 3221.2 3269.7 3278.1 3315.1 1153.5 1153.7 1156.2 1192.7 1207.1 11501.2 11581.9 11583.1 11643.5 11650.6 4487.5 4498.7 4534.9 4543.9 4550.3 9910.0 9913.6 9927.1 9941.9 9944.2 4972.0 5008.5 5016.1 5016.9 5021.7 4499.5 4561.7 4564.0 4564.3 4573.1 3842.1 3892.6 3910.4 3914.4 3933.0 1195.5 1228.0 1237.5 1239.7 1267.8 1096.2 1101.1 1149.3 1295.1 1395.0 7585.2 7753.3 7839.1 7848.6 7876.8 936.0 955.6 1103.5 1121.3 1181.2 6362.5 6419.9 6425.6 6449.4 6457.0 9651.1 10134.6 10142.7 10321.6 10342.2 10106.9 10130.2 10140.0 10140.5 10145.9 7600.2 7897.1 7898.2 7903.0 7906.3 7269.1 7731.1 7732.2 7746.0 7751.8 8789.5 8989.4 9060.3 9072.3 9183.5 9063.2 9111.8 9120.4 9340.2 9417.6 7296.5 7403.3 7406.9 7408.4 7410.9 7838.7 7886.8 7915.8 7960.0 7971.8 6743.3 7400.7 7530.8 7594.5 7675.6 6868.0 7636.9 7645.5 7672.8 7792.6 7774.2 7843.6 7847.0 7847.6 7848.0 6808.4 6996.8 7048.6 7088.4 7103.1 6898.9 6902.6 6909.4 6924.3 6954.0 13:03:10 INFO - 2016-02-11 13:03:10,041 DEBUG : BROWSER_OUTPUT: 13:03:10 INFO - 2016-02-11 13:03:10,041 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5489.78 Median:6222.86 stddev:1633.13 (26.2%) stddev-sans-first:1591.91 13:03:10 INFO - 2016-02-11 13:03:10,042 DEBUG : BROWSER_OUTPUT: Values: 373.3 373.7 374.5 376.8 383.8 6075.5 6109.4 6121.3 6154.4 6220.1 5828.7 5941.3 6004.4 6110.3 6133.7 4741.1 4771.3 4773.6 4778.4 4791.9 4586.5 4788.7 4794.2 4796.6 4800.1 4616.7 4660.7 4724.0 4740.1 4751.9 4712.3 4729.3 4729.4 4729.5 4735.6 4221.7 4226.3 4226.6 4233.1 4236.7 5754.7 5838.6 5839.2 5845.6 5852.0 5541.3 5549.6 5560.3 5560.9 5561.9 6451.2 6455.0 6458.2 6460.9 6465.3 4711.6 4715.2 4718.4 4726.2 4737.3 6519.8 6688.8 6722.4 6735.1 6737.2 4632.0 4639.9 4645.5 4651.7 4656.1 4700.5 4703.7 4706.5 4707.2 4707.3 5351.5 5417.8 5422.4 5435.2 5440.2 6524.2 6525.7 6534.4 6539.1 6540.2 1667.6 1688.1 1688.5 1690.1 1691.6 1134.6 1142.7 1145.8 1155.0 1166.4 6253.0 6255.2 6259.7 6262.7 6266.6 6550.0 6755.9 6764.7 6765.3 6767.2 6125.7 6225.6 6318.3 6322.6 6340.9 3616.8 3646.1 3655.9 3658.3 3668.9 6802.3 6951.0 6953.8 6958.1 6959.8 6912.4 6931.5 6933.3 6948.1 6958.5 6895.9 6911.0 6950.8 6971.4 6974.4 6654.3 6788.6 6795.6 6797.9 6804.6 6693.2 6696.7 6706.1 6709.6 6712.6 6956.5 6967.6 6979.0 6979.2 6985.7 4680.4 4710.0 4737.0 4742.8 4746.9 6763.4 6777.6 6778.4 6781.7 6788.1 6617.1 6619.6 6627.7 6628.0 6629.5 6441.6 6596.3 6601.3 6608.9 6673.7 6550.4 6554.5 6556.0 6562.2 6563.9 6673.1 6674.7 6677.9 6683.3 6683.5 6303.7 6490.9 6505.3 6530.7 6544.5 13:03:10 INFO - 2016-02-11 13:03:10,042 DEBUG : BROWSER_OUTPUT: 13:03:10 INFO - 2016-02-11 13:03:10,043 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14477.57 Median:4527.15 stddev:16519.17 (364.9%) stddev-sans-first:16533.28 13:03:10 INFO - 2016-02-11 13:03:10,043 DEBUG : BROWSER_OUTPUT: Values: 735.6 784.3 842.2 914.4 932.0 13337.4 13368.9 13669.3 13684.5 13743.7 12719.3 12788.4 12875.8 12910.9 13252.9 746.8 750.7 829.0 847.3 890.3 894.8 903.8 911.1 912.3 913.3 925.2 946.1 946.8 947.2 947.8 774.7 788.2 920.5 941.0 942.7 691.3 693.9 701.1 701.7 702.2 13957.6 13978.4 13980.9 13998.4 14026.9 12651.5 13529.9 13618.3 13691.2 13691.7 10149.9 10179.7 10215.5 10278.2 10342.3 3884.4 3951.9 3958.8 3962.2 3966.2 46283.0 46578.5 48428.8 48826.3 49005.3 9858.6 10427.5 10822.3 10843.2 10904.6 18917.7 18941.0 18948.2 18969.5 19316.2 7909.3 7983.0 7990.8 8024.4 8227.8 4460.3 4516.6 4523.2 4531.1 4669.1 3317.1 3330.9 3333.4 3340.9 3343.7 571.9 578.2 582.3 587.3 597.9 664.3 687.0 690.5 707.5 712.2 9216.8 9559.1 9840.4 9862.7 9873.1 653.3 684.2 696.4 697.7 713.3 4174.2 4246.2 4262.2 4385.7 4449.3 58039.7 58138.4 58354.0 58614.4 60884.7 52369.2 53385.5 53618.2 54326.0 55862.4 48646.3 48864.3 49519.5 49526.8 49718.8 9182.7 9329.1 9439.4 9510.6 9669.9 35929.8 36526.3 37902.8 38230.2 38299.0 46475.8 46955.0 47182.0 47502.8 47612.8 11653.2 11734.8 12014.8 12300.0 12331.9 13170.2 13190.2 13225.4 13245.0 13269.9 12340.2 12423.3 12505.2 12563.6 12744.4 12101.2 12479.3 12485.4 12693.4 12755.8 9084.2 11464.3 11680.5 11692.0 11951.3 10444.0 11070.0 11111.7 11118.5 11206.9 10119.6 10430.4 10547.2 10559.5 10630.9 13:03:10 INFO - 2016-02-11 13:03:10,043 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:03:10 INFO - 2016-02-11 13:03:10,043 DEBUG : BROWSER_OUTPUT: 13:03:10 INFO - 2016-02-11 13:03:10,651 INFO : Browser exited with error code: 0 13:03:10 INFO - 2016-02-11 13:03:10,669 INFO : Completed test dromaeo_css (00:18:29) 13:03:10 INFO - 2016-02-11 13:03:10,669 INFO : Starting test kraken 13:03:10 INFO - 2016-02-11 13:03:10,669 DEBUG : operating with platform_type : linux_ 13:03:10 INFO - 2016-02-11 13:03:10,669 INFO : Initialising browser for kraken test... 13:03:10 INFO - 2016-02-11 13:03:10,676 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgvnjoZ/profile http://localhost:36341/getInfo.html 13:03:14 INFO - 2016-02-11 13:03:14,369 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:03:14 INFO - 2016-02-11 13:03:14,369 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:03:14 INFO - 2016-02-11 13:03:14,369 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:03:14 INFO - 2016-02-11 13:03:14,370 DEBUG : BROWSER_OUTPUT: __metrics 13:03:14 INFO - 2016-02-11 13:03:14,531 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] 13:03:15 INFO - 2016-02-11 13:03:15,274 INFO : Browser initialized. 13:03:15 INFO - 2016-02-11 13:03:15,275 INFO : Running cycle 1/1 for kraken test... 13:03:15 INFO - 2016-02-11 13:03:15,275 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgvnjoZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:03:26 INFO - 2016-02-11 13:03:26,941 DEBUG : BROWSER_OUTPUT: RSS: Main: 132034560 13:03:26 INFO - 2016-02-11 13:03:26,941 DEBUG : BROWSER_OUTPUT: 13:03:29 INFO - 2016-02-11 13:03:29,380 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36341/tests/kraken/driver.html?testName=audio-beat-detection) 13:03:29 INFO - 2016-02-11 13:03:29,946 DEBUG : BROWSER_OUTPUT: RSS: Main: 164720640 13:03:29 INFO - 2016-02-11 13:03:29,946 DEBUG : BROWSER_OUTPUT: 13:03:32 INFO - 2016-02-11 13:03:32,501 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36341/tests/kraken/driver.html?testName=audio-dft) 13:03:33 INFO - 2016-02-11 13:03:33,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 161390592 13:03:33 INFO - 2016-02-11 13:03:33,067 DEBUG : BROWSER_OUTPUT: 13:03:35 INFO - 2016-02-11 13:03:35,836 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36341/tests/kraken/driver.html?testName=audio-fft) 13:03:36 INFO - 2016-02-11 13:03:36,398 DEBUG : BROWSER_OUTPUT: RSS: Main: 160014336 13:03:36 INFO - 2016-02-11 13:03:36,398 DEBUG : BROWSER_OUTPUT: 13:03:38 INFO - 2016-02-11 13:03:38,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36341/tests/kraken/driver.html?testName=audio-oscillator) 13:03:38 INFO - 2016-02-11 13:03:38,923 DEBUG : BROWSER_OUTPUT: RSS: Main: 160247808 13:03:38 INFO - 2016-02-11 13:03:38,923 DEBUG : BROWSER_OUTPUT: 13:03:41 INFO - 2016-02-11 13:03:41,097 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36341/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:03:41 INFO - 2016-02-11 13:03:41,658 DEBUG : BROWSER_OUTPUT: RSS: Main: 158261248 13:03:41 INFO - 2016-02-11 13:03:41,659 DEBUG : BROWSER_OUTPUT: 13:03:44 INFO - 2016-02-11 13:03:44,496 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36341/tests/kraken/driver.html?testName=imaging-darkroom) 13:03:45 INFO - 2016-02-11 13:03:45,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 157106176 13:03:45 INFO - 2016-02-11 13:03:45,064 DEBUG : BROWSER_OUTPUT: 13:03:48 INFO - 2016-02-11 13:03:48,386 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36341/tests/kraken/driver.html?testName=imaging-desaturate) 13:03:48 INFO - 2016-02-11 13:03:48,952 DEBUG : BROWSER_OUTPUT: RSS: Main: 158396416 13:03:48 INFO - 2016-02-11 13:03:48,952 DEBUG : BROWSER_OUTPUT: 13:03:51 INFO - 2016-02-11 13:03:51,654 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36341/tests/kraken/driver.html?testName=json-parse-financial) 13:03:52 INFO - 2016-02-11 13:03:52,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 158212096 13:03:52 INFO - 2016-02-11 13:03:52,228 DEBUG : BROWSER_OUTPUT: 13:03:53 INFO - 2016-02-11 13:03:53,777 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36341/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:03:54 INFO - 2016-02-11 13:03:54,330 DEBUG : BROWSER_OUTPUT: RSS: Main: 164446208 13:03:54 INFO - 2016-02-11 13:03:54,330 DEBUG : BROWSER_OUTPUT: 13:03:56 INFO - 2016-02-11 13:03:56,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36341/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:03:56 INFO - 2016-02-11 13:03:56,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 162054144 13:03:56 INFO - 2016-02-11 13:03:56,665 DEBUG : BROWSER_OUTPUT: 13:03:58 INFO - 2016-02-11 13:03:58,636 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36341/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:03:59 INFO - 2016-02-11 13:03:59,202 DEBUG : BROWSER_OUTPUT: RSS: Main: 165801984 13:03:59 INFO - 2016-02-11 13:03:59,202 DEBUG : BROWSER_OUTPUT: 13:04:01 INFO - 2016-02-11 13:04:01,582 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36341/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:04:02 INFO - 2016-02-11 13:04:02,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 170303488 13:04:02 INFO - 2016-02-11 13:04:02,163 DEBUG : BROWSER_OUTPUT: 13:04:04 INFO - 2016-02-11 13:04:04,642 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36341/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:04:05 INFO - 2016-02-11 13:04:05,211 DEBUG : BROWSER_OUTPUT: RSS: Main: 170512384 13:04:05 INFO - 2016-02-11 13:04:05,211 DEBUG : BROWSER_OUTPUT: 13:04:06 INFO - 2016-02-11 13:04:06,843 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36341/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36341/tests/kraken/driver.html?testName=ai-astar) 13:04:07 INFO - 2016-02-11 13:04:07,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 228327424 13:04:07 INFO - 2016-02-11 13:04:07,101 DEBUG : BROWSER_OUTPUT: 13:04:07 INFO - 2016-02-11 13:04:07,101 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:04:07 INFO - 2016-02-11 13:04:07,101 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:04:07 INFO - 2016-02-11 13:04:07,101 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:04:07 INFO - 2016-02-11 13:04:07,101 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:04:07 INFO - 2016-02-11 13:04:07,101 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;112;103;110;108;109;99;110;109;108 13:04:07 INFO - 2016-02-11 13:04:07,101 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;121;143;164;124;149;149;124;154;123 13:04:07 INFO - 2016-02-11 13:04:07,101 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;158;160;158;160;160;160;158;159;157 13:04:07 INFO - 2016-02-11 13:04:07,101 DEBUG : BROWSER_OUTPUT: |3;audio-fft;69;71;72;156;70;71;72;71;152;71 13:04:07 INFO - 2016-02-11 13:04:07,102 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;136;92;91;91;138;92;91;139 13:04:07 INFO - 2016-02-11 13:04:07,102 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;108;109 13:04:07 INFO - 2016-02-11 13:04:07,102 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;146;146;146;146;146;145;146;145 13:04:07 INFO - 2016-02-11 13:04:07,102 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;95;96;96;95;95;95 13:04:07 INFO - 2016-02-11 13:04:07,102 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;59;57;58;59;56;59;58;55;55 13:04:07 INFO - 2016-02-11 13:04:07,102 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;63;64;64;64;64;63;63;64;63 13:04:07 INFO - 2016-02-11 13:04:07,102 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;78;76;79;78;86;78;77;79;78;79 13:04:07 INFO - 2016-02-11 13:04:07,102 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;125;111;116;109;115;116;111;113;128 13:04:07 INFO - 2016-02-11 13:04:07,102 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;132;143;144;142;153;133;149;134;142;131 13:04:07 INFO - 2016-02-11 13:04:07,102 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;64;65;66;64;64;65;63;64;64 13:04:07 INFO - 2016-02-11 13:04:07,102 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:04:07 INFO - 2016-02-11 13:04:07,102 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:04:07 INFO - 2016-02-11 13:04:07,102 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,873 13:04:07 INFO - 2016-02-11 13:04:07,102 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:04:07 INFO - 2016-02-11 13:04:07,102 DEBUG : BROWSER_OUTPUT: __startTimestamp1455224647096__endTimestamp 13:04:07 INFO - 2016-02-11 13:04:07,103 DEBUG : BROWSER_OUTPUT: 13:04:07 INFO - 2016-02-11 13:04:07,103 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:04:07 INFO - 2016-02-11 13:04:07,103 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:04:07 INFO - 2016-02-11 13:04:07,103 DEBUG : BROWSER_OUTPUT: 13:04:07 INFO - 2016-02-11 13:04:07,103 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.70 Median:109.50 stddev:3.83 (3.5%) stddev-sans-first:4.03 13:04:07 INFO - 2016-02-11 13:04:07,103 DEBUG : BROWSER_OUTPUT: Values: 109.0 112.0 103.0 110.0 108.0 109.0 99.0 110.0 109.0 108.0 13:04:07 INFO - 2016-02-11 13:04:07,103 DEBUG : BROWSER_OUTPUT: 13:04:07 INFO - 2016-02-11 13:04:07,103 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:139.90 Median:148.50 stddev:15.52 (10.5%) stddev-sans-first:16.19 13:04:07 INFO - 2016-02-11 13:04:07,103 DEBUG : BROWSER_OUTPUT: Values: 148.0 121.0 143.0 164.0 124.0 149.0 149.0 124.0 154.0 123.0 13:04:07 INFO - 2016-02-11 13:04:07,104 DEBUG : BROWSER_OUTPUT: 13:04:07 INFO - 2016-02-11 13:04:07,104 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.00 Median:160.00 stddev:1.15 (0.7%) stddev-sans-first:1.17 13:04:07 INFO - 2016-02-11 13:04:07,104 DEBUG : BROWSER_OUTPUT: Values: 160.0 158.0 160.0 158.0 160.0 160.0 160.0 158.0 159.0 157.0 13:04:07 INFO - 2016-02-11 13:04:07,104 DEBUG : BROWSER_OUTPUT: 13:04:07 INFO - 2016-02-11 13:04:07,104 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.50 Median:71.00 stddev:35.07 (49.4%) stddev-sans-first:36.56 13:04:07 INFO - 2016-02-11 13:04:07,104 DEBUG : BROWSER_OUTPUT: Values: 69.0 71.0 72.0 156.0 70.0 71.0 72.0 71.0 152.0 71.0 13:04:07 INFO - 2016-02-11 13:04:07,104 DEBUG : BROWSER_OUTPUT: 13:04:07 INFO - 2016-02-11 13:04:07,104 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.20 Median:91.00 stddev:22.42 (24.6%) stddev-sans-first:23.18 13:04:07 INFO - 2016-02-11 13:04:07,104 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 136.0 92.0 91.0 91.0 138.0 92.0 91.0 139.0 13:04:07 INFO - 2016-02-11 13:04:07,104 DEBUG : BROWSER_OUTPUT: 13:04:07 INFO - 2016-02-11 13:04:07,104 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:108.90 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:04:07 INFO - 2016-02-11 13:04:07,104 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 108.0 109.0 13:04:07 INFO - 2016-02-11 13:04:07,104 DEBUG : BROWSER_OUTPUT: 13:04:07 INFO - 2016-02-11 13:04:07,104 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 13:04:07 INFO - 2016-02-11 13:04:07,104 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 13:04:07 INFO - 2016-02-11 13:04:07,104 DEBUG : BROWSER_OUTPUT: 13:04:07 INFO - 2016-02-11 13:04:07,105 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 13:04:07 INFO - 2016-02-11 13:04:07,105 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 13:04:07 INFO - 2016-02-11 13:04:07,105 DEBUG : BROWSER_OUTPUT: 13:04:07 INFO - 2016-02-11 13:04:07,105 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.20 Median:58.00 stddev:1.62 (2.8%) stddev-sans-first:1.66 13:04:07 INFO - 2016-02-11 13:04:07,105 DEBUG : BROWSER_OUTPUT: Values: 56.0 59.0 57.0 58.0 59.0 56.0 59.0 58.0 55.0 55.0 13:04:07 INFO - 2016-02-11 13:04:07,105 DEBUG : BROWSER_OUTPUT: 13:04:07 INFO - 2016-02-11 13:04:07,105 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.60 Median:64.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 13:04:07 INFO - 2016-02-11 13:04:07,105 DEBUG : BROWSER_OUTPUT: Values: 64.0 63.0 64.0 64.0 64.0 64.0 63.0 63.0 64.0 63.0 13:04:07 INFO - 2016-02-11 13:04:07,105 DEBUG : BROWSER_OUTPUT: 13:04:07 INFO - 2016-02-11 13:04:07,105 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:78.50 stddev:2.70 (3.4%) stddev-sans-first:2.85 13:04:07 INFO - 2016-02-11 13:04:07,105 DEBUG : BROWSER_OUTPUT: Values: 78.0 76.0 79.0 78.0 86.0 78.0 77.0 79.0 78.0 79.0 13:04:07 INFO - 2016-02-11 13:04:07,105 DEBUG : BROWSER_OUTPUT: 13:04:07 INFO - 2016-02-11 13:04:07,105 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:117.30 Median:116.00 stddev:7.35 (6.3%) stddev-sans-first:6.46 13:04:07 INFO - 2016-02-11 13:04:07,105 DEBUG : BROWSER_OUTPUT: Values: 129.0 125.0 111.0 116.0 109.0 115.0 116.0 111.0 113.0 128.0 13:04:07 INFO - 2016-02-11 13:04:07,105 DEBUG : BROWSER_OUTPUT: 13:04:07 INFO - 2016-02-11 13:04:07,105 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.30 Median:142.50 stddev:7.54 (5.3%) stddev-sans-first:7.38 13:04:07 INFO - 2016-02-11 13:04:07,106 DEBUG : BROWSER_OUTPUT: Values: 132.0 143.0 144.0 142.0 153.0 133.0 149.0 134.0 142.0 131.0 13:04:07 INFO - 2016-02-11 13:04:07,106 DEBUG : BROWSER_OUTPUT: 13:04:07 INFO - 2016-02-11 13:04:07,106 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 13:04:07 INFO - 2016-02-11 13:04:07,106 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 65.0 66.0 64.0 64.0 65.0 63.0 64.0 64.0 13:04:07 INFO - 2016-02-11 13:04:07,106 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:04:07 INFO - 2016-02-11 13:04:07,106 DEBUG : BROWSER_OUTPUT: 13:04:07 INFO - 2016-02-11 13:04:07,811 INFO : Browser exited with error code: 0 13:04:07 INFO - 2016-02-11 13:04:07,859 INFO : Completed test kraken (00:00:57) 13:04:07 INFO - 2016-02-11 13:04:07,859 INFO : Starting test v8_7 13:04:07 INFO - 2016-02-11 13:04:07,859 DEBUG : operating with platform_type : linux_ 13:04:07 INFO - 2016-02-11 13:04:07,859 INFO : Initialising browser for v8_7 test... 13:04:07 INFO - 2016-02-11 13:04:07,865 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsq5f4H/profile http://localhost:36341/getInfo.html 13:04:11 INFO - 2016-02-11 13:04:11,546 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:04:11 INFO - 2016-02-11 13:04:11,546 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:04:11 INFO - 2016-02-11 13:04:11,546 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:04:11 INFO - 2016-02-11 13:04:11,546 DEBUG : BROWSER_OUTPUT: __metrics 13:04:11 INFO - 2016-02-11 13:04:11,695 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] 13:04:12 INFO - 2016-02-11 13:04:12,415 INFO : Browser initialized. 13:04:12 INFO - 2016-02-11 13:04:12,415 INFO : Running cycle 1/1 for v8_7 test... 13:04:12 INFO - 2016-02-11 13:04:12,415 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsq5f4H/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:04:24 INFO - 2016-02-11 13:04:24,094 DEBUG : BROWSER_OUTPUT: RSS: Main: 132276224 13:04:24 INFO - 2016-02-11 13:04:24,094 DEBUG : BROWSER_OUTPUT: 13:04:45 INFO - 2016-02-11 13:04:45,429 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36341/tests/v8_7/run.html (next: http://localhost:36341/tests/v8_7/run.html) 13:04:45 INFO - 2016-02-11 13:04:45,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 424636416 13:04:45 INFO - 2016-02-11 13:04:45,675 DEBUG : BROWSER_OUTPUT: 13:04:45 INFO - 2016-02-11 13:04:45,676 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:04:45 INFO - 2016-02-11 13:04:45,676 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:04:45 INFO - 2016-02-11 13:04:45,676 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:04:45 INFO - 2016-02-11 13:04:45,676 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:04:45 INFO - 2016-02-11 13:04:45,676 DEBUG : BROWSER_OUTPUT: |0;Richards;172.1170395869191 13:04:45 INFO - 2016-02-11 13:04:45,676 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.82610845557937 13:04:45 INFO - 2016-02-11 13:04:45,676 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.473962684489 13:04:45 INFO - 2016-02-11 13:04:45,677 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 13:04:45 INFO - 2016-02-11 13:04:45,677 DEBUG : BROWSER_OUTPUT: |4;RayTrace;962.4639076034649 13:04:45 INFO - 2016-02-11 13:04:45,677 DEBUG : BROWSER_OUTPUT: |5;Earley;539.3743257820928 13:04:45 INFO - 2016-02-11 13:04:45,677 DEBUG : BROWSER_OUTPUT: |6;Boyer;10541.666666666666 13:04:45 INFO - 2016-02-11 13:04:45,677 DEBUG : BROWSER_OUTPUT: |7;RegExp;24357.14285714286 13:04:45 INFO - 2016-02-11 13:04:45,678 DEBUG : BROWSER_OUTPUT: |8;Splay;517.063081695967 13:04:45 INFO - 2016-02-11 13:04:45,678 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 13:04:45 INFO - 2016-02-11 13:04:45,678 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:04:45 INFO - 2016-02-11 13:04:45,678 DEBUG : BROWSER_OUTPUT: __startTimestamp1455224685675__endTimestamp 13:04:45 INFO - 2016-02-11 13:04:45,678 DEBUG : BROWSER_OUTPUT: 13:04:45 INFO - 2016-02-11 13:04:45,678 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:04:45 INFO - 2016-02-11 13:04:45,678 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:04:45 INFO - 2016-02-11 13:04:45,678 DEBUG : BROWSER_OUTPUT: 13:04:45 INFO - 2016-02-11 13:04:45,679 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:172.12 Median:172.12 stddev:0.00 (0.0%) 13:04:45 INFO - 2016-02-11 13:04:45,679 DEBUG : BROWSER_OUTPUT: Values: 172.1 13:04:45 INFO - 2016-02-11 13:04:45,679 DEBUG : BROWSER_OUTPUT: 13:04:45 INFO - 2016-02-11 13:04:45,679 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.83 Median:164.83 stddev:0.00 (0.0%) 13:04:45 INFO - 2016-02-11 13:04:45,679 DEBUG : BROWSER_OUTPUT: Values: 164.8 13:04:45 INFO - 2016-02-11 13:04:45,679 DEBUG : BROWSER_OUTPUT: 13:04:45 INFO - 2016-02-11 13:04:45,679 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.47 Median:278.47 stddev:0.00 (0.0%) 13:04:45 INFO - 2016-02-11 13:04:45,679 DEBUG : BROWSER_OUTPUT: Values: 278.5 13:04:45 INFO - 2016-02-11 13:04:45,679 DEBUG : BROWSER_OUTPUT: 13:04:45 INFO - 2016-02-11 13:04:45,679 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 13:04:45 INFO - 2016-02-11 13:04:45,679 DEBUG : BROWSER_OUTPUT: Values: 5181.3 13:04:45 INFO - 2016-02-11 13:04:45,681 DEBUG : BROWSER_OUTPUT: 13:04:45 INFO - 2016-02-11 13:04:45,681 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:962.46 Median:962.46 stddev:0.00 (0.0%) 13:04:45 INFO - 2016-02-11 13:04:45,681 DEBUG : BROWSER_OUTPUT: Values: 962.5 13:04:45 INFO - 2016-02-11 13:04:45,681 DEBUG : BROWSER_OUTPUT: 13:04:45 INFO - 2016-02-11 13:04:45,681 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:539.37 Median:539.37 stddev:0.00 (0.0%) 13:04:45 INFO - 2016-02-11 13:04:45,681 DEBUG : BROWSER_OUTPUT: Values: 539.4 13:04:45 INFO - 2016-02-11 13:04:45,681 DEBUG : BROWSER_OUTPUT: 13:04:45 INFO - 2016-02-11 13:04:45,681 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10541.67 Median:10541.67 stddev:0.00 (0.0%) 13:04:45 INFO - 2016-02-11 13:04:45,682 DEBUG : BROWSER_OUTPUT: Values: 10541.7 13:04:45 INFO - 2016-02-11 13:04:45,682 DEBUG : BROWSER_OUTPUT: 13:04:45 INFO - 2016-02-11 13:04:45,682 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24357.14 Median:24357.14 stddev:0.00 (0.0%) 13:04:45 INFO - 2016-02-11 13:04:45,682 DEBUG : BROWSER_OUTPUT: Values: 24357.1 13:04:45 INFO - 2016-02-11 13:04:45,682 DEBUG : BROWSER_OUTPUT: 13:04:45 INFO - 2016-02-11 13:04:45,682 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:517.06 Median:517.06 stddev:0.00 (0.0%) 13:04:45 INFO - 2016-02-11 13:04:45,682 DEBUG : BROWSER_OUTPUT: Values: 517.1 13:04:45 INFO - 2016-02-11 13:04:45,683 DEBUG : BROWSER_OUTPUT: 13:04:45 INFO - 2016-02-11 13:04:45,683 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 13:04:45 INFO - 2016-02-11 13:04:45,683 DEBUG : BROWSER_OUTPUT: Values: 4822.1 13:04:45 INFO - 2016-02-11 13:04:45,683 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:04:45 INFO - 2016-02-11 13:04:45,683 DEBUG : BROWSER_OUTPUT: 13:04:46 INFO - 2016-02-11 13:04:46,379 INFO : Browser exited with error code: 0 13:04:46 INFO - 2016-02-11 13:04:46,391 INFO : Completed test v8_7 (00:00:38) 13:04:46 INFO - 2016-02-11 13:04:46,735 INFO : Completed test suite (00:20:05) 13:04:46 INFO - 2016-02-11 13:04:46,735 DEBUG : Working with test: dromaeo_css 13:04:46 INFO - 2016-02-11 13:04:46,735 DEBUG : Generating results file: dromaeo_css 13:04:46 INFO - 2016-02-11 13:04:46,737 DEBUG : Working with test: kraken 13:04:46 INFO - 2016-02-11 13:04:46,737 DEBUG : Generating results file: kraken 13:04:46 INFO - 2016-02-11 13:04:46,737 INFO : javascript benchmark 13:04:46 INFO - 2016-02-11 13:04:46,738 DEBUG : Working with test: v8_7 13:04:46 INFO - 2016-02-11 13:04:46,738 DEBUG : Generating results file: v8_7 13:04:46 INFO - 2016-02-11 13:04:46,738 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:04:46 INFO - 2016-02-11 13:04:46,796 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 13:04:46 INFO - 2016-02-11 13:04:46,797 DEBUG : process_Request line: dromaeo_css 7562.73 graph.html#tests=[[72,53,35]] 13:04:46 INFO - 2016-02-11 13:04:46,797 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:04:46 INFO - 2016-02-11 13:04:46,833 DEBUG : process_Request line: kraken 1470.70 graph.html#tests=[[232,53,35]] 13:04:46 INFO - 2016-02-11 13:04:46,834 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:04:46 INFO - 2016-02-11 13:04:46,867 DEBUG : process_Request line: v8_7 23229.23 graph.html#tests=[[230,53,35]] 13:04:46 INFO - 2016-02-11 13:04:46,869 INFO : javascript benchmark 13:04:46 INFO - 2016-02-11 13:04:46,872 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3253.4469140246156, 3294.061192560121, 3330.5836770403685, 3335.0661814691894, 3358.4290670586006, 5315.468453154687, 5355.892882142355, 5366.892662146754, 5375.301210842595, 5389.83830485086, 5386.676799392039, 5397.62216644835, 5409.459054094588, 5439.945600543993, 5460.290162278908, 4945.233488809223, 4996.875078123039, 5014.022265658207, 5047.116754567955, 5047.621428392885, 5004.099262132815, 5060.746962651871, 5070.543651071403, 5076.314697515843, 5081.2886195932415, 4992.251162325662, 5075.416327122372, 5095.490450954893, 5105.285260063594, 5106.285120083191, 5037.1940489521685, 5075.822346217883, 5129.717865517395, 5134.0, 5134.743262836881, 5053.772580233898, 5110.66780659256, 5161.894421229328, 5162.199859021857, 5192.402873669538, 5282.0756367635895, 5320.068987927098, 5393.325834270716, 5503.9174412383845, 5504.0, 6008.309044459856, 6015.849603759897, 6017.63894166347, 6019.969900150515, 6029.397060293979, 6015.969920150415, 6019.849503762397, 6033.064874944391, 6033.3664965178905, 6043.848903777397, 5421.674699518002, 5501.807436739695, 5513.862153446155, 5566.35986861508, 5622.128570071645, 6023.307319658208, 6076.908846367308, 6106.6336019838955, 6119.479844213202, 6120.326764055951, 5940.762369505258, 5948.137520059568, 5948.375420580864, 5950.137230101697, 5957.076653118686, 5731.828045158652, 5833.154192642043, 5839.270091238595, 5883.970580147072, 5916.556258280646, 5838.12428135783, 5840.474357307778, 5846.035404158266, 5847.1229315603, 5848.2689663792025, 5780.826575202751, 5900.321463031721, 5921.111833225051, 5923.822285331361, 5925.851853703605, 4515.0, 4596.287575425815, 4607.14767767964, 4623.53764623535, 4637.489876113625, 4094.4063110849356, 4108.219438306772, 4110.712250142461, 4119.299719047769, 4142.130152667974, 5374.113271310268, 5510.9448905510435, 5592.86017849557, 5597.692126933058, 5603.579731520153, 5941.1385349125, 5994.6403215807195, 6020.578559500793, 6029.668368239789, 6052.848678783065, 5574.554035677136, 5612.0, 5612.410696876769, 5616.466435688603, 5620.494155526022, 5087.440381558025, 5115.053715062725, 5178.352705911761, 5204.297419848348, 5206.947930520646, 6111.728004700595, 6143.56995010345, 6144.938550614526, 6148.292946311142, 6150.985087460608, 6006.8498287541415, 6008.579399441997, 6019.668918209541, 6037.698115094227, 6050.062240352752, 6002.0996850472775, 6013.398660133952, 6127.387261273837, 6138.355472675305, 6142.447179753844, 5863.149843272787, 5904.498117659875, 5910.438508341701, 5920.348761636303, 5920.911186332295, 5956.493698035715, 6009.489193418608, 6016.6690832002905, 6017.187679663364, 6023.30731965812, 5616.803411880564, 5718.942810571841, 5752.07966725322, 5822.272215973004, 5856.033754430471, 5847.532197424111, 5894.233749612523, 5902.881942361215, 5919.526437885045, 5929.377415371497, 5614.5789065821045, 5794.62334948227, 5799.8550036249435, 5813.418658134153, 5821.126830975388, 5700.087985922232, 5791.8552036199435, 5797.507211886868, 5809.767609295581, 5837.562182836219, 5690.032694441872, 5697.601167918206, 5760.855978600569, 5789.797357092481, 5792.884142317214], "unit": "ms", "name": "dojo.html", "value": 5481.463798185825}, {"lowerIsBetter": false, "replicates": [630.5113537008817, 636.8535236895514, 646.3278190681691, 651.2413038809789, 652.6377860287539, 39744.80127599362, 40569.59430405699, 40612.0, 40617.1876562469, 40661.59338406615, 45202.0, 45765.31352029722, 45791.0, 45824.312635310496, 45899.0, 8114.310283625899, 8245.917540824576, 9091.272698184146, 9300.0, 10386.53260603271, 10554.366737995706, 10662.840057399146, 10677.305975111633, 10680.732981675443, 10682.252242343038, 10668.839967400496, 10671.359718416881, 10751.946240268826, 10766.0, 10787.352758834495, 10602.045815876569, 10699.144068474503, 10702.41136737479, 10706.571737130505, 10708.19688523364, 10454.79090418195, 10572.0, 10591.84112238317, 10599.523021463976, 10601.522931468102, 42132.0, 42635.36046959298, 42959.0, 43022.784886075366, 43045.35431968523, 3373.089265898194, 3384.1370450534955, 3387.3733359328603, 3444.50054742061, 3975.105601239698, 32739.6726032739, 32814.83592582046, 33016.174595635064, 33025.83487082573, 33156.0, 4299.226139294926, 4374.803133858984, 4438.3694613239695, 4459.643228541709, 4478.0148367359125, 284091.0, 284206.0, 286428.0, 286950.0, 287724.0, 58670.0, 60471.09293360603, 64088.35911640917, 64472.35527644664, 70931.0, 62492.68753656203, 62830.68584657047, 63071.0, 63117.0, 63172.0, 17932.551686207687, 17977.550561235814, 18088.547786305448, 18142.909285453752, 18155.27378904829, 12654.430550625244, 12679.366031698379, 12701.36493175356, 12718.046146538862, 12731.55439559611, 21105.577888442145, 21382.57234855294, 21422.46443838885, 21475.0, 21475.677864831727, 8007.239312265326, 8222.17778222173, 8257.8348433031, 8385.496870187808, 8399.62201700925, 997.7677568203263, 1038.4911393417322, 1083.4474418046852, 1142.6172232302106, 1146.656003199037, 28773.136805895858, 28798.712012880023, 29480.262993425335, 29515.85242073776, 29750.25624359365, 1162.1690491298593, 1190.2441949362217, 1205.9809461005436, 1232.9321887296285, 1279.9552015679405, 13853.307334633228, 14999.17504537239, 15235.847641523444, 15692.843071569137, 17713.557161071076, 410159.0, 414637.0, 417413.0, 417965.0, 418909.0, 54262.45737542653, 54739.17891231635, 55162.724186379615, 55398.44601554013, 55732.72133639306, 1336.358547897015, 1338.2305174524492, 1450.4198320671605, 1485.8811295096366, 1534.0948840184121, 29796.255093622833, 29989.70010299869, 33827.0, 34596.481052783725, 34719.0, 52356.0, 52394.73802630963, 52452.7377363126, 52581.0, 52859.207111894124, 313076.0, 314177.0, 316184.0, 316742.0, 317635.0, 44185.0, 44446.11107777891, 44993.775031124635, 45393.0, 45621.08757824892, 48469.27296090491, 48617.0, 49060.75469622629, 49273.507264928325, 50316.0, 39931.80034099811, 40769.388459172544, 40841.79579102086, 41646.58353416548, 42001.579984199765, 40897.795511022254, 41757.0, 41848.1630367397, 44904.0, 45231.77384113058, 38644.80677596594, 38982.80508597439, 39228.41157382585, 39276.607233927294, 39381.409278860265, 34437.65562344345, 34768.652313477556, 35123.29753404867, 35345.1163720909, 35742.821285893406, 27218.31954201161, 27751.0, 27767.583486248128, 27886.0, 27894.44211115807], "unit": "ms", "name": "ext.html", "value": 20654.584147152564}, {"lowerIsBetter": false, "replicates": [392.8919547124542, 396.071213005502, 398.04469273743024, 399.26535175277485, 401.7950845069015, 13513.256770877599, 17300.394486192985, 19211.13549890255, 19573.314933977315, 19601.21595136193, 18875.811241887575, 18890.52773680655, 19286.71069933952, 19404.902975485104, 19456.027198640084, 6174.351693072242, 6268.247810262752, 6299.559030867841, 6306.9369306307035, 6322.589031712947, 5189.896202075956, 5345.893082138355, 6183.474404675608, 6273.874522509547, 6279.246490421156, 3885.7279990400684, 3986.3621820508724, 5326.041312563737, 5331.840044798643, 5333.919991200135, 6669.0996715443525, 6938.375546200816, 6938.653067346638, 6968.965155174243, 6969.756058537952, 6553.0, 6730.0, 6739.292374300726, 6744.662766861687, 6747.156605424322, 22490.100395984304, 24458.755412445826, 24533.509329813303, 25015.249542513753, 25941.22176334694, 2553.540362734707, 2565.9101931432497, 2613.9346516337246, 2627.0279996401455, 2667.5065112954167, 15106.39574417022, 15218.771718424232, 15454.536363909101, 15465.458708945132, 15660.843391566052, 2038.7987779130162, 2097.6958341040618, 2121.7772133926023, 2135.540858715368, 2199.373178644095, 68618.0, 76809.0, 77009.8448523267, 77139.22860771377, 77200.61399693022, 16251.349946002027, 16528.25622846975, 16623.750643740354, 16632.0, 16663.91668041652, 26920.192394228205, 27020.729792702215, 27352.31619209496, 27378.315542111606, 27466.862665686545, 9726.854097188549, 9817.312788104908, 9830.606775728891, 9866.358686685342, 9891.653792117242, 8196.811462337928, 8226.341892648574, 8245.13426090264, 8328.08391076981, 8364.707235246737, 8019.7995050123045, 8060.758177254692, 8079.313258372987, 8087.0, 8121.4721043132, 2561.372463746357, 3043.802152860057, 3112.6887311269143, 3147.0558832350202, 3163.3673265347024, 902.0573500691793, 976.2043934193752, 1000.0749306891242, 1002.5288114586133, 1044.9373037617768, 16825.663486730442, 17202.1398930053, 17314.65370692604, 17416.303347866196, 17788.110594470483, 990.980180396388, 1013.1742629756725, 1042.6924057403085, 1049.197364016528, 1078.46615925116, 9298.209652179641, 9713.757156071013, 9986.30095893295, 10407.0, 10407.427591482541, 418196.0, 474429.0, 666555.6722163872, 688380.0, 731681.0, 82358.0, 86867.0, 87448.56275718709, 87841.56079219563, 90678.0, 1196.3659260591726, 1197.3474456421272, 1211.4185191108318, 1216.489074588657, 1238.4488902438509, 15568.688626227638, 15842.12868292255, 15949.087603091148, 15975.840241597436, 16307.510774676779, 37137.0, 37164.0, 37279.6272037287, 37811.81094094512, 38142.237155257295, 50327.49672503228, 51479.485205147466, 51895.48104519057, 53628.46371536235, 54246.72876635592, 9998.550065246936, 10100.090991810479, 10106.747331316776, 10176.542055607664, 10239.692809215736, 17638.88061331936, 17723.0, 18080.0, 18281.634367312847, 18668.159932802784, 14482.420703171754, 14515.05652132608, 14551.708965820413, 15108.773368399263, 15510.069395836286, 14975.775363369341, 15136.54590362291, 15198.392064317746, 15459.768103478233, 15558.144302063496, 15130.243487825785, 15358.462453814063, 15640.983336083118, 15835.445759398366, 16047.03717776937, 9720.951395242979, 9865.654702085392, 9904.009599040039, 10010.749731256778, 10021.699349019542, 10451.581936722447, 10533.4733263335, 12684.429200686176, 15210.315535801137, 15454.150021748463], "unit": "ms", "name": "jquery.html", "value": 10419.676183861575}, {"lowerIsBetter": false, "replicates": [1560.8751299896007, 1604.6389562348465, 1620.8946418482801, 1793.1751394358594, 1897.8102189781016, 7870.173631768661, 8047.396445266614, 8057.113717491071, 8068.717594884173, 8079.91920080799, 7410.888836667455, 7542.132654744706, 7563.584002879839, 7973.521588704682, 8274.669013239478, 2288.39357570244, 2302.7121609798774, 2330.0796185506715, 2332.650102484624, 2333.8366314358, 2316.0, 2323.0707716913203, 2451.44842410458, 2451.9264422067367, 2453.325335532725, 1985.2059176329512, 2028.4421784009369, 2272.0457407888644, 2356.1871154451687, 2373.6558199061124, 2339.5320935812733, 2359.1507057459385, 2382.2376839411395, 2391.6173412254043, 2393.0, 2284.4288927768057, 2285.0288627333316, 2310.0528783198974, 2321.2688003278913, 2321.7446080931086, 8265.669373225064, 8340.165983401672, 8344.916550834474, 8347.874781878276, 8348.373871959566, 4882.048000639877, 4991.875203119915, 4993.825216117455, 4995.275685025651, 4996.550310472075, 3220.6296275928335, 3221.1624977505785, 3269.738420926344, 3278.065751260903, 3315.1380641033265, 1153.532819208222, 1153.6942710181809, 1156.1964434717875, 1192.6958625550517, 1207.1067410116539, 11501.194916355858, 11581.942090289578, 11583.131265155063, 11643.534258629645, 11650.592229271935, 4487.461504619401, 4498.662600304925, 4534.909301814011, 4543.863684089482, 4550.340200670884, 9910.0, 9913.553890074963, 9927.106560409453, 9941.850872236922, 9944.154746846454, 4971.975140124348, 5008.524190201925, 5016.147254966664, 5016.899662006739, 5021.6735912165595, 4499.482559505634, 4561.703489273186, 4564.0, 4564.315352697122, 4573.085382923428, 3842.1163132479687, 3892.591277915835, 3910.413437984268, 3914.412838074312, 3932.980335098306, 1195.462042081067, 1227.9508819647292, 1237.5049980008068, 1239.7148655809215, 1267.7527882063093, 1096.1614365010773, 1101.0750969185922, 1149.2759561476216, 1295.1193188631632, 1394.9930250348684, 7585.241475852481, 7753.302202801775, 7839.137694853562, 7848.568328741974, 7876.842463150705, 935.9672411465566, 955.5652178258875, 1103.4979084516526, 1121.2599684208383, 1181.1750844944581, 6362.522810789117, 6419.871602567922, 6425.646589437532, 6449.419552240321, 6457.031445283151, 9651.131398174199, 10134.594616215269, 10142.746431339128, 10321.63874264397, 10342.172626189888, 10106.898931010743, 10130.189584833195, 10140.0, 10140.49297535135, 10145.94927025375, 7600.201978792147, 7897.131315555399, 7898.210178982055, 7903.0, 7906.327962123284, 7269.091363579552, 7731.072271327476, 7732.226777322448, 7746.0317460317465, 7751.806204844924, 8789.472631642122, 8989.41568798026, 9060.320475964198, 9072.319576031692, 9183.494907780136, 9063.184313411824, 9111.772205694911, 9120.361574689709, 9340.159385655052, 9417.62329506812, 7296.489245752747, 7403.296686814744, 7406.888896666446, 7408.407327413686, 7410.925890741024, 7838.686452541834, 7886.763397098096, 7915.802104947423, 7959.960200199193, 7971.760847174594, 6743.2582415935185, 7400.703971841066, 7530.811729706801, 7594.468387212842, 7675.577843218453, 6867.969804529161, 7636.923630763844, 7645.4648174629465, 7672.80817979555, 7792.649330780015, 7774.183710710294, 7843.607819608883, 7847.0, 7847.607619618882, 7847.9607601961625, 6808.38724514796, 6996.790096297119, 7048.612326322102, 7088.397486213524, 7103.076600041962, 6898.931010689829, 6902.620355880475, 6909.44724422035, 6924.272951340238, 6954.026436298821], "unit": "ms", "name": "mootools.html", "value": 4765.326434648756}, {"lowerIsBetter": false, "replicates": [373.2646686028524, 373.69730518280176, 374.5280946008029, 376.77205290799066, 383.81576843115306, 6075.51395888329, 6109.35851735568, 6121.296050954142, 6154.446099851012, 6220.098085777559, 5828.679422631753, 5941.316748573915, 6004.399560043993, 6110.327863934964, 6133.6626485543275, 4741.099191153687, 4771.33201351811, 4773.641976851733, 4778.4265888093305, 4791.880202994918, 4586.495485496593, 4788.712677239359, 4794.208955522335, 4796.616270698353, 4800.087983283182, 4616.676832621718, 4660.6504512161555, 4723.984343366193, 4740.146773580754, 4751.928721069186, 4712.269598212282, 4729.266963620645, 4729.408823897013, 4729.527047295243, 4735.550122738335, 4221.6833737469815, 4226.281532139544, 4226.619604235603, 4233.089885674594, 4236.68224883135, 5754.74103665336, 5838.6204896682, 5839.182514447981, 5845.5908086433965, 5852.034414321632, 5541.27963364764, 5549.556035517149, 5560.304961879765, 5560.944390556083, 5561.860953476155, 6451.1936007999, 6455.0, 6458.192725909262, 6460.903086453707, 6465.321141280145, 4711.646626502992, 4715.221988371914, 4718.363020992191, 4726.196546587088, 4737.336772851803, 6519.771807986745, 6688.799336019927, 6722.394984451423, 6735.057092007123, 6737.157855268091, 4632.0, 4639.930401043987, 4645.465771436328, 4651.744154071491, 4656.115338085753, 4700.482946875841, 4703.6942598730975, 4706.529347065334, 4707.223308154184, 4707.31743897133, 5351.464853514617, 5417.756200970965, 5422.376426710979, 5435.1847222916085, 5440.183972404171, 6524.151860258136, 6525.706343214567, 6534.411902928759, 6539.149910511698, 6540.215174179129, 1667.624784423495, 1688.139049084951, 1688.5440930948575, 1690.0789069956902, 1691.5940174358311, 1134.6085600467825, 1142.725745820997, 1145.799485090106, 1155.0470861539095, 1166.445938179358, 6252.968735156295, 6255.186825712719, 6259.6870156492, 6262.718177682015, 6266.592671476339, 6550.0, 6755.864882702417, 6764.680887226944, 6765.255821859591, 6767.221769496472, 6125.663088530085, 6225.6264624121795, 6318.336574659686, 6322.557420980487, 6340.936590634127, 3616.764910280823, 3646.1431563582537, 3655.908602284964, 3658.2500587379523, 3668.871589494355, 6802.319768023158, 6951.0, 6953.826154346182, 6958.130233720785, 6959.756408525677, 6912.447004239649, 6931.514793964475, 6933.2720064393525, 6948.096747422803, 6958.503921656868, 6895.931040689529, 6911.03245545624, 6950.756723514653, 6971.407430368374, 6974.407175390149, 6654.268030516542, 6788.59268443895, 6795.626240556817, 6797.93202067973, 6804.591724496546, 6693.196816382066, 6696.732130714911, 6706.094677218513, 6709.597424154566, 6712.563683360566, 6956.5478243913985, 6967.616781077089, 6979.0, 6979.232284448808, 6985.650717464208, 4680.4149481314835, 4710.034442939258, 4737.0, 4742.762861856824, 4746.905061898674, 6763.391294783493, 6777.6272305023695, 6778.356056174655, 6781.728730850711, 6788.083608712958, 6617.07360969455, 6619.569727967667, 6627.668616569249, 6628.038934354588, 6629.535932484872, 6441.581297215666, 6596.2744098148205, 6601.339866013553, 6608.867822643617, 6673.733050677918, 6550.443212327005, 6554.508411869034, 6556.0493728408155, 6562.245341785756, 6563.9343606563325, 6673.132492775908, 6674.666266686743, 6677.899831502435, 6683.331666833278, 6683.498737594603, 6303.716332764945, 6490.935090649033, 6505.316941721051, 6530.67346632676, 6544.54188206821], "unit": "ms", "name": "prototype.html", "value": 4970.291138637297}, {"lowerIsBetter": false, "replicates": [735.5623404074573, 784.2627929746039, 842.1704620948368, 914.3782228084899, 931.9906800931989, 13337.399817008234, 13368.866311336884, 13669.316534173277, 13684.452621895125, 13743.725125497496, 12719.30043847588, 12788.424520896559, 12875.806862897063, 12910.93544532276, 13252.867471325284, 746.7535713214653, 750.6546988385322, 828.9544075075869, 847.2501835875264, 890.2877697841701, 894.8210357928408, 903.7695387676133, 911.116217269251, 912.2975309012056, 913.324140136301, 925.1673493855517, 946.1153821177187, 946.8248374050822, 947.1948843483053, 947.8388673925449, 774.7094839435183, 788.2432864450135, 920.4891285336636, 941.0307383395045, 942.7030485397078, 691.325957191734, 693.8855088910324, 701.130598058409, 701.7333413302963, 702.199492578461, 13957.58127256184, 13978.440862365493, 13980.860191398058, 13998.440062397594, 14026.92986535071, 12651.493940242379, 13529.932350338186, 13618.250996195206, 13691.246981416018, 13691.726165476734, 10149.949250253701, 10179.694609161663, 10215.540300686487, 10278.229132814993, 10342.276040677156, 3884.4173373993845, 3951.8616848410456, 3958.782266975344, 3962.2075584883137, 3966.1671049079728, 46283.0, 46578.53421465776, 48428.75785621049, 48826.26760598594, 49005.26492102585, 9858.570507276405, 10427.478626068667, 10822.296550724177, 10843.186760992958, 10904.61833835812, 18917.7162342565, 18941.0, 18948.24207031731, 18969.525761856064, 19316.227350905807, 7909.3277071449575, 7983.0, 7990.84018319642, 8024.398170137263, 8227.794305142299, 4460.264056430718, 4516.6160876325885, 4523.163214805271, 4531.13908357411, 4669.066186762661, 3317.1209629448217, 3330.8501117449773, 3333.399988002183, 3340.883069092619, 3343.699067083974, 571.8598943258928, 578.1645522220351, 582.3332284534184, 587.3069777662314, 597.8774351258069, 664.2527156948433, 686.993130068703, 690.4786885901112, 707.487071872888, 712.2201189697273, 9216.815663686688, 9559.06195281816, 9840.392544044578, 9862.704118876445, 9873.111419972238, 653.2520264297448, 684.1619016704498, 696.3697853442643, 697.693015073366, 713.2653367031966, 4174.248635245685, 4246.150769845982, 4262.232798096373, 4385.6710746694125, 4449.28811390176, 58039.709801451565, 58138.418615814146, 58354.0, 58614.41385586175, 60884.69557652184, 52369.21446178311, 53385.466145338825, 53618.19572706413, 54326.0, 55862.441375585724, 48646.270305945436, 48864.26703599378, 49519.50480495221, 49526.75236623866, 49718.751406242736, 9182.724518264462, 9329.067093290616, 9439.386439881386, 9510.572024258787, 9669.854952175863, 35929.82035089912, 36526.26947460983, 37902.8104859474, 38230.23539529138, 38299.0, 46475.76762116168, 46955.0, 47182.0, 47502.76248618873, 47612.761936190094, 11653.242539234923, 11734.765304694029, 12014.819777703167, 12300.0, 12331.876681233432, 13170.209787412787, 13190.208587484782, 13225.40485678166, 13245.0, 13269.933650331686, 12340.197887137307, 12423.31671758026, 12505.187162834387, 12563.623091307276, 12744.42650080767, 12101.152919295917, 12479.251244925334, 12485.375731213222, 12693.365331733192, 12755.80866287025, 9084.214557129802, 11464.25482343645, 11680.532778688757, 11692.0, 11951.282923024646, 10444.0, 11070.0, 11111.72220694489, 11118.49966751482, 11206.887931120911, 10119.59521619127, 10430.426326552113, 10547.156227501628, 10559.472026398804, 10630.893691062991], "unit": "ms", "name": "yui.html", "value": 6695.570048906094}], "name": "dromaeo_css", "value": 7562.725489635318}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 103.0, 110.0, 108.0, 109.0, 99.0, 110.0, 109.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 107.7}, {"lowerIsBetter": true, "replicates": [148.0, 121.0, 143.0, 164.0, 124.0, 149.0, 149.0, 124.0, 154.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 139.9}, {"lowerIsBetter": true, "replicates": [160.0, 158.0, 160.0, 158.0, 160.0, 160.0, 160.0, 158.0, 159.0, 157.0], "unit": "ms", "name": "audio-dft", "value": 159.0}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 72.0, 156.0, 70.0, 71.0, 72.0, 71.0, 152.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 87.5}, {"lowerIsBetter": true, "replicates": [91.0, 91.0, 136.0, 92.0, 91.0, 91.0, 138.0, 92.0, 91.0, 139.0], "unit": "ms", "name": "audio-oscillator", "value": 105.2}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 108.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 108.9}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [56.0, 59.0, 57.0, 58.0, 59.0, 56.0, 59.0, 58.0, 55.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 64.0, 64.0, 64.0, 64.0, 63.0, 63.0, 64.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.6}, {"lowerIsBetter": true, "replicates": [78.0, 76.0, 79.0, 78.0, 86.0, 78.0, 77.0, 79.0, 78.0, 79.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 78.8}, {"lowerIsBetter": true, "replicates": [129.0, 125.0, 111.0, 116.0, 109.0, 115.0, 116.0, 111.0, 113.0, 128.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 117.3}, {"lowerIsBetter": true, "replicates": [132.0, 143.0, 144.0, 142.0, 153.0, 133.0, 149.0, 134.0, 142.0, 131.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 140.3}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 65.0, 66.0, 64.0, 64.0, 65.0, 63.0, 64.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.3}], "name": "kraken", "value": 1470.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [172.1170395869191], "unit": "score", "name": "Richards", "value": 205.10462}, {"lowerIsBetter": false, "replicates": [164.82610845557937], "unit": "score", "name": "DeltaBlue", "value": 401.137906}, {"lowerIsBetter": false, "replicates": [278.473962684489], "unit": "score", "name": "Encrypt", "value": 955.8559709999997}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [962.4639076034649], "unit": "score", "name": "RayTrace", "value": 768.8485710000002}, {"lowerIsBetter": false, "replicates": [539.3743257820928], "unit": "score", "name": "Earley", "value": 1235.6224020000004}, {"lowerIsBetter": false, "replicates": [10541.666666666666], "unit": "score", "name": "Boyer", "value": 63.22178656126487}, {"lowerIsBetter": false, "replicates": [24357.14285714286], "unit": "score", "name": "RegExp", "value": 37.40114369501463}, {"lowerIsBetter": false, "replicates": [517.063081695967], "unit": "score", "name": "Splay", "value": 157.6035939999999}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 23229.2265389747}]} 13:04:46 INFO - RETURN: dromaeo_css: 7562.73 13:04:46 INFO - RETURN: kraken: 1470.70 13:04:46 INFO - RETURN: v8_7: 23229.23 13:04:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23229.23"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1470.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7562.73"}}} 13:04:46 INFO - Return code: 0 13:04:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:04:46 INFO - # TBPL SUCCESS # 13:04:46 INFO - Running post-action listener: _resource_record_post_action 13:04:46 INFO - Running post-run listener: _resource_record_post_run 13:04:48 INFO - Total resource usage - Wall time: 1221s; CPU: 13.0%; Read bytes: 315392; Write bytes: 516263936; Read time: 68; Write time: 414324 13:04:48 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 250748928; Read time: 0; Write time: 257952 13:04:48 INFO - run-tests - Wall time: 1207s; CPU: 13.0%; Read bytes: 315392; Write bytes: 265515008; Read time: 68; Write time: 156372 13:04:48 INFO - Running post-run listener: _upload_blobber_files 13:04:48 INFO - Blob upload gear active. 13:04:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:04:48 INFO - Copying logs to upload dir... 13:04:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1251.576144 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-02-11 13:04:48.030992) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-11 13:04:48.034664) ========= 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=ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455213754/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009972 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455213754/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-11 13:04:48.085658) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 13:04:48.086080) ========= 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=ed14279e38b05397cf4aa391000001a4-1455223433.833109-718097679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 13:04:48.136484) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 13:04:48.136834) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 13:04:48.137199) ========= ========= Total master_lag: 0.28 =========