builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1453723704.57 results: success (0) buildid: 20160118120031 builduid: 818fd5d38f994d05b8cc299dc07eda1c revision: f84fcce02b11 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:24.572485) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:24.572910) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:24.573190) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005925 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:24.595909) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:24.596290) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:24.609367) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:24.609685) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:24.659149) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:24.659462) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:24.659808) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:24.660077) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 04:08:24-- 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% 209M=0s 2016-01-25 04:08:25 (209 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163168 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:24.835709) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:24.836017) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022866 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:24.886012) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-25 04:08:24.886394) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f84fcce02b11 --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 f84fcce02b11 --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=9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 04:08:25,171 Setting DEBUG logging. 2016-01-25 04:08:25,171 attempt 1/10 2016-01-25 04:08:25,171 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f84fcce02b11?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 04:08:26,213 unpacking tar archive at: mozilla-beta-f84fcce02b11/testing/mozharness/ program finished with exit code 0 elapsedTime=1.360327 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-25 04:08:26.259742) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:26.260096) ========= echo f84fcce02b11 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f84fcce02b11'] 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=9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False f84fcce02b11 program finished with exit code 0 elapsedTime=0.004633 script_repo_revision: 'f84fcce02b11' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:26.311280) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:26.311821) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:26.323795) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-01-25 04:08:26.324406) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:08:26 INFO - MultiFileLogger online at 20160125 04:08:26 in /builds/slave/test-pgo 04:08:26 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 04:08:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:08:26 INFO - {'append_to_log': False, 04:08:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:08:26 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:08:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:08:26 INFO - 'branch': 'Mozilla-Beta', 04:08:26 INFO - 'buildbot_json_path': 'buildprops.json', 04:08:26 INFO - 'config_files': ('talos/linux_config.py',), 04:08:26 INFO - 'default_actions': ('clobber', 04:08:26 INFO - 'read-buildbot-config', 04:08:26 INFO - 'download-and-extract', 04:08:26 INFO - 'populate-webroot', 04:08:26 INFO - 'create-virtualenv', 04:08:26 INFO - 'install', 04:08:26 INFO - 'run-tests'), 04:08:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:08:26 INFO - 'download_minidump_stackwalk': True, 04:08:26 INFO - 'download_symbols': 'ondemand', 04:08:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:08:26 INFO - 'tooltool.py': '/tools/tooltool.py', 04:08:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:08:26 INFO - '/tools/misc-python/virtualenv.py')}, 04:08:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:08:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:08:26 INFO - 'installer_path': 'installer.exe', 04:08:26 INFO - 'log_level': 'info', 04:08:26 INFO - 'log_name': 'talos', 04:08:26 INFO - 'log_to_console': True, 04:08:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:08:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:08:26 INFO - 'opt_config_files': (), 04:08:26 INFO - 'pip_index': False, 04:08:26 INFO - 'sps_profile': False, 04:08:26 INFO - 'sps_profile_interval': 0, 04:08:26 INFO - 'suite': 'dromaeojs', 04:08:26 INFO - 'system_bits': '32', 04:08:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:08:26 INFO - 'title': 'talos-linux64-ix-022', 04:08:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:08:26 INFO - 'use_talos_json': True, 04:08:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:08:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:08:26 INFO - 'work_dir': 'build'} 04:08:26 INFO - ##### 04:08:26 INFO - ##### Running clobber step. 04:08:26 INFO - ##### 04:08:26 INFO - Running pre-action listener: _resource_record_pre_action 04:08:26 INFO - Running main action method: clobber 04:08:26 INFO - rmtree: /builds/slave/test-pgo/build 04:08:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:08:27 INFO - Running post-action listener: _resource_record_post_action 04:08:27 INFO - ##### 04:08:27 INFO - ##### Running read-buildbot-config step. 04:08:27 INFO - ##### 04:08:27 INFO - Running pre-action listener: _resource_record_pre_action 04:08:27 INFO - Running main action method: read_buildbot_config 04:08:27 INFO - Using buildbot properties: 04:08:27 INFO - { 04:08:27 INFO - "properties": { 04:08:27 INFO - "buildnumber": 83, 04:08:27 INFO - "product": "firefox", 04:08:27 INFO - "script_repo_revision": "production", 04:08:27 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 04:08:27 INFO - "repository": "", 04:08:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 04:08:27 INFO - "buildid": "20160118120031", 04:08:27 INFO - "slavename": "talos-linux64-ix-022", 04:08:27 INFO - "pgo_build": "True", 04:08:27 INFO - "basedir": "/builds/slave/test-pgo", 04:08:27 INFO - "project": "", 04:08:27 INFO - "platform": "ubuntu64_hw", 04:08:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:08:27 INFO - "slavebuilddir": "test", 04:08:27 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 04:08:27 INFO - "branch": "mozilla-beta", 04:08:27 INFO - "repo_path": "releases/mozilla-beta", 04:08:27 INFO - "stage_platform": "linux64-pgo", 04:08:27 INFO - "builduid": "818fd5d38f994d05b8cc299dc07eda1c", 04:08:27 INFO - "revision": "f84fcce02b11" 04:08:27 INFO - }, 04:08:27 INFO - "sourcestamp": { 04:08:27 INFO - "repository": "", 04:08:27 INFO - "hasPatch": false, 04:08:27 INFO - "project": "", 04:08:27 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 04:08:27 INFO - "changes": [ 04:08:27 INFO - { 04:08:27 INFO - "category": null, 04:08:27 INFO - "files": [ 04:08:27 INFO - { 04:08:27 INFO - "url": null, 04:08:27 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.tar.bz2" 04:08:27 INFO - } 04:08:27 INFO - ], 04:08:27 INFO - "repository": "", 04:08:27 INFO - "rev": "f84fcce02b11", 04:08:27 INFO - "who": "sendchange", 04:08:27 INFO - "when": 1453155801, 04:08:27 INFO - "number": 7475630, 04:08:27 INFO - "comments": "Bug 1233982 - Do not fetch autofill icons from the network. r=adw a=ritu CLOSED TREE", 04:08:27 INFO - "project": "", 04:08:27 INFO - "at": "Mon 18 Jan 2016 14:23:21", 04:08:27 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 04:08:27 INFO - "revlink": "", 04:08:27 INFO - "properties": [ 04:08:27 INFO - [ 04:08:27 INFO - "buildid", 04:08:27 INFO - "20160118120031", 04:08:27 INFO - "Change" 04:08:27 INFO - ], 04:08:27 INFO - [ 04:08:27 INFO - "builduid", 04:08:27 INFO - "818fd5d38f994d05b8cc299dc07eda1c", 04:08:27 INFO - "Change" 04:08:27 INFO - ], 04:08:27 INFO - [ 04:08:27 INFO - "pgo_build", 04:08:27 INFO - "True", 04:08:27 INFO - "Change" 04:08:27 INFO - ] 04:08:27 INFO - ], 04:08:27 INFO - "revision": "f84fcce02b11" 04:08:27 INFO - } 04:08:27 INFO - ], 04:08:27 INFO - "revision": "f84fcce02b11" 04:08:27 INFO - } 04:08:27 INFO - } 04:08:27 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.tar.bz2. 04:08:27 INFO - Running post-action listener: _resource_record_post_action 04:08:27 INFO - ##### 04:08:27 INFO - ##### Running download-and-extract step. 04:08:27 INFO - ##### 04:08:27 INFO - Running pre-action listener: _resource_record_pre_action 04:08:27 INFO - Running main action method: download_and_extract 04:08:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:08:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:27 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/test_packages.json 04:08:27 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:08:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:08:27 INFO - Downloaded 1270 bytes. 04:08:27 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:08:27 INFO - Using the following test package requirements: 04:08:27 INFO - {u'common': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 04:08:27 INFO - u'cppunittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:27 INFO - u'firefox-44.0.en-US.linux-x86_64.cppunittest.tests.zip'], 04:08:27 INFO - u'jittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:27 INFO - u'jsshell-linux-x86_64.zip'], 04:08:27 INFO - u'mochitest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:27 INFO - u'firefox-44.0.en-US.linux-x86_64.mochitest.tests.zip'], 04:08:27 INFO - u'mozbase': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 04:08:27 INFO - u'reftest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:27 INFO - u'firefox-44.0.en-US.linux-x86_64.reftest.tests.zip'], 04:08:27 INFO - u'talos': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:27 INFO - u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'], 04:08:27 INFO - u'web-platform': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:27 INFO - u'firefox-44.0.en-US.linux-x86_64.web-platform.tests.zip'], 04:08:27 INFO - u'webapprt': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 04:08:27 INFO - u'xpcshell': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:27 INFO - u'firefox-44.0.en-US.linux-x86_64.xpcshell.tests.zip']} 04:08:27 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:08:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:27 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.common.tests.zip 04:08:27 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 04:08:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:08:27 INFO - Downloaded 22573307 bytes. 04:08:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:08:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 04:08:27 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:08:28 INFO - Return code: 0 04:08:28 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:08:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:28 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.common.tests.zip 04:08:28 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 04:08:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:08:28 INFO - Downloaded 22573307 bytes. 04:08:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:08:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 04:08:28 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:08:30 INFO - Return code: 0 04:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:30 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 04:08:30 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 04:08:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:08:30 INFO - Downloaded 11131970 bytes. 04:08:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 04:08:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 04:08:30 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:08:30 INFO - Return code: 0 04:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:30 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.tar.bz2 04:08:30 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2 04:08:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:08:31 INFO - Downloaded 56626174 bytes. 04:08:31 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.tar.bz2 04:08:31 INFO - mkdir: /builds/slave/test-pgo/properties 04:08:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:08:31 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:08:31 INFO - Contents: 04:08:31 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.tar.bz2 04:08:31 INFO - Running post-action listener: _resource_record_post_action 04:08:31 INFO - Running post-action listener: set_extra_try_arguments 04:08:31 INFO - ##### 04:08:31 INFO - ##### Running populate-webroot step. 04:08:31 INFO - ##### 04:08:31 INFO - Running pre-action listener: _resource_record_pre_action 04:08:31 INFO - Running main action method: populate_webroot 04:08:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:08:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:08:31 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:08:31 INFO - '../fennec_ids.txt'], 04:08:31 INFO - 'tests': ['tcheck2']}, 04:08:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:08:31 INFO - '--tppagecycles', 04:08:31 INFO - '7'], 04:08:31 INFO - 'tests': ['tsvgm']}}, 04:08:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:08:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:08:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:08:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:08:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:08:31 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:08:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:31 INFO - 'talos_options': ['--e10s'], 04:08:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:31 INFO - 'tests': ['damp', 'tps']}, 04:08:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:31 INFO - 'talos_options': ['--e10s'], 04:08:31 INFO - 'tests': ['damp', 'tps']}, 04:08:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:08:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:08:31 INFO - 'other': {'tests': ['a11yr', 04:08:31 INFO - 'ts_paint', 04:08:31 INFO - 'tpaint', 04:08:31 INFO - 'sessionrestore', 04:08:31 INFO - 'sessionrestore_no_auto_restore']}, 04:08:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:08:31 INFO - 'tests': ['a11yr', 04:08:31 INFO - 'ts_paint', 04:08:31 INFO - 'tpaint', 04:08:31 INFO - 'sessionrestore', 04:08:31 INFO - 'sessionrestore_no_auto_restore']}, 04:08:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:08:31 INFO - 'tests': ['a11yr', 04:08:31 INFO - 'ts_paint', 04:08:31 INFO - 'tpaint', 04:08:31 INFO - 'sessionrestore', 04:08:31 INFO - 'sessionrestore_no_auto_restore']}, 04:08:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:08:31 INFO - 'tests': ['a11yr', 04:08:31 INFO - 'ts_paint', 04:08:31 INFO - 'tpaint', 04:08:31 INFO - 'sessionrestore', 04:08:31 INFO - 'sessionrestore_no_auto_restore']}, 04:08:31 INFO - 'other_l64': {'tests': ['a11yr', 04:08:31 INFO - 'ts_paint', 04:08:31 INFO - 'tpaint', 04:08:31 INFO - 'sessionrestore', 04:08:31 INFO - 'sessionrestore_no_auto_restore']}, 04:08:31 INFO - 'other_nol64': {'tests': ['a11yr', 04:08:31 INFO - 'ts_paint', 04:08:31 INFO - 'tpaint', 04:08:31 INFO - 'sessionrestore', 04:08:31 INFO - 'sessionrestore_no_auto_restore']}, 04:08:31 INFO - 'svgr': {'tests': ['tsvgx', 04:08:31 INFO - 'tsvgr_opacity', 04:08:31 INFO - 'tart', 04:08:31 INFO - 'tscrollx', 04:08:31 INFO - 'cart']}, 04:08:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:08:31 INFO - 'tests': ['tsvgx', 04:08:31 INFO - 'tsvgr_opacity', 04:08:31 INFO - 'tart', 04:08:31 INFO - 'tscrollx', 04:08:31 INFO - 'cart']}, 04:08:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:31 INFO - 'tests': ['tp5o']}, 04:08:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:31 INFO - 'talos_options': ['--e10s'], 04:08:31 INFO - 'tests': ['tp5o']}, 04:08:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:31 INFO - 'talos_options': ['--xperf_path', 04:08:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:31 INFO - 'tests': ['tp5n']}, 04:08:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:31 INFO - 'talos_options': ['--e10s', 04:08:31 INFO - '--xperf_path', 04:08:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:31 INFO - 'tests': ['tp5n']}}, 04:08:31 INFO - 'talos.zip': {'path': '', 04:08:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:08:31 INFO - Running post-action listener: _resource_record_post_action 04:08:31 INFO - ##### 04:08:31 INFO - ##### Running create-virtualenv step. 04:08:31 INFO - ##### 04:08:31 INFO - Running pre-action listener: _resource_record_pre_action 04:08:31 INFO - Running main action method: create_virtualenv 04:08:31 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:08:31 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 04:08:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:08:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:08:31 INFO - Using real prefix '/usr' 04:08:31 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:08:32 INFO - Installing distribute.............................................................................................................................................................................................done. 04:08:34 INFO - Installing pip.................done. 04:08:34 INFO - Return code: 0 04:08:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:08:34 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')]} 04:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:34 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')]} 04:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff517169f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f8600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2187350>, '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 0x2188250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21886e0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973', '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 04:08:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 04:08:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:08:34 INFO - Using env: {'DISPLAY': ':0', 04:08:34 INFO - 'HOME': '/home/cltbld', 04:08:34 INFO - 'LANG': 'en_US.UTF-8', 04:08:34 INFO - 'LANGUAGE': 'en_US:en', 04:08:34 INFO - 'LOGNAME': 'cltbld', 04:08:34 INFO - 'MAIL': '/var/mail/cltbld', 04:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:34 INFO - 'MOZ_NO_REMOTE': '1', 04:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:34 INFO - 'NO_EM_RESTART': '1', 04:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:34 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:34 INFO - 'SHELL': '/bin/bash', 04:08:34 INFO - 'SHLVL': '1', 04:08:34 INFO - 'TERM': 'linux', 04:08:34 INFO - 'TMOUT': '86400', 04:08:34 INFO - 'USER': 'cltbld', 04:08:34 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973', 04:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:34 INFO - '_': '/tools/buildbot/bin/python'} 04:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:34 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 04:08:34 INFO - Cleaning up... 04:08:34 INFO - Return code: 0 04:08:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:08:34 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')]} 04:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:34 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')]} 04:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff517169f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f8600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2187350>, '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 0x2188250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21886e0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973', '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 04:08:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 04:08:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:08:34 INFO - Using env: {'DISPLAY': ':0', 04:08:34 INFO - 'HOME': '/home/cltbld', 04:08:34 INFO - 'LANG': 'en_US.UTF-8', 04:08:34 INFO - 'LANGUAGE': 'en_US:en', 04:08:34 INFO - 'LOGNAME': 'cltbld', 04:08:34 INFO - 'MAIL': '/var/mail/cltbld', 04:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:34 INFO - 'MOZ_NO_REMOTE': '1', 04:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:34 INFO - 'NO_EM_RESTART': '1', 04:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:34 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:34 INFO - 'SHELL': '/bin/bash', 04:08:34 INFO - 'SHLVL': '1', 04:08:34 INFO - 'TERM': 'linux', 04:08:34 INFO - 'TMOUT': '86400', 04:08:34 INFO - 'USER': 'cltbld', 04:08:34 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973', 04:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:34 INFO - '_': '/tools/buildbot/bin/python'} 04:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:34 INFO - Downloading/unpacking psutil>=0.7.1 04:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:36 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:08:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:08:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:08:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:36 INFO - Installing collected packages: psutil 04:08:36 INFO - Running setup.py install for psutil 04:08:36 INFO - building 'psutil._psutil_linux' extension 04:08:36 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 04:08:36 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 04:08:36 INFO - building 'psutil._psutil_posix' extension 04:08:36 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 04:08:37 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 04:08:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:37 INFO - Successfully installed psutil 04:08:37 INFO - Cleaning up... 04:08:37 INFO - Return code: 0 04:08:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:37 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff517169f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f8600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2187350>, '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 0x2188250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21886e0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973', '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 04:08:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 04:08:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:08:37 INFO - Using env: {'DISPLAY': ':0', 04:08:37 INFO - 'HOME': '/home/cltbld', 04:08:37 INFO - 'LANG': 'en_US.UTF-8', 04:08:37 INFO - 'LANGUAGE': 'en_US:en', 04:08:37 INFO - 'LOGNAME': 'cltbld', 04:08:37 INFO - 'MAIL': '/var/mail/cltbld', 04:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:37 INFO - 'MOZ_NO_REMOTE': '1', 04:08:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:37 INFO - 'NO_EM_RESTART': '1', 04:08:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:37 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:37 INFO - 'SHELL': '/bin/bash', 04:08:37 INFO - 'SHLVL': '1', 04:08:37 INFO - 'TERM': 'linux', 04:08:37 INFO - 'TMOUT': '86400', 04:08:37 INFO - 'USER': 'cltbld', 04:08:37 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973', 04:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:37 INFO - '_': '/tools/buildbot/bin/python'} 04:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:08:37 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 04:08:37 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 04:08:37 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 04:08:37 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 04:08:37 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 04:08:37 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 04:08:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:08:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:08:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:08:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:08:39 INFO - Installing collected packages: mozsystemmonitor 04:08:39 INFO - Running setup.py install for mozsystemmonitor 04:08:39 INFO - Successfully installed mozsystemmonitor 04:08:39 INFO - Cleaning up... 04:08:39 INFO - Return code: 0 04:08:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:08: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')]} 04:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08: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')]} 04:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff517169f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f8600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2187350>, '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 0x2188250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21886e0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973', '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 04:08:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 04:08:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:08:39 INFO - Using env: {'DISPLAY': ':0', 04:08:39 INFO - 'HOME': '/home/cltbld', 04:08:39 INFO - 'LANG': 'en_US.UTF-8', 04:08:39 INFO - 'LANGUAGE': 'en_US:en', 04:08:39 INFO - 'LOGNAME': 'cltbld', 04:08:39 INFO - 'MAIL': '/var/mail/cltbld', 04:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:39 INFO - 'MOZ_NO_REMOTE': '1', 04:08:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:39 INFO - 'NO_EM_RESTART': '1', 04:08:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:39 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:39 INFO - 'SHELL': '/bin/bash', 04:08:39 INFO - 'SHLVL': '1', 04:08:39 INFO - 'TERM': 'linux', 04:08:39 INFO - 'TMOUT': '86400', 04:08:39 INFO - 'USER': 'cltbld', 04:08:39 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973', 04:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:39 INFO - '_': '/tools/buildbot/bin/python'} 04:08:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:39 INFO - Downloading/unpacking blobuploader==1.2.4 04:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:41 INFO - Downloading blobuploader-1.2.4.tar.gz 04:08:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:08:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:08:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:08:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:08:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:42 INFO - Downloading docopt-0.6.1.tar.gz 04:08:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:08:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:08:42 INFO - Installing collected packages: blobuploader, requests, docopt 04:08:42 INFO - Running setup.py install for blobuploader 04:08:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:08:42 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:08:42 INFO - Running setup.py install for requests 04:08:42 INFO - Running setup.py install for docopt 04:08:42 INFO - Successfully installed blobuploader requests docopt 04:08:42 INFO - Cleaning up... 04:08:42 INFO - Return code: 0 04:08:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff517169f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f8600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2187350>, '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 0x2188250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21886e0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973', '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 04:08:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:08:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:08:42 INFO - Using env: {'DISPLAY': ':0', 04:08:42 INFO - 'HOME': '/home/cltbld', 04:08:42 INFO - 'LANG': 'en_US.UTF-8', 04:08:42 INFO - 'LANGUAGE': 'en_US:en', 04:08:42 INFO - 'LOGNAME': 'cltbld', 04:08:42 INFO - 'MAIL': '/var/mail/cltbld', 04:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:42 INFO - 'MOZ_NO_REMOTE': '1', 04:08:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:42 INFO - 'NO_EM_RESTART': '1', 04:08:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:42 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:42 INFO - 'SHELL': '/bin/bash', 04:08:42 INFO - 'SHLVL': '1', 04:08:42 INFO - 'TERM': 'linux', 04:08:42 INFO - 'TMOUT': '86400', 04:08:42 INFO - 'USER': 'cltbld', 04:08:42 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973', 04:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:42 INFO - '_': '/tools/buildbot/bin/python'} 04:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:08:42 INFO - Running setup.py (path:/tmp/pip-yHbDoN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:08:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:08:42 INFO - Running setup.py (path:/tmp/pip-BWYpJH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:08:43 INFO - Running setup.py (path:/tmp/pip-YqhFLz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:08:43 INFO - Running setup.py (path:/tmp/pip-vlPne6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:08:43 INFO - Running setup.py (path:/tmp/pip-1sVHt7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:08:43 INFO - Running setup.py (path:/tmp/pip-BdqRva-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:08:43 INFO - Running setup.py (path:/tmp/pip-CYNK51-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:08:43 INFO - Running setup.py (path:/tmp/pip-lQWbob-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:08:43 INFO - Running setup.py (path:/tmp/pip-B33FcK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:08:43 INFO - Running setup.py (path:/tmp/pip-nqujbe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:08:43 INFO - Running setup.py (path:/tmp/pip-SUXlX7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:08:43 INFO - Running setup.py (path:/tmp/pip-tiOCyH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:08:43 INFO - Running setup.py (path:/tmp/pip-CGJ7F2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:08:43 INFO - Running setup.py (path:/tmp/pip-qtqQ4K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:08:43 INFO - Running setup.py (path:/tmp/pip-rnqQbg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:08:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:08:43 INFO - Running setup.py (path:/tmp/pip-93fdRV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:08:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:08:44 INFO - Running setup.py (path:/tmp/pip-0Can3z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:08:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:08:44 INFO - Running setup.py install for manifestparser 04:08:44 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:08:44 INFO - Running setup.py install for mozcrash 04:08:44 INFO - Running setup.py install for mozdebug 04:08:44 INFO - Running setup.py install for mozdevice 04:08:44 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:08:44 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:08:44 INFO - Running setup.py install for mozfile 04:08:44 INFO - Running setup.py install for mozhttpd 04:08:44 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:08:44 INFO - Running setup.py install for mozinfo 04:08:44 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:08:44 INFO - Running setup.py install for mozInstall 04:08:44 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:08:44 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:08:44 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:08:44 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:08:44 INFO - Running setup.py install for mozleak 04:08:45 INFO - Running setup.py install for mozlog 04:08:45 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:08:45 INFO - Running setup.py install for moznetwork 04:08:45 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:08:45 INFO - Running setup.py install for mozprocess 04:08:45 INFO - Running setup.py install for mozprofile 04:08:45 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:08:45 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:08:45 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:08:45 INFO - Running setup.py install for mozrunner 04:08:45 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:08:45 INFO - Running setup.py install for mozscreenshot 04:08:45 INFO - Running setup.py install for moztest 04:08:45 INFO - Running setup.py install for mozversion 04:08:45 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:08:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:08:45 INFO - Cleaning up... 04:08:45 INFO - Return code: 0 04:08:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff517169f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f8600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2187350>, '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 0x2188250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21886e0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973', '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 04:08:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 04:08:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:08:45 INFO - Using env: {'DISPLAY': ':0', 04:08:45 INFO - 'HOME': '/home/cltbld', 04:08:45 INFO - 'LANG': 'en_US.UTF-8', 04:08:45 INFO - 'LANGUAGE': 'en_US:en', 04:08:45 INFO - 'LOGNAME': 'cltbld', 04:08:45 INFO - 'MAIL': '/var/mail/cltbld', 04:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:45 INFO - 'MOZ_NO_REMOTE': '1', 04:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:45 INFO - 'NO_EM_RESTART': '1', 04:08:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:45 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:45 INFO - 'SHELL': '/bin/bash', 04:08:45 INFO - 'SHLVL': '1', 04:08:45 INFO - 'TERM': 'linux', 04:08:45 INFO - 'TMOUT': '86400', 04:08:45 INFO - 'USER': 'cltbld', 04:08:45 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973', 04:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:45 INFO - '_': '/tools/buildbot/bin/python'} 04:08:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:08:46 INFO - Running setup.py (path:/tmp/pip-T4N0d9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:08:46 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)) 04:08:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:08:46 INFO - Running setup.py (path:/tmp/pip-3SsGnC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:08:46 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)) 04:08:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:08:46 INFO - Running setup.py (path:/tmp/pip-zBlRfj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:08:46 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)) 04:08:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:08:46 INFO - Running setup.py (path:/tmp/pip-PEQo7e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:08:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 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)) 04:08:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:08:46 INFO - Running setup.py (path:/tmp/pip-sjyjj0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:08:46 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)) 04:08:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:08:46 INFO - Running setup.py (path:/tmp/pip-Jev2Y7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:08:46 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)) 04:08:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:08:46 INFO - Running setup.py (path:/tmp/pip-mMFdIY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:08:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 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)) 04:08:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:08:46 INFO - Running setup.py (path:/tmp/pip-8OVd0i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:08:46 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)) 04:08:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:08:46 INFO - Running setup.py (path:/tmp/pip-amBYrr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:08:46 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)) 04:08:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:08:46 INFO - Running setup.py (path:/tmp/pip-wJbtNR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:08:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 04:08:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:08:46 INFO - Running setup.py (path:/tmp/pip-UtNC7o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:08:46 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)) 04:08:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:08:46 INFO - Running setup.py (path:/tmp/pip-vTfD7X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:08:46 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)) 04:08:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:08:46 INFO - Running setup.py (path:/tmp/pip-hiG3Hi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:08:47 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)) 04:08:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:08:47 INFO - Running setup.py (path:/tmp/pip-LRLq39-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:08:47 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)) 04:08:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:08:47 INFO - Running setup.py (path:/tmp/pip-i7P2ii-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:08:47 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)) 04:08:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:08:47 INFO - Running setup.py (path:/tmp/pip-HKBLb1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:08:47 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)) 04:08:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:08:47 INFO - Running setup.py (path:/tmp/pip-3nLQNp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:08:47 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)) 04:08:47 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)) 04:08:47 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)) 04:08:47 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)) 04:08:47 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.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:08:47 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.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:08:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:49 INFO - Downloading blessings-1.6.tar.gz 04:08:49 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.6.tar.gz 04:08:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:08:49 INFO - Installing collected packages: blessings 04:08:49 INFO - Running setup.py install for blessings 04:08:49 INFO - Successfully installed blessings 04:08:49 INFO - Cleaning up... 04:08:49 INFO - Return code: 0 04:08:49 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:08:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:08:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:08:49 INFO - Reading from file tmpfile_stdout 04:08:49 INFO - Current package versions: 04:08:49 INFO - argparse == 1.2.1 04:08:49 INFO - blessings == 1.6 04:08:49 INFO - blobuploader == 1.2.4 04:08:49 INFO - docopt == 0.6.1 04:08:49 INFO - manifestparser == 1.1 04:08:49 INFO - mozInstall == 1.12 04:08:49 INFO - mozcrash == 0.16 04:08:49 INFO - mozdebug == 0.1 04:08:49 INFO - mozdevice == 0.46 04:08:49 INFO - mozfile == 1.2 04:08:49 INFO - mozhttpd == 0.7 04:08:49 INFO - mozinfo == 0.8 04:08:49 INFO - mozleak == 0.1 04:08:49 INFO - mozlog == 3.0 04:08:49 INFO - moznetwork == 0.27 04:08:49 INFO - mozprocess == 0.22 04:08:49 INFO - mozprofile == 0.27 04:08:49 INFO - mozrunner == 6.11 04:08:49 INFO - mozscreenshot == 0.1 04:08:49 INFO - mozsystemmonitor == 0.0 04:08:49 INFO - moztest == 0.7 04:08:49 INFO - mozversion == 1.4 04:08:49 INFO - psutil == 3.1.1 04:08:49 INFO - requests == 1.2.3 04:08:49 INFO - wsgiref == 0.1.2 04:08:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7ff517169f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f8600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2187350>, '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 0x2188250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21886e0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973', '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 04:08:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 04:08:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 04:08:49 INFO - Using env: {'DISPLAY': ':0', 04:08:49 INFO - 'HOME': '/home/cltbld', 04:08:49 INFO - 'LANG': 'en_US.UTF-8', 04:08:49 INFO - 'LANGUAGE': 'en_US:en', 04:08:49 INFO - 'LOGNAME': 'cltbld', 04:08:49 INFO - 'MAIL': '/var/mail/cltbld', 04:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:49 INFO - 'MOZ_NO_REMOTE': '1', 04:08:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:49 INFO - 'NO_EM_RESTART': '1', 04:08:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:49 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:49 INFO - 'SHELL': '/bin/bash', 04:08:49 INFO - 'SHLVL': '1', 04:08:49 INFO - 'TERM': 'linux', 04:08:49 INFO - 'TMOUT': '86400', 04:08:49 INFO - 'USER': 'cltbld', 04:08:49 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973', 04:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:49 INFO - '_': '/tools/buildbot/bin/python'} 04:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:49 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)) 04:08:49 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)) 04:08:49 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)) 04:08:49 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)) 04:08:49 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)) 04:08:49 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)) 04:08:49 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)) 04:08:49 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)) 04:08:49 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)) 04:08:49 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)) 04:08:49 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)) 04:08:49 INFO - Cleaning up... 04:08:49 INFO - Return code: 0 04:08:49 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7ff517169f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f8600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2187350>, '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 0x2188250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21886e0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973', '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 04:08:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 04:08:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:08:49 INFO - Using env: {'DISPLAY': ':0', 04:08:49 INFO - 'HOME': '/home/cltbld', 04:08:49 INFO - 'LANG': 'en_US.UTF-8', 04:08:49 INFO - 'LANGUAGE': 'en_US:en', 04:08:49 INFO - 'LOGNAME': 'cltbld', 04:08:49 INFO - 'MAIL': '/var/mail/cltbld', 04:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:49 INFO - 'MOZ_NO_REMOTE': '1', 04:08:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:49 INFO - 'NO_EM_RESTART': '1', 04:08:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:49 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:49 INFO - 'SHELL': '/bin/bash', 04:08:49 INFO - 'SHLVL': '1', 04:08:49 INFO - 'TERM': 'linux', 04:08:49 INFO - 'TMOUT': '86400', 04:08:49 INFO - 'USER': 'cltbld', 04:08:49 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973', 04:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:49 INFO - '_': '/tools/buildbot/bin/python'} 04:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:49 INFO - Downloading/unpacking jsonschema 04:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:08:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:08:51 INFO - Downloading/unpacking functools32 (from jsonschema) 04:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:51 INFO - Downloading functools32-3.2.3-2.tar.gz 04:08:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:08:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:08:51 INFO - warning: no files found matching '*.txt' 04:08:51 INFO - no previously-included directories found matching 'build' 04:08:51 INFO - no previously-included directories found matching 'dist' 04:08:51 INFO - no previously-included directories found matching '.git*' 04:08:51 INFO - Installing collected packages: jsonschema, functools32 04:08:52 INFO - Running setup.py install for functools32 04:08:52 INFO - warning: no files found matching '*.txt' 04:08:52 INFO - no previously-included directories found matching 'build' 04:08:52 INFO - no previously-included directories found matching 'dist' 04:08:52 INFO - no previously-included directories found matching '.git*' 04:08:52 INFO - Successfully installed jsonschema functools32 04:08:52 INFO - Cleaning up... 04:08:52 INFO - Return code: 0 04:08:52 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff517169f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f8600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2187350>, '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 0x2188250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21886e0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973', '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 04:08:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 04:08:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:08:52 INFO - Using env: {'DISPLAY': ':0', 04:08:52 INFO - 'HOME': '/home/cltbld', 04:08:52 INFO - 'LANG': 'en_US.UTF-8', 04:08:52 INFO - 'LANGUAGE': 'en_US:en', 04:08:52 INFO - 'LOGNAME': 'cltbld', 04:08:52 INFO - 'MAIL': '/var/mail/cltbld', 04:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:52 INFO - 'MOZ_NO_REMOTE': '1', 04:08:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:52 INFO - 'NO_EM_RESTART': '1', 04:08:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:08:52 INFO - 'PWD': '/builds/slave/test-pgo', 04:08:52 INFO - 'SHELL': '/bin/bash', 04:08:52 INFO - 'SHLVL': '1', 04:08:52 INFO - 'TERM': 'linux', 04:08:52 INFO - 'TMOUT': '86400', 04:08:52 INFO - 'USER': 'cltbld', 04:08:52 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973', 04:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:52 INFO - '_': '/tools/buildbot/bin/python'} 04:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:52 INFO - Downloading/unpacking flake8 04:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:08:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:08:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:08:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:08:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:08:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.7.0.tar.gz 04:08:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:08:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:08:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:08:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:08:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:08:54 INFO - no previously-included directories found matching 'docs/_build' 04:08:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:08:54 INFO - Running setup.py install for pep8 04:08:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:08:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:08:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:08:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:08:54 INFO - no previously-included directories found matching 'docs/_build' 04:08:54 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:08:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:08:54 INFO - Cleaning up... 04:08:55 INFO - Return code: 0 04:08:55 INFO - Running post-action listener: _resource_record_post_action 04:08:55 INFO - Running post-action listener: _start_resource_monitoring 04:08:55 INFO - Starting resource monitoring. 04:08:55 INFO - ##### 04:08:55 INFO - ##### Running install step. 04:08:55 INFO - ##### 04:08:55 INFO - Running pre-action listener: _resource_record_pre_action 04:08:55 INFO - Running main action method: install 04:08:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:08:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:08:55 INFO - Reading from file tmpfile_stdout 04:08:55 INFO - Detecting whether we're running mozinstall >=1.0... 04:08:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:08:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:08:55 INFO - Reading from file tmpfile_stdout 04:08:55 INFO - Output received: 04:08:55 INFO - Usage: mozinstall [options] installer 04:08:55 INFO - Options: 04:08:55 INFO - -h, --help show this help message and exit 04:08:55 INFO - -d DEST, --destination=DEST 04:08:55 INFO - Directory to install application into. [default: 04:08:55 INFO - "/builds/slave/test-pgo"] 04:08:55 INFO - --app=APP Application being installed. [default: firefox] 04:08:55 INFO - mkdir: /builds/slave/test-pgo/build/application 04:08:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 04:08:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 04:09:09 INFO - Reading from file tmpfile_stdout 04:09:09 INFO - Output received: 04:09:09 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:09:09 INFO - Running post-action listener: _resource_record_post_action 04:09:09 INFO - ##### 04:09:09 INFO - ##### Running run-tests step. 04:09:09 INFO - ##### 04:09:09 INFO - Running pre-action listener: _resource_record_pre_action 04:09:09 INFO - Running main action method: run_tests 04:09:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:09:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:09:09 INFO - Python 2.7.3 04:09:09 INFO - Return code: 0 04:09:09 INFO - grabbing minidump binary from tooltool 04:09: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')]} 04:09:09 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 0x2187350>, '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 0x2188250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21886e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:09:09 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 04:09:09 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 04:09:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:09:09 INFO - Return code: 0 04:09:09 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:09:09 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:09:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:09:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:09:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:09:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:09:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:09:10 INFO - Return code: 0 04:09:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 04:09:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost 04:09:10 INFO - Using env: {'DISPLAY': ':0', 04:09:10 INFO - 'HOME': '/home/cltbld', 04:09:10 INFO - 'LANG': 'en_US.UTF-8', 04:09:10 INFO - 'LANGUAGE': 'en_US:en', 04:09:10 INFO - 'LOGNAME': 'cltbld', 04:09:10 INFO - 'MAIL': '/var/mail/cltbld', 04:09:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:09:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:10 INFO - 'MOZ_NO_REMOTE': '1', 04:09:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:09:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:10 INFO - 'NO_EM_RESTART': '1', 04:09:10 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:09:10 INFO - 'PWD': '/builds/slave/test-pgo', 04:09:10 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:09:10 INFO - 'SHELL': '/bin/bash', 04:09:10 INFO - 'SHLVL': '1', 04:09:10 INFO - 'TERM': 'linux', 04:09:10 INFO - 'TMOUT': '86400', 04:09:10 INFO - 'USER': 'cltbld', 04:09:10 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973', 04:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:10 INFO - '_': '/tools/buildbot/bin/python'} 04:09:10 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] with output_timeout 3600 04:09:10 INFO - mozversion INFO | application_buildid: 20160118120031 04:09:10 INFO - mozversion INFO | application_changeset: f84fcce02b11da4d97979f4151c10801ae8d9425 04:09:10 INFO - mozversion INFO | application_display_name: Nightly 04:09:10 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:09:10 INFO - mozversion INFO | application_name: Firefox 04:09:10 INFO - mozversion INFO | application_remotingname: firefox 04:09:10 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:09:10 INFO - mozversion INFO | application_vendor: Mozilla 04:09:10 INFO - mozversion INFO | application_version: 44.0 04:09:10 INFO - mozversion INFO | platform_buildid: 20160118120031 04:09:10 INFO - mozversion INFO | platform_changeset: f84fcce02b11da4d97979f4151c10801ae8d9425 04:09:10 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:09:10 INFO - mozversion INFO | platform_version: 44.0 04:09:10 INFO - 2016-01-25 04:09:10,928 DEBUG : using testdate: 1453723750 04:09:10 INFO - 2016-01-25 04:09:10,928 DEBUG : actual date: 1453723750 04:09:10 INFO - 2016-01-25 04:09:10,975 INFO : starting webserver on 'localhost:35826' 04:09:10 INFO - 2016-01-25 04:09:10,976 INFO : Starting test suite talos-linux64-ix-022 04:09:10 INFO - 2016-01-25 04:09:10,976 INFO : Starting test dromaeo_css 04:09:10 INFO - 2016-01-25 04:09:10,976 DEBUG : operating with platform_type : linux_ 04:09:10 INFO - 2016-01-25 04:09:10,977 INFO : Initialising browser for dromaeo_css test... 04:09:10 INFO - 2016-01-25 04:09:10,989 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxtWfr6/profile http://localhost:35826/getInfo.html 04:09:14 INFO - 2016-01-25 04:09:14,846 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:09:14 INFO - 2016-01-25 04:09:14,846 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:09:14 INFO - 2016-01-25 04:09:14,846 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:09:14 INFO - 2016-01-25 04:09:14,846 DEBUG : BROWSER_OUTPUT: __metrics 04:09:14 INFO - 2016-01-25 04:09:14,951 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] 04:09:16 INFO - 2016-01-25 04:09:16,402 INFO : Browser initialized. 04:09:16 INFO - 2016-01-25 04:09:16,402 INFO : Running cycle 1/1 for dromaeo_css test... 04:09:16 INFO - 2016-01-25 04:09:16,403 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxtWfr6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:09:27 INFO - 2016-01-25 04:09:27,956 DEBUG : BROWSER_OUTPUT: RSS: Main: 128102400 04:09:27 INFO - 2016-01-25 04:09:27,956 DEBUG : BROWSER_OUTPUT: 04:10:19 INFO - 2016-01-25 04:10:19,635 DEBUG : BROWSER_OUTPUT: 1453723819633 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] 04:12:26 INFO - 2016-01-25 04:12:26,554 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35826/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35826/tests/dromaeo/cssquery-ext.html) 04:12:27 INFO - 2016-01-25 04:12:27,603 DEBUG : BROWSER_OUTPUT: RSS: Main: 236662784 04:12:27 INFO - 2016-01-25 04:12:27,603 DEBUG : BROWSER_OUTPUT: 04:15:29 INFO - 2016-01-25 04:15:29,669 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35826/tests/dromaeo/cssquery-ext.html (next: http://localhost:35826/tests/dromaeo/cssquery-jquery.html) 04:15:30 INFO - 2016-01-25 04:15:30,235 DEBUG : BROWSER_OUTPUT: RSS: Main: 199761920 04:15:30 INFO - 2016-01-25 04:15:30,235 DEBUG : BROWSER_OUTPUT: 04:18:31 INFO - 2016-01-25 04:18:31,922 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35826/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35826/tests/dromaeo/cssquery-mootools.html) 04:18:32 INFO - 2016-01-25 04:18:32,484 DEBUG : BROWSER_OUTPUT: RSS: Main: 209321984 04:18:32 INFO - 2016-01-25 04:18:32,484 DEBUG : BROWSER_OUTPUT: 04:21:34 INFO - 2016-01-25 04:21:34,227 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35826/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35826/tests/dromaeo/cssquery-prototype.html) 04:21:34 INFO - 2016-01-25 04:21:34,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 190521344 04:21:34 INFO - 2016-01-25 04:21:34,809 DEBUG : BROWSER_OUTPUT: 04:24:37 INFO - 2016-01-25 04:24:37,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35826/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35826/tests/dromaeo/cssquery-yui.html) 04:24:37 INFO - 2016-01-25 04:24:37,688 DEBUG : BROWSER_OUTPUT: RSS: Main: 193212416 04:24:37 INFO - 2016-01-25 04:24:37,688 DEBUG : BROWSER_OUTPUT: 04:27:39 INFO - 2016-01-25 04:27:39,877 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35826/tests/dromaeo/cssquery-yui.html (next: http://localhost:35826/tests/dromaeo/cssquery-dojo.html) 04:27:40 INFO - 2016-01-25 04:27:40,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 220401664 04:27:40 INFO - 2016-01-25 04:27:40,136 DEBUG : BROWSER_OUTPUT: 04:27:40 INFO - 2016-01-25 04:27:40,136 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:27:40 INFO - 2016-01-25 04:27:40,136 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:27:40 INFO - 2016-01-25 04:27:40,136 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:27:40 INFO - 2016-01-25 04:27:40,136 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:27:40 INFO - 2016-01-25 04:27:40,136 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3278.7540934429926;3287.6712328767117;3346.6151392589845;3350.145712843225;3377.729781617471;5507.256520369759;5512.779488820447;5514.11774116141;5517.586181036423;5532.3914369419335;5532.806351777688;5540.252065971093;5551.472610102034;5551.472610102034;5555.083411237141;4888.120138375091;5027.748612569375;5055.317532133152;5134.306868572732;5138.7173705446185;5019.54824065834;5025.522575355335;5112.744362781865;5119.923201151985;5145.871353216162;5107.7446127693465;5167.664101833388;5168.948310516903;5172.586193104543;5172.767225474844;5095.108356037678;5097.776533631902;5139.717315547625;5151.253068305112;5183.870403239912;4932.334134891779;5006;5025.547700706918;5093.083245015896;5132.820351287724;5400.648957817729;5400.810971615974;5410.756515956791;5412.675239485604;5434.483724046209;5786.07422812348;6001.969990150065;6006.579539432241;6011.218541589609;6011.549133814981;5880.294364676223;5942.881142377171;6044.274687037584;6051.1225872248715;6081.452669259788;5688.4311568843195;5698.857528561778;5705.62913410627;5710.628809127394;5715.399883012307;6016.759329626853;6101.084837274356;6146.907796383058;6162.5378096642935;6164.660943648053;5917.171595976567;5993.640381577119;6001.219841420588;6007;6038.154658347835;6022.126791615191;6026.246719160105;6026.728797204137;6028.819135425856;6033.18551995475;5782.074868021181;5905.881882362414;5998.550108741774;6009.278886533644;6032.306284777307;5949.970250148808;6106.603070800384;6111.113888486145;6111.786087486917;6112.052631842072;4640.814367425332;4648.930266046012;4657.604103651228;4667.276572131325;4691.976540117277;4032.8185231664647;4049.0687141957515;4100.36444351126;4118.279301122351;4158.313878210122;5683.2895888014;5683.658980461103;5683.8010669626365;5683.886322273532;5684.658920464785;6030.427109424598;6033.577649564489;6036.8188954331445;6039.66781826995;6045.969770151121;5464.672119672832;5511.090670039399;5567.109262517978;5585.357683866408;5605.271314729141;5168.9224661630105;5189.091908915924;5191.377034755778;5194.68831870089;5220.034293655686;6018.097285407136;6146.0473626587955;6148.262208535004;6148.723307451175;6164.321924588292;5990.580659353804;6025.246844144394;6101.267847858286;6148.44663980244;6150.600210986271;6096.820737350046;6099.683347046721;6102.121413343663;6107.4197951194565;6107.5724699272405;5598.552115830642;5690.2887139107615;5901.114832775118;5941.049432090845;5941.22764040672;5970.283565972111;6063.545234107548;6071.514278857592;6072.392760723892;6094.664793436404;5905.763769449174;5921.348651648402;5930.377310382348;5934.109883517507;5936.851578710567;5651.15232715096;5735.168400581809;5753.827385178452;5899.823005309848;5900.43945825146;5801.332846722681;5834.679092649945;5835.854103647443;5839.7372118255635;5852.736626851717;5929.407059294209;5929.466348028698;5935.643861368331;5940.227770389822;5949;5606.523445507178;5679.574031947538;5714.228579141763;5797.4782269595935;5806.65160090396 04:27:40 INFO - 2016-01-25 04:27:40,136 DEBUG : BROWSER_OUTPUT: |1;ext.html;601.8074216250799;627.1909237084162;630.5334052800929;637.799093285615;643.8808820368232;40923.181536369295;40953.385699214465;40968.18063638725;41025.58974410259;41100.38349424761;46664.766676166655;47157.292640610336;47331.76334118324;47380.52619473804;47384.28923566149;8168.060673022619;8282.047564530096;9269.72190834276;9425.81148377032;10603.893961060407;10867.456627168649;10983.505742241578;10987.066099381562;10990.890091099107;10999;11017.724556886102;11080.556777728882;11083.113350931946;11109.944450277737;11126.666200014013;10921.945390273038;11020.393878336688;11046.171537134707;11057.723556911062;11068.667939961773;10869.619563315246;10932.945335273353;11019.228653994223;11020.559177632886;11034.117270618332;45779.542204578196;46106.308405373944;46222.30666540004;46264.30603540949;46297.30554041692;3420.7605467617277;3576.141725985745;3701.9629803701887;3761.3041587306434;3785.886423407302;30912;34034.319313613836;34395.484067739;34451.31097378038;35197.12007199815;3414.1805966567845;3425.9486107708403;3437.2438063625964;3446.400143724764;3535.9469607955903;315292;320187;322420;322923;323526.382368089;66595.66702166459;67553.3244667547;74017;81889.59055204685;83988.58005709933;77195.61402193065;77580.22419775843;77901.22098779053;77943.61028194823;77979.61010194913;18904.62190756177;19224.231030758612;19255.32606358771;19314.71027934582;19319.51701207481;14118.364673589713;14379.928100359431;14403.78394324086;14406.279686015658;14536.781948270784;23922.162724304566;24125.638115428283;24198;24212.273631791075;24310.75689243085;9356.90643093574;9498.715038548717;9517.714468565953;9549.331546791658;9586.758719770205;1014.9188064954934;1040.8490768838628;1096.3915027160003;1113.7661091170944;1208.468273959455;30548.84725576358;30816.229594260323;31005.379892402027;31246.375072498424;31346;1062.4740753327153;1121.8036843552509;1156.9595064172713;1207.8570503174021;1218.6648671615376;15112;16073.437429689904;16097.839021609634;16238.594035148979;17640.470785876445;449301;455559.8888022221;456862;456903;456932;64162.67918660377;64757;64770;64862.67568662127;64881.35118648848;1379.5861241627472;1415.2332190567415;1478.3790807860723;1483.3399137383976;1509.532045066055;31574.36851262916;31832.5225121628;32178.678213218504;32232.19419514531;32584.83707581447;52324.47675523196;52711.472885270654;52804.73597631987;52824.20763688625;52847;323069;323834;324796;325528;325737;37503.624963750015;37631.81184094062;37924.24151516899;49527.25709114294;50488.495115048376;48927.75536122297;49187;49324.2601360987;50047.499525004285;50319.74840125776;41462.58537414708;42626.57373426226;42701;42823.7858810704;42902.570974291106;35822.28355432929;36055;36122.63877361193;36543.086422838576;36604.26791464209;41550.792246038574;41718.374224386054;42804.357934631626;42900.49848255296;42907;36586.07311415134;37454;39549.209015818946;41106;41985.37021944612;28038.158855234375;28970.7102928968;28979.42041159123;30486.56107511438;30571.54142687906 04:27:40 INFO - 2016-01-25 04:27:40,137 DEBUG : BROWSER_OUTPUT: |2;jquery.html;381.23982367658147;383.3636163967814;386.12349965578136;389.96685281751047;391.11998004489897;12497.875021249785;15354.923225383858;17253.913730431344;19046.90476547617;19056.23775049;19882.105305261262;20168.798312016876;20315.593688126228;20658.793412065876;20697;5880.3825598312205;5989.610675306091;5990.311114221855;5991.041433370661;5991.670458124801;4484.66365022623;4590.632749380042;5931.792387266447;6512.934870651304;6749.696263668122;6489.805305840832;6616.27221005689;6641.169853768279;6670;6674.833129171785;6563.245226798907;6598.670066496656;6601.801945941629;6606.471482281454;6613.669316534154;5765.7981970631245;5880.088586269135;5888.558358123158;5907.202527658754;5918.674472903988;23604.173853915032;23748.525029499488;23918.402039948967;23942.16202432924;24358.26925192247;2030.857839951204;2092.3199960013058;2100.6428907085833;2269.773022697717;2353.188150088217;10330.9483452583;10382.948085259526;10552.788944221073;10675.145988320994;10771.515281812337;1686.991565042167;1693.7628731977534;1700.45585412668;1710.1534740303505;1713.3660545598084;70706;70760.2923970764;71188;71848.6407567964;72252.63873680598;7800.297973182441;7832.373410127176;7837.608119593998;7869.527828330319;7910.129885712567;9556.904430955601;9567.808643827084;9570.33007689469;9582.233421326277;9601;6266.060090986389;6275.497960163176;6321.589096708699;6322;6388.648624325707;6618.7021584028835;6749.2238392584495;6763.323667633197;6796.286389929085;6807.591544507345;3622.5290712207243;3667.4132138857653;3672.13704779382;3703.703703703697;3706.5181526401393;1233.5374234662002;1263.317808383481;1263.595649392204;1267.689416093063;1314.7830607949581;442.7830363122047;497.6914313125885;507.71567921963083;511.3761211322181;552.7015411677729;10330.328528645614;11173.83239251412;11175.608853690082;11209.94395028036;11469.25449845774;469.624300559551;481.7687509995222;487.3250547990987;493.6149803153474;506.8428787075944;6054.969725151434;6092.45167934888;6199.070139479114;6269.7492100316385;6324.652144132025;627377;632876;636312;646399;650939;89304.5534772335;90184;90879.54560227289;91163;92151.53924230336;501.8670052436107;504.271327931136;505.72438021277753;506.4631490620028;507.2619338861947;10776;10845.349279043283;10919.83620245681;10936.453177340942;10941.070009049;38752;39275.2144957105;39489.2102157961;40258;40468.190636186526;52954.205686913956;53329.733351334544;54224;54239.18641220464;54866.451335487734;7415.184329723618;7435.330820226206;7555.13115991668;7701.6919323228685;7718.53688778675;13304.401301941629;13637.659058523615;13714.588562343146;13746.243956582484;13868.72262554723;11785.116116291483;11903.166778325434;12039.939800300943;12071.758564828478;12162.756744864877;10124.443155626512;11622.88377116218;11712.648620541397;11726.472308745957;11735;12071.275723456622;12271.386430678609;12341.814872776737;12358.567450139562;12369.196002259825;7513.4740568159705;7546.434017448603;7631.503952243086;7647.541147531166;7661.923380766121;11709.707257318294;11831.290122592673;11865.525378984745;11869.584564540544;12201.08491863096 04:27:40 INFO - 2016-01-25 04:27:40,137 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1527.3356090100806;1568.1845440371007;1628.1614968291324;1775.7869055713309;1884.7738271407434;7316.96341518293;7493;7875.291223789858;7958.28375446209;7968.083670377909;7770.883436748453;7956.443048986574;8040.879386809188;8048.114707382183;8049.315808156313;2325.534893021394;2348.5655153796515;2354.234873666057;2355.528894221154;2356.1871154451687;2171.4896999205175;2210.3810932938723;2372.146027430124;2418.3470462974988;2499.2252401755422;2349.119080344871;2410.276916924924;2416.395901024744;2418.407490164912;2419.5402873454077;2436.9634455483183;2459.766322199388;2464.4331803685163;2464.544059349026;2466.8149888758417;2426.6845310109748;2479.8636075015866;2482.4042229864704;2485.565026120422;2486.6021436570063;8108.310793582553;8137.877931831027;8179.918200818035;8186.795330116735;8191.467554608991;4937.925931111036;4958.181899986498;4966.354373931402;4982.676126051795;4999.175136102539;3149.7795154339206;3192.5530425740417;3265.4938484534937;3282.96717032829;3293.736501079908;1034.7982143482025;1036.4040676610903;1036.4506811389974;1056.1392465140887;1059.5285098131335;10581.259311848175;10600.416977066257;10606.628767993161;10615.416152111631;10622.78754424915;4514.0069184779295;4522.547745225517;4575.794089265991;4602.861914142581;4614.169449499055;9116.361854670242;9118.224950879117;9154.908450915538;9157.221636160868;9170.220531254918;4983.252512123138;4992.251162325608;4994.40067191932;4995.200767877195;4998.125328067574;4495.100979804052;4525.185466616041;4528.117017181618;4544.977275113603;4545.2954792007295;3464.255185135208;3814.6185381461632;3855.3445914194654;3874.4575759393706;3880.670143037817;1247.8876901078947;1252.2298786246574;1292.9094963352475;1294.6763309172707;1297.5588299978053;1171.0280467212194;1384.806127142201;1408.8379836318954;1429.8570142985827;1431.3701971132668;7794.2985131338455;7859.174786647434;7905.723299684483;7917.802054948673;7921.445498815143;1185.3184418959133;1194.8267501212276;1196.9222000569935;1206.927584344942;1217.6773155113901;6266.937330626726;6276.623402595859;6353.14232578596;6377.521685873486;6380.936190638127;9330.766730831783;9587.616495340248;9602.135807777333;9609.519524023772;9609.807803843883;9420.24638028956;9440.339176257734;9441.669541566012;9476.810463790685;9502.04979502058;7451.925480745232;7569.432292578079;7573.507721998052;7575.090989081235;7577;7434.405247580073;7518.135414427411;7540.208278130936;7562.810929726801;7571.545707257582;8615.267702245379;8744.475331480131;8827.24968377695;8837.293016558788;8940.776480588038;8907.777305567413;9090.772730681785;9097.727068187965;9101.317401194805;9173.220276276325;7078.009078729085;7132.251113632994;7155;7174.1032370953635;7176.318249766264;6951.930480695129;7277.454190935595;7926.643301051351;7973.880391794011;8038.236367545074;7219.963900180465;7288.234735352924;7316.670749816165;7354.338109570164;7354.595497247703;7066.152061752623;7072.575645461289;7147.749828755968;7212.963935180501;7220.4945653805835;7421.035265415461;7466.589337586268;7469.701211951461;7484.476086673881;7495.175530691728;6720.428763555153;6811.352921472452;6825.897611535732;6849.863002739818;6867.656617169221;6859.142607174103;6883.621400823003;6895.138107736533;6899.344562266577;6903.965480172567 04:27:40 INFO - 2016-01-25 04:27:40,137 DEBUG : BROWSER_OUTPUT: |4;prototype.html;359.4679873786795;363.9745217834749;365.3660898341377;368.02840501077145;373.02640109314683;5843.152742852284;5895.528357731382;5913.379095195007;5918.230630018103;5922.052471604538;5772.480476757091;5813.941860581393;5859.6777177255235;5861.648301101937;5879.441453061963;4611.907761844761;4618.1456430560365;4619.815207391717;4621.491635920046;4626.560476754703;4618.861434156964;4626.259798432252;4627.745473998929;4632.351470794091;4634;4514.97742511287;4595;4624.699394539361;4673.579377855992;4677.976610116962;4631.351610774477;4641.698289611165;4650.627949764011;4666.90666186676;4670.2060649689465;3901.941470877939;4117.238310912491;4129.669626429908;4130.607592278759;4136.9793151034055;5551.861203469905;5595.608307418483;5659;5668.659880407147;5668.858278543028;5317.2821669074565;5323.653962492425;5326.520613144836;5330.9733451332495;5333.946660533384;6211.968940155315;6217.129601855744;6219.34696856828;6222.688865556704;6226.2839773426185;4379.146066517031;4426.734395936254;4453.376527286183;4456.465224173087;4508.346289787963;6381.61710297379;6438.967805160991;6443.226812782496;6443.871122577569;6447.355264473562;4440.245158323093;4447.533009034069;4447.888802779957;4448.266036104006;4451.06527629195;4532.637389008872;4532.9773351133035;4534.455865296186;4536.977315113403;4540.704854184468;5122.359705036871;5267.841964741064;5277.445868183862;5286.920696189561;5292.153255479105;6348.968255158787;6349.777757778455;6352.6823658816875;6355.046742988497;6359.841003974845;1641.2040160522138;1675.2126500544725;1675.31312162013;1675.4136052381568;1677.3290683726364;1126.6563698072166;1127.8026345389524;1128.4527004402858;1145.7364806094645;1155.179822326141;6151.231096112986;6153.600015998945;6157.661328626879;6160.383961603804;6164.6917654117115;6538.313477084933;6548.770793022221;6553;6554.737810487527;6562.048502967043;5980.970095149496;6125.142480052797;6144.17053697754;6146.938530614726;6149.477294429934;3583.605803361628;3591.964080359163;3609;3615.692666123409;3618;6459.838504037437;6546.149000629887;6591.835204119935;6682.498812589075;6688.097106890507;6669.1330127083165;6676.86646267072;6679.265280819106;6691;6693.263740988487;6633.4693224541925;6656.567323124078;6656.733730650816;6658.800235992928;6666.300038495985;6389.297177310399;6498.805035848932;6501.44737697301;6503.674816259074;6504;6508.251551071688;6508.674566271762;6509.316521765147;6513.837154071186;6515;6739.696713647995;6742.69657865407;6751.459883209233;6753.15585551806;6753.932460675527;4514.841980530666;4599.356090147449;4603.3785438965315;4603.58567728906;4604.631629469702;6554.80335589933;6599.703013364506;6601.702923368364;6604.504662150454;6606.933930660632;6406.87186256263;6416.743330266924;6420.903686444613;6430.582012169194;6431.196100487439;6252.062190671436;6331.335209803088;6336.651484168415;6337.683115844097;6406.167198264196;6234.127222188988;6236.34518375564;6236.937630623635;6243;6249.25008998923;6368.42684158428;6375.203099612549;6375.330590287953;6377.617342959437;6378.362163783585;6116.113163591343;6209.59637623553;6210.192674952227;6216.844578885564;6218.626882387071 04:27:40 INFO - 2016-01-25 04:27:40,138 DEBUG : BROWSER_OUTPUT: |5;yui.html;801.483043436983;860.6944534690181;875.6322344615261;929.660673854043;945.5225111318783;15302;15645.295961681722;15681.372745090212;15688.450904218354;15693.607659808511;12960.54638087667;13029.413676384562;13047.15193512421;13048.347582620878;13048.869511304883;751.1924680967954;761.0980987529767;899.7030979776658;901.166421060518;915.8168366326728;907.541691445819;907.8002839375326;907.9818403631923;910.7859652981545;915.6474757218452;808.0303635637259;950.5437390052779;957.248559880494;959.4243453927658;959.4627008875052;813.780279324582;931.9673811416602;949.8290307744603;950.396498223626;951.4338968313842;702.6802804723839;705.8270723672733;706.3819158236543;707.9150501939748;708.4155571653406;14534.781978270334;14647.12117272967;14666.046706964013;14681.412743490248;14697.77953330701;12294.446749896186;12981.286029268387;13004.869951300461;13103.148295360867;13113.409896554678;9304.488253146073;9335.579898904565;9441.339106262565;9536.427814331162;9577.712668619952;3346.3474622448634;3394.4568868980846;3448.137965508623;3459.636738142484;3459.8616055357757;50180.74909625465;50190.7490462549;50295.49704502945;51144.23283650748;52553.211701824504;9613.807723845484;9725.756856078513;9783.510824458748;9785.26610504215;9799.804003919882;20522.58954820895;20558.79441205569;20652;20681.793182067988;20758.896205519177;7248.238934911864;7288.234735352818;7365.7790266292095;7386;7559.962200189074;4159.126583417456;4206.398451267057;4207.453031105937;4222.915541689149;4256.723312984646;3264.183954011497;3304.1078908694517;3304.9173770655443;3306.04124803809;3316.3533111043116;515.38926372249;517.981870634526;520.9921851172236;521.0464849325725;523.1368242400071;525.3879230696273;539.4147350125158;573.87948530809;613.4172536090732;631.0471188505298;7972.123066462685;8101.432899697083;8341.791455213668;8504.14958504157;8631.827363452696;549.9202615620712;579.4408395897979;603.3001718007179;635.8664680417072;637.877335888839;3808.200277941608;3834.9233015339537;3866.2654095721723;3903.6486716195677;3973.7615743055508;63531.36468635347;63726.362736372044;64277;64336.03495947565;65111;56000.719996399755;56587;56622.43377566254;57135;59885.700571497735;53818.73090634522;53921;54006.459935400926;55103.724481378136;55569;8102.554359510284;8166.510009399455;8219.671213151407;8355.707550235713;8406.15938406179;39651.80174099111;40348.79825600853;41091;41173.588264118174;41400.1719965605;49328.26007609961;49371.75314123406;52655.05004504297;52961;53677.463225367246;8331.208535189147;8372.28835548985;8413.116622754522;8513.106123856905;8667.566621668766;12529.686757831127;12554.686132846751;12639.747205056032;12731.55439559611;12966.80549791735;10899.02548837374;10911.345319280868;10914.563417463212;10969.396683182502;11009.83485247738;11616.535338586362;11621.76756464883;11836.585719499777;11861.822072668745;11916.940415297868;9444.0555944405;9980.101790838859;10413.895861041596;10684.946575267073;10689.625863095065;9491.145796878038;9929.602815887572;9995.550200241152;10030.197584193102;10399.428031458343;8522.872156917776;8731.694390696295;8784.956075219583;9088.818223635622;9091.090890910857 04:27:40 INFO - 2016-01-25 04:27:40,138 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:27:40 INFO - 2016-01-25 04:27:40,138 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:27:40 INFO - 2016-01-25 04:27:40,138 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,808 04:27:40 INFO - 2016-01-25 04:27:40,138 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:27:40 INFO - 2016-01-25 04:27:40,138 DEBUG : BROWSER_OUTPUT: __startTimestamp1453724860129__endTimestamp 04:27:40 INFO - 2016-01-25 04:27:40,138 DEBUG : BROWSER_OUTPUT: 04:27:40 INFO - 2016-01-25 04:27:40,138 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:27:40 INFO - 2016-01-25 04:27:40,139 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:27:40 INFO - 2016-01-25 04:27:40,139 DEBUG : BROWSER_OUTPUT: 04:27:40 INFO - 2016-01-25 04:27:40,139 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5566.44 Median:5753.83 stddev:621.88 (10.8%) stddev-sans-first:597.33 04:27:40 INFO - 2016-01-25 04:27:40,139 DEBUG : BROWSER_OUTPUT: Values: 3278.8 3287.7 3346.6 3350.1 3377.7 5507.3 5512.8 5514.1 5517.6 5532.4 5532.8 5540.3 5551.5 5551.5 5555.1 4888.1 5027.7 5055.3 5134.3 5138.7 5019.5 5025.5 5112.7 5119.9 5145.9 5107.7 5167.7 5168.9 5172.6 5172.8 5095.1 5097.8 5139.7 5151.3 5183.9 4932.3 5006.0 5025.5 5093.1 5132.8 5400.6 5400.8 5410.8 5412.7 5434.5 5786.1 6002.0 6006.6 6011.2 6011.5 5880.3 5942.9 6044.3 6051.1 6081.5 5688.4 5698.9 5705.6 5710.6 5715.4 6016.8 6101.1 6146.9 6162.5 6164.7 5917.2 5993.6 6001.2 6007.0 6038.2 6022.1 6026.2 6026.7 6028.8 6033.2 5782.1 5905.9 5998.6 6009.3 6032.3 5950.0 6106.6 6111.1 6111.8 6112.1 4640.8 4648.9 4657.6 4667.3 4692.0 4032.8 4049.1 4100.4 4118.3 4158.3 5683.3 5683.7 5683.8 5683.9 5684.7 6030.4 6033.6 6036.8 6039.7 6046.0 5464.7 5511.1 5567.1 5585.4 5605.3 5168.9 5189.1 5191.4 5194.7 5220.0 6018.1 6146.0 6148.3 6148.7 6164.3 5990.6 6025.2 6101.3 6148.4 6150.6 6096.8 6099.7 6102.1 6107.4 6107.6 5598.6 5690.3 5901.1 5941.0 5941.2 5970.3 6063.5 6071.5 6072.4 6094.7 5905.8 5921.3 5930.4 5934.1 5936.9 5651.2 5735.2 5753.8 5899.8 5900.4 5801.3 5834.7 5835.9 5839.7 5852.7 5929.4 5929.5 5935.6 5940.2 5949.0 5606.5 5679.6 5714.2 5797.5 5806.7 04:27:40 INFO - 2016-01-25 04:27:40,139 DEBUG : BROWSER_OUTPUT: 04:27:40 INFO - 2016-01-25 04:27:40,139 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:56438.75 Median:19366.53 stddev:97792.12 (505.0%) stddev-sans-first:97976.59 04:27:40 INFO - 2016-01-25 04:27:40,139 DEBUG : BROWSER_OUTPUT: Values: 601.8 627.2 630.5 637.8 643.9 40923.2 40953.4 40968.2 41025.6 41100.4 46664.8 47157.3 47331.8 47380.5 47384.3 8168.1 8282.0 9269.7 9425.8 10603.9 10867.5 10983.5 10987.1 10990.9 10999.0 11017.7 11080.6 11083.1 11109.9 11126.7 10921.9 11020.4 11046.2 11057.7 11068.7 10869.6 10932.9 11019.2 11020.6 11034.1 45779.5 46106.3 46222.3 46264.3 46297.3 3420.8 3576.1 3702.0 3761.3 3785.9 30912.0 34034.3 34395.5 34451.3 35197.1 3414.2 3425.9 3437.2 3446.4 3535.9 315292.0 320187.0 322420.0 322923.0 323526.4 66595.7 67553.3 74017.0 81889.6 83988.6 77195.6 77580.2 77901.2 77943.6 77979.6 18904.6 19224.2 19255.3 19314.7 19319.5 14118.4 14379.9 14403.8 14406.3 14536.8 23922.2 24125.6 24198.0 24212.3 24310.8 9356.9 9498.7 9517.7 9549.3 9586.8 1014.9 1040.8 1096.4 1113.8 1208.5 30548.8 30816.2 31005.4 31246.4 31346.0 1062.5 1121.8 1157.0 1207.9 1218.7 15112.0 16073.4 16097.8 16238.6 17640.5 449301.0 455559.9 456862.0 456903.0 456932.0 64162.7 64757.0 64770.0 64862.7 64881.4 1379.6 1415.2 1478.4 1483.3 1509.5 31574.4 31832.5 32178.7 32232.2 32584.8 52324.5 52711.5 52804.7 52824.2 52847.0 323069.0 323834.0 324796.0 325528.0 325737.0 37503.6 37631.8 37924.2 49527.3 50488.5 48927.8 49187.0 49324.3 50047.5 50319.7 41462.6 42626.6 42701.0 42823.8 42902.6 35822.3 36055.0 36122.6 36543.1 36604.3 41550.8 41718.4 42804.4 42900.5 42907.0 36586.1 37454.0 39549.2 41106.0 41985.4 28038.2 28970.7 28979.4 30486.6 30571.5 04:27:40 INFO - 2016-01-25 04:27:40,139 DEBUG : BROWSER_OUTPUT: 04:27:40 INFO - 2016-01-25 04:27:40,139 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31730.37 Median:490.47 stddev:104728.52 (21352.7%) stddev-sans-first:104995.86 04:27:40 INFO - 2016-01-25 04:27:40,140 DEBUG : BROWSER_OUTPUT: Values: 381.2 383.4 386.1 390.0 391.1 12497.9 15354.9 17253.9 19046.9 19056.2 19882.1 20168.8 20315.6 20658.8 20697.0 5880.4 5989.6 5990.3 5991.0 5991.7 4484.7 4590.6 5931.8 6512.9 6749.7 6489.8 6616.3 6641.2 6670.0 6674.8 6563.2 6598.7 6601.8 6606.5 6613.7 5765.8 5880.1 5888.6 5907.2 5918.7 23604.2 23748.5 23918.4 23942.2 24358.3 2030.9 2092.3 2100.6 2269.8 2353.2 10330.9 10382.9 10552.8 10675.1 10771.5 1687.0 1693.8 1700.5 1710.2 1713.4 70706.0 70760.3 71188.0 71848.6 72252.6 7800.3 7832.4 7837.6 7869.5 7910.1 9556.9 9567.8 9570.3 9582.2 9601.0 6266.1 6275.5 6321.6 6322.0 6388.6 6618.7 6749.2 6763.3 6796.3 6807.6 3622.5 3667.4 3672.1 3703.7 3706.5 1233.5 1263.3 1263.6 1267.7 1314.8 442.8 497.7 507.7 511.4 552.7 10330.3 11173.8 11175.6 11209.9 11469.3 469.6 481.8 487.3 493.6 506.8 6055.0 6092.5 6199.1 6269.7 6324.7 627377.0 632876.0 636312.0 646399.0 650939.0 89304.6 90184.0 90879.5 91163.0 92151.5 501.9 504.3 505.7 506.5 507.3 10776.0 10845.3 10919.8 10936.5 10941.1 38752.0 39275.2 39489.2 40258.0 40468.2 52954.2 53329.7 54224.0 54239.2 54866.5 7415.2 7435.3 7555.1 7701.7 7718.5 13304.4 13637.7 13714.6 13746.2 13868.7 11785.1 11903.2 12039.9 12071.8 12162.8 10124.4 11622.9 11712.6 11726.5 11735.0 12071.3 12271.4 12341.8 12358.6 12369.2 7513.5 7546.4 7631.5 7647.5 7661.9 11709.7 11831.3 11865.5 11869.6 12201.1 04:27:40 INFO - 2016-01-25 04:27:40,141 DEBUG : BROWSER_OUTPUT: 04:27:40 INFO - 2016-01-25 04:27:40,141 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5689.16 Median:6765.89 stddev:2865.45 (42.4%) stddev-sans-first:2856.41 04:27:40 INFO - 2016-01-25 04:27:40,142 DEBUG : BROWSER_OUTPUT: Values: 1527.3 1568.2 1628.2 1775.8 1884.8 7317.0 7493.0 7875.3 7958.3 7968.1 7770.9 7956.4 8040.9 8048.1 8049.3 2325.5 2348.6 2354.2 2355.5 2356.2 2171.5 2210.4 2372.1 2418.3 2499.2 2349.1 2410.3 2416.4 2418.4 2419.5 2437.0 2459.8 2464.4 2464.5 2466.8 2426.7 2479.9 2482.4 2485.6 2486.6 8108.3 8137.9 8179.9 8186.8 8191.5 4937.9 4958.2 4966.4 4982.7 4999.2 3149.8 3192.6 3265.5 3283.0 3293.7 1034.8 1036.4 1036.5 1056.1 1059.5 10581.3 10600.4 10606.6 10615.4 10622.8 4514.0 4522.5 4575.8 4602.9 4614.2 9116.4 9118.2 9154.9 9157.2 9170.2 4983.3 4992.3 4994.4 4995.2 4998.1 4495.1 4525.2 4528.1 4545.0 4545.3 3464.3 3814.6 3855.3 3874.5 3880.7 1247.9 1252.2 1292.9 1294.7 1297.6 1171.0 1384.8 1408.8 1429.9 1431.4 7794.3 7859.2 7905.7 7917.8 7921.4 1185.3 1194.8 1196.9 1206.9 1217.7 6266.9 6276.6 6353.1 6377.5 6380.9 9330.8 9587.6 9602.1 9609.5 9609.8 9420.2 9440.3 9441.7 9476.8 9502.0 7451.9 7569.4 7573.5 7575.1 7577.0 7434.4 7518.1 7540.2 7562.8 7571.5 8615.3 8744.5 8827.2 8837.3 8940.8 8907.8 9090.8 9097.7 9101.3 9173.2 7078.0 7132.3 7155.0 7174.1 7176.3 6951.9 7277.5 7926.6 7973.9 8038.2 7220.0 7288.2 7316.7 7354.3 7354.6 7066.2 7072.6 7147.7 7213.0 7220.5 7421.0 7466.6 7469.7 7484.5 7495.2 6720.4 6811.4 6825.9 6849.9 6867.7 6859.1 6883.6 6895.1 6899.3 6904.0 04:27:40 INFO - 2016-01-25 04:27:40,142 DEBUG : BROWSER_OUTPUT: 04:27:40 INFO - 2016-01-25 04:27:40,142 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5304.88 Median:6048.54 stddev:1565.82 (25.9%) stddev-sans-first:1525.59 04:27:40 INFO - 2016-01-25 04:27:40,142 DEBUG : BROWSER_OUTPUT: Values: 359.5 364.0 365.4 368.0 373.0 5843.2 5895.5 5913.4 5918.2 5922.1 5772.5 5813.9 5859.7 5861.6 5879.4 4611.9 4618.1 4619.8 4621.5 4626.6 4618.9 4626.3 4627.7 4632.4 4634.0 4515.0 4595.0 4624.7 4673.6 4678.0 4631.4 4641.7 4650.6 4666.9 4670.2 3901.9 4117.2 4129.7 4130.6 4137.0 5551.9 5595.6 5659.0 5668.7 5668.9 5317.3 5323.7 5326.5 5331.0 5333.9 6212.0 6217.1 6219.3 6222.7 6226.3 4379.1 4426.7 4453.4 4456.5 4508.3 6381.6 6439.0 6443.2 6443.9 6447.4 4440.2 4447.5 4447.9 4448.3 4451.1 4532.6 4533.0 4534.5 4537.0 4540.7 5122.4 5267.8 5277.4 5286.9 5292.2 6349.0 6349.8 6352.7 6355.0 6359.8 1641.2 1675.2 1675.3 1675.4 1677.3 1126.7 1127.8 1128.5 1145.7 1155.2 6151.2 6153.6 6157.7 6160.4 6164.7 6538.3 6548.8 6553.0 6554.7 6562.0 5981.0 6125.1 6144.2 6146.9 6149.5 3583.6 3592.0 3609.0 3615.7 3618.0 6459.8 6546.1 6591.8 6682.5 6688.1 6669.1 6676.9 6679.3 6691.0 6693.3 6633.5 6656.6 6656.7 6658.8 6666.3 6389.3 6498.8 6501.4 6503.7 6504.0 6508.3 6508.7 6509.3 6513.8 6515.0 6739.7 6742.7 6751.5 6753.2 6753.9 4514.8 4599.4 4603.4 4603.6 4604.6 6554.8 6599.7 6601.7 6604.5 6606.9 6406.9 6416.7 6420.9 6430.6 6431.2 6252.1 6331.3 6336.7 6337.7 6406.2 6234.1 6236.3 6236.9 6243.0 6249.3 6368.4 6375.2 6375.3 6377.6 6378.4 6116.1 6209.6 6210.2 6216.8 6218.6 04:27:40 INFO - 2016-01-25 04:27:40,142 DEBUG : BROWSER_OUTPUT: 04:27:40 INFO - 2016-01-25 04:27:40,142 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14823.86 Median:27826.82 stddev:18157.40 (65.3%) stddev-sans-first:18177.81 04:27:40 INFO - 2016-01-25 04:27:40,142 DEBUG : BROWSER_OUTPUT: Values: 801.5 860.7 875.6 929.7 945.5 15302.0 15645.3 15681.4 15688.5 15693.6 12960.5 13029.4 13047.2 13048.3 13048.9 751.2 761.1 899.7 901.2 915.8 907.5 907.8 908.0 910.8 915.6 808.0 950.5 957.2 959.4 959.5 813.8 932.0 949.8 950.4 951.4 702.7 705.8 706.4 707.9 708.4 14534.8 14647.1 14666.0 14681.4 14697.8 12294.4 12981.3 13004.9 13103.1 13113.4 9304.5 9335.6 9441.3 9536.4 9577.7 3346.3 3394.5 3448.1 3459.6 3459.9 50180.7 50190.7 50295.5 51144.2 52553.2 9613.8 9725.8 9783.5 9785.3 9799.8 20522.6 20558.8 20652.0 20681.8 20758.9 7248.2 7288.2 7365.8 7386.0 7560.0 4159.1 4206.4 4207.5 4222.9 4256.7 3264.2 3304.1 3304.9 3306.0 3316.4 515.4 518.0 521.0 521.0 523.1 525.4 539.4 573.9 613.4 631.0 7972.1 8101.4 8341.8 8504.1 8631.8 549.9 579.4 603.3 635.9 637.9 3808.2 3834.9 3866.3 3903.6 3973.8 63531.4 63726.4 64277.0 64336.0 65111.0 56000.7 56587.0 56622.4 57135.0 59885.7 53818.7 53921.0 54006.5 55103.7 55569.0 8102.6 8166.5 8219.7 8355.7 8406.2 39651.8 40348.8 41091.0 41173.6 41400.2 49328.3 49371.8 52655.1 52961.0 53677.5 8331.2 8372.3 8413.1 8513.1 8667.6 12529.7 12554.7 12639.7 12731.6 12966.8 10899.0 10911.3 10914.6 10969.4 11009.8 11616.5 11621.8 11836.6 11861.8 11916.9 9444.1 9980.1 10413.9 10684.9 10689.6 9491.1 9929.6 9995.6 10030.2 10399.4 8522.9 8731.7 8785.0 9088.8 9091.1 04:27:40 INFO - 2016-01-25 04:27:40,142 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:27:40 INFO - 2016-01-25 04:27:40,142 DEBUG : BROWSER_OUTPUT: 04:27:40 INFO - 2016-01-25 04:27:40,746 INFO : Browser exited with error code: 0 04:27:40 INFO - 2016-01-25 04:27:40,764 INFO : Completed test dromaeo_css (00:18:29) 04:27:40 INFO - 2016-01-25 04:27:40,764 INFO : Starting test kraken 04:27:40 INFO - 2016-01-25 04:27:40,764 DEBUG : operating with platform_type : linux_ 04:27:40 INFO - 2016-01-25 04:27:40,764 INFO : Initialising browser for kraken test... 04:27:40 INFO - 2016-01-25 04:27:40,771 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRkdOkd/profile http://localhost:35826/getInfo.html 04:27:44 INFO - 2016-01-25 04:27:44,466 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:27:44 INFO - 2016-01-25 04:27:44,466 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:27:44 INFO - 2016-01-25 04:27:44,466 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:27:44 INFO - 2016-01-25 04:27:44,466 DEBUG : BROWSER_OUTPUT: __metrics 04:27:44 INFO - 2016-01-25 04:27:44,656 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] 04:27:45 INFO - 2016-01-25 04:27:45,926 INFO : Browser initialized. 04:27:45 INFO - 2016-01-25 04:27:45,926 INFO : Running cycle 1/1 for kraken test... 04:27:45 INFO - 2016-01-25 04:27:45,927 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRkdOkd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:27:57 INFO - 2016-01-25 04:27:57,467 DEBUG : BROWSER_OUTPUT: RSS: Main: 128655360 04:27:57 INFO - 2016-01-25 04:27:57,468 DEBUG : BROWSER_OUTPUT: 04:27:59 INFO - 2016-01-25 04:27:59,888 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35826/tests/kraken/driver.html?testName=audio-beat-detection) 04:28:00 INFO - 2016-01-25 04:28:00,455 DEBUG : BROWSER_OUTPUT: RSS: Main: 163713024 04:28:00 INFO - 2016-01-25 04:28:00,455 DEBUG : BROWSER_OUTPUT: 04:28:02 INFO - 2016-01-25 04:28:02,976 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35826/tests/kraken/driver.html?testName=audio-dft) 04:28:03 INFO - 2016-01-25 04:28:03,539 DEBUG : BROWSER_OUTPUT: RSS: Main: 160043008 04:28:03 INFO - 2016-01-25 04:28:03,539 DEBUG : BROWSER_OUTPUT: 04:28:06 INFO - 2016-01-25 04:28:06,329 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35826/tests/kraken/driver.html?testName=audio-fft) 04:28:06 INFO - 2016-01-25 04:28:06,895 DEBUG : BROWSER_OUTPUT: RSS: Main: 157052928 04:28:06 INFO - 2016-01-25 04:28:06,896 DEBUG : BROWSER_OUTPUT: 04:28:08 INFO - 2016-01-25 04:28:08,860 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35826/tests/kraken/driver.html?testName=audio-oscillator) 04:28:09 INFO - 2016-01-25 04:28:09,425 DEBUG : BROWSER_OUTPUT: RSS: Main: 157704192 04:28:09 INFO - 2016-01-25 04:28:09,426 DEBUG : BROWSER_OUTPUT: 04:28:11 INFO - 2016-01-25 04:28:11,552 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35826/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:28:12 INFO - 2016-01-25 04:28:12,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 155848704 04:28:12 INFO - 2016-01-25 04:28:12,113 DEBUG : BROWSER_OUTPUT: 04:28:15 INFO - 2016-01-25 04:28:15,011 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35826/tests/kraken/driver.html?testName=imaging-darkroom) 04:28:15 INFO - 2016-01-25 04:28:15,578 DEBUG : BROWSER_OUTPUT: RSS: Main: 154886144 04:28:15 INFO - 2016-01-25 04:28:15,578 DEBUG : BROWSER_OUTPUT: 04:28:18 INFO - 2016-01-25 04:28:18,925 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35826/tests/kraken/driver.html?testName=imaging-desaturate) 04:28:19 INFO - 2016-01-25 04:28:19,491 DEBUG : BROWSER_OUTPUT: RSS: Main: 155545600 04:28:19 INFO - 2016-01-25 04:28:19,491 DEBUG : BROWSER_OUTPUT: 04:28:22 INFO - 2016-01-25 04:28:22,178 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35826/tests/kraken/driver.html?testName=json-parse-financial) 04:28:22 INFO - 2016-01-25 04:28:22,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 156557312 04:28:22 INFO - 2016-01-25 04:28:22,745 DEBUG : BROWSER_OUTPUT: 04:28:24 INFO - 2016-01-25 04:28:24,226 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35826/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:28:24 INFO - 2016-01-25 04:28:24,780 DEBUG : BROWSER_OUTPUT: RSS: Main: 161529856 04:28:24 INFO - 2016-01-25 04:28:24,780 DEBUG : BROWSER_OUTPUT: 04:28:26 INFO - 2016-01-25 04:28:26,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35826/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:28:27 INFO - 2016-01-25 04:28:27,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 160780288 04:28:27 INFO - 2016-01-25 04:28:27,103 DEBUG : BROWSER_OUTPUT: 04:28:29 INFO - 2016-01-25 04:28:29,055 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35826/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:28:29 INFO - 2016-01-25 04:28:29,617 DEBUG : BROWSER_OUTPUT: RSS: Main: 165314560 04:28:29 INFO - 2016-01-25 04:28:29,617 DEBUG : BROWSER_OUTPUT: 04:28:31 INFO - 2016-01-25 04:28:31,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35826/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:28:32 INFO - 2016-01-25 04:28:32,509 DEBUG : BROWSER_OUTPUT: RSS: Main: 170196992 04:28:32 INFO - 2016-01-25 04:28:32,509 DEBUG : BROWSER_OUTPUT: 04:28:34 INFO - 2016-01-25 04:28:34,910 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35826/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:28:35 INFO - 2016-01-25 04:28:35,479 DEBUG : BROWSER_OUTPUT: RSS: Main: 165507072 04:28:35 INFO - 2016-01-25 04:28:35,480 DEBUG : BROWSER_OUTPUT: 04:28:37 INFO - 2016-01-25 04:28:37,060 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35826/tests/kraken/driver.html?testName=ai-astar) 04:28:37 INFO - 2016-01-25 04:28:37,311 DEBUG : BROWSER_OUTPUT: RSS: Main: 226426880 04:28:37 INFO - 2016-01-25 04:28:37,311 DEBUG : BROWSER_OUTPUT: 04:28:37 INFO - 2016-01-25 04:28:37,311 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:28:37 INFO - 2016-01-25 04:28:37,312 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:28:37 INFO - 2016-01-25 04:28:37,312 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:28:37 INFO - 2016-01-25 04:28:37,312 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:28:37 INFO - 2016-01-25 04:28:37,312 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;109;103;110;112;110;97;109;108;108 04:28:37 INFO - 2016-01-25 04:28:37,312 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;144;120;142;157;125;148;141;121;154;129 04:28:37 INFO - 2016-01-25 04:28:37,312 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;158;160;160;159;158;158;159;159;161 04:28:37 INFO - 2016-01-25 04:28:37,312 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;71;149;72;71;70;71;177;77 04:28:37 INFO - 2016-01-25 04:28:37,312 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;89;143;89;94;89;130;89;90;130 04:28:37 INFO - 2016-01-25 04:28:37,313 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;110;110;109;109;109;109 04:28:37 INFO - 2016-01-25 04:28:37,313 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;146;145;145;145;145;145;146;145 04:28:37 INFO - 2016-01-25 04:28:37,313 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;96;96;96;95;96;96;95 04:28:37 INFO - 2016-01-25 04:28:37,313 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;53;56;57;55;55;55;57;63;55;53 04:28:37 INFO - 2016-01-25 04:28:37,313 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;63;63;64;64;63;63;63;63;63 04:28:37 INFO - 2016-01-25 04:28:37,313 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;77;78;77;78;76;76;77;78;78 04:28:37 INFO - 2016-01-25 04:28:37,313 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;108;114;121;108;113;113;120;106;119;106 04:28:37 INFO - 2016-01-25 04:28:37,313 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;129;139;136;135;134;138;134;138;137 04:28:37 INFO - 2016-01-25 04:28:37,314 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;63;61;63;61;62;61;65;61;60 04:28:37 INFO - 2016-01-25 04:28:37,314 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:28:37 INFO - 2016-01-25 04:28:37,314 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:28:37 INFO - 2016-01-25 04:28:37,314 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,858 04:28:37 INFO - 2016-01-25 04:28:37,314 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:28:37 INFO - 2016-01-25 04:28:37,314 DEBUG : BROWSER_OUTPUT: __startTimestamp1453724917309__endTimestamp 04:28:37 INFO - 2016-01-25 04:28:37,314 DEBUG : BROWSER_OUTPUT: 04:28:37 INFO - 2016-01-25 04:28:37,317 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:28:37 INFO - 2016-01-25 04:28:37,317 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:28:37 INFO - 2016-01-25 04:28:37,317 DEBUG : BROWSER_OUTPUT: 04:28:37 INFO - 2016-01-25 04:28:37,317 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.30 Median:109.50 stddev:4.32 (3.9%) stddev-sans-first:4.58 04:28:37 INFO - 2016-01-25 04:28:37,317 DEBUG : BROWSER_OUTPUT: Values: 107.0 109.0 103.0 110.0 112.0 110.0 97.0 109.0 108.0 108.0 04:28:37 INFO - 2016-01-25 04:28:37,318 DEBUG : BROWSER_OUTPUT: 04:28:37 INFO - 2016-01-25 04:28:37,318 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:138.10 Median:143.00 stddev:13.50 (9.4%) stddev-sans-first:14.15 04:28:37 INFO - 2016-01-25 04:28:37,318 DEBUG : BROWSER_OUTPUT: Values: 144.0 120.0 142.0 157.0 125.0 148.0 141.0 121.0 154.0 129.0 04:28:37 INFO - 2016-01-25 04:28:37,318 DEBUG : BROWSER_OUTPUT: 04:28:37 INFO - 2016-01-25 04:28:37,318 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.30 Median:159.50 stddev:1.16 (0.7%) stddev-sans-first:1.05 04:28:37 INFO - 2016-01-25 04:28:37,318 DEBUG : BROWSER_OUTPUT: Values: 161.0 158.0 160.0 160.0 159.0 158.0 158.0 159.0 159.0 161.0 04:28:37 INFO - 2016-01-25 04:28:37,318 DEBUG : BROWSER_OUTPUT: 04:28:37 INFO - 2016-01-25 04:28:37,318 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.00 Median:71.00 stddev:39.08 (55.0%) stddev-sans-first:40.85 04:28:37 INFO - 2016-01-25 04:28:37,318 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 71.0 149.0 72.0 71.0 70.0 71.0 177.0 77.0 04:28:37 INFO - 2016-01-25 04:28:37,318 DEBUG : BROWSER_OUTPUT: 04:28:37 INFO - 2016-01-25 04:28:37,318 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.20 Median:89.00 stddev:21.83 (24.5%) stddev-sans-first:22.54 04:28:37 INFO - 2016-01-25 04:28:37,318 DEBUG : BROWSER_OUTPUT: Values: 89.0 89.0 143.0 89.0 94.0 89.0 130.0 89.0 90.0 130.0 04:28:37 INFO - 2016-01-25 04:28:37,318 DEBUG : BROWSER_OUTPUT: 04:28:37 INFO - 2016-01-25 04:28:37,318 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:28:37 INFO - 2016-01-25 04:28:37,319 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 110.0 110.0 109.0 109.0 109.0 109.0 04:28:37 INFO - 2016-01-25 04:28:37,319 DEBUG : BROWSER_OUTPUT: 04:28:37 INFO - 2016-01-25 04:28:37,319 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 04:28:37 INFO - 2016-01-25 04:28:37,319 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 04:28:37 INFO - 2016-01-25 04:28:37,319 DEBUG : BROWSER_OUTPUT: 04:28:37 INFO - 2016-01-25 04:28:37,319 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:28:37 INFO - 2016-01-25 04:28:37,319 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 04:28:37 INFO - 2016-01-25 04:28:37,320 DEBUG : BROWSER_OUTPUT: 04:28:37 INFO - 2016-01-25 04:28:37,320 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.90 Median:55.50 stddev:2.85 (5.1%) stddev-sans-first:2.82 04:28:37 INFO - 2016-01-25 04:28:37,320 DEBUG : BROWSER_OUTPUT: Values: 53.0 56.0 57.0 55.0 55.0 55.0 57.0 63.0 55.0 53.0 04:28:37 INFO - 2016-01-25 04:28:37,320 DEBUG : BROWSER_OUTPUT: 04:28:37 INFO - 2016-01-25 04:28:37,320 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.20 Median:63.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 04:28:37 INFO - 2016-01-25 04:28:37,320 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 63.0 64.0 64.0 63.0 63.0 63.0 63.0 63.0 04:28:37 INFO - 2016-01-25 04:28:37,320 DEBUG : BROWSER_OUTPUT: 04:28:37 INFO - 2016-01-25 04:28:37,320 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:77.50 stddev:0.79 (1.0%) stddev-sans-first:0.83 04:28:37 INFO - 2016-01-25 04:28:37,320 DEBUG : BROWSER_OUTPUT: Values: 77.0 77.0 78.0 77.0 78.0 76.0 76.0 77.0 78.0 78.0 04:28:37 INFO - 2016-01-25 04:28:37,320 DEBUG : BROWSER_OUTPUT: 04:28:37 INFO - 2016-01-25 04:28:37,320 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:112.80 Median:113.50 stddev:5.75 (5.1%) stddev-sans-first:5.83 04:28:37 INFO - 2016-01-25 04:28:37,320 DEBUG : BROWSER_OUTPUT: Values: 108.0 114.0 121.0 108.0 113.0 113.0 120.0 106.0 119.0 106.0 04:28:37 INFO - 2016-01-25 04:28:37,320 DEBUG : BROWSER_OUTPUT: 04:28:37 INFO - 2016-01-25 04:28:37,320 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.80 Median:137.50 stddev:2.97 (2.2%) stddev-sans-first:3.05 04:28:37 INFO - 2016-01-25 04:28:37,320 DEBUG : BROWSER_OUTPUT: Values: 138.0 129.0 139.0 136.0 135.0 134.0 138.0 134.0 138.0 137.0 04:28:37 INFO - 2016-01-25 04:28:37,320 DEBUG : BROWSER_OUTPUT: 04:28:37 INFO - 2016-01-25 04:28:37,321 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.50 stddev:1.95 (3.1%) stddev-sans-first:1.54 04:28:37 INFO - 2016-01-25 04:28:37,321 DEBUG : BROWSER_OUTPUT: Values: 66.0 63.0 61.0 63.0 61.0 62.0 61.0 65.0 61.0 60.0 04:28:37 INFO - 2016-01-25 04:28:37,321 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:28:37 INFO - 2016-01-25 04:28:37,321 DEBUG : BROWSER_OUTPUT: 04:28:38 INFO - 2016-01-25 04:28:38,006 INFO : Browser exited with error code: 0 04:28:38 INFO - 2016-01-25 04:28:38,059 INFO : Completed test kraken (00:00:57) 04:28:38 INFO - 2016-01-25 04:28:38,059 INFO : Starting test v8_7 04:28:38 INFO - 2016-01-25 04:28:38,059 DEBUG : operating with platform_type : linux_ 04:28:38 INFO - 2016-01-25 04:28:38,059 INFO : Initialising browser for v8_7 test... 04:28:38 INFO - 2016-01-25 04:28:38,065 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2xvoSf/profile http://localhost:35826/getInfo.html 04:28:41 INFO - 2016-01-25 04:28:41,739 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:28:41 INFO - 2016-01-25 04:28:41,739 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:28:41 INFO - 2016-01-25 04:28:41,739 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:28:41 INFO - 2016-01-25 04:28:41,740 DEBUG : BROWSER_OUTPUT: __metrics 04:28:41 INFO - 2016-01-25 04:28:41,949 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] 04:28:43 INFO - 2016-01-25 04:28:43,250 INFO : Browser initialized. 04:28:43 INFO - 2016-01-25 04:28:43,250 INFO : Running cycle 1/1 for v8_7 test... 04:28:43 INFO - 2016-01-25 04:28:43,251 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2xvoSf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:28:54 INFO - 2016-01-25 04:28:54,754 DEBUG : BROWSER_OUTPUT: RSS: Main: 129474560 04:28:54 INFO - 2016-01-25 04:28:54,754 DEBUG : BROWSER_OUTPUT: 04:29:16 INFO - 2016-01-25 04:29:16,151 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35826/tests/v8_7/run.html (next: http://localhost:35826/tests/v8_7/run.html) 04:29:16 INFO - 2016-01-25 04:29:16,409 DEBUG : BROWSER_OUTPUT: RSS: Main: 425254912 04:29:16 INFO - 2016-01-25 04:29:16,409 DEBUG : BROWSER_OUTPUT: 04:29:16 INFO - 2016-01-25 04:29:16,409 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:29:16 INFO - 2016-01-25 04:29:16,409 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:29:16 INFO - 2016-01-25 04:29:16,409 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:29:16 INFO - 2016-01-25 04:29:16,409 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:29:16 INFO - 2016-01-25 04:29:16,409 DEBUG : BROWSER_OUTPUT: |0;Richards;163.47882949158085 04:29:16 INFO - 2016-01-25 04:29:16,410 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;170.24174327545114 04:29:16 INFO - 2016-01-25 04:29:16,410 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.3296089385475 04:29:16 INFO - 2016-01-25 04:29:16,410 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5055.555555555556 04:29:16 INFO - 2016-01-25 04:29:16,410 DEBUG : BROWSER_OUTPUT: |4;RayTrace;942.5070688030161 04:29:16 INFO - 2016-01-25 04:29:16,410 DEBUG : BROWSER_OUTPUT: |5;Earley;554.016620498615 04:29:16 INFO - 2016-01-25 04:29:16,410 DEBUG : BROWSER_OUTPUT: |6;Boyer;10443.298969072164 04:29:16 INFO - 2016-01-25 04:29:16,410 DEBUG : BROWSER_OUTPUT: |7;RegExp;24166.666666666668 04:29:16 INFO - 2016-01-25 04:29:16,410 DEBUG : BROWSER_OUTPUT: |8;Splay;534.1450502911594 04:29:16 INFO - 2016-01-25 04:29:16,410 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4878.048780487805 04:29:16 INFO - 2016-01-25 04:29:16,410 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:29:16 INFO - 2016-01-25 04:29:16,410 DEBUG : BROWSER_OUTPUT: __startTimestamp1453724956402__endTimestamp 04:29:16 INFO - 2016-01-25 04:29:16,410 DEBUG : BROWSER_OUTPUT: 04:29:16 INFO - 2016-01-25 04:29:16,410 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:29:16 INFO - 2016-01-25 04:29:16,410 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:29:16 INFO - 2016-01-25 04:29:16,410 DEBUG : BROWSER_OUTPUT: 04:29:16 INFO - 2016-01-25 04:29:16,410 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.48 Median:163.48 stddev:0.00 (0.0%) 04:29:16 INFO - 2016-01-25 04:29:16,411 DEBUG : BROWSER_OUTPUT: Values: 163.5 04:29:16 INFO - 2016-01-25 04:29:16,411 DEBUG : BROWSER_OUTPUT: 04:29:16 INFO - 2016-01-25 04:29:16,411 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:170.24 Median:170.24 stddev:0.00 (0.0%) 04:29:16 INFO - 2016-01-25 04:29:16,411 DEBUG : BROWSER_OUTPUT: Values: 170.2 04:29:16 INFO - 2016-01-25 04:29:16,411 DEBUG : BROWSER_OUTPUT: 04:29:16 INFO - 2016-01-25 04:29:16,411 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.33 Median:279.33 stddev:0.00 (0.0%) 04:29:16 INFO - 2016-01-25 04:29:16,411 DEBUG : BROWSER_OUTPUT: Values: 279.3 04:29:16 INFO - 2016-01-25 04:29:16,411 DEBUG : BROWSER_OUTPUT: 04:29:16 INFO - 2016-01-25 04:29:16,411 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5055.56 Median:5055.56 stddev:0.00 (0.0%) 04:29:16 INFO - 2016-01-25 04:29:16,411 DEBUG : BROWSER_OUTPUT: Values: 5055.6 04:29:16 INFO - 2016-01-25 04:29:16,411 DEBUG : BROWSER_OUTPUT: 04:29:16 INFO - 2016-01-25 04:29:16,411 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:942.51 Median:942.51 stddev:0.00 (0.0%) 04:29:16 INFO - 2016-01-25 04:29:16,411 DEBUG : BROWSER_OUTPUT: Values: 942.5 04:29:16 INFO - 2016-01-25 04:29:16,411 DEBUG : BROWSER_OUTPUT: 04:29:16 INFO - 2016-01-25 04:29:16,411 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:554.02 Median:554.02 stddev:0.00 (0.0%) 04:29:16 INFO - 2016-01-25 04:29:16,411 DEBUG : BROWSER_OUTPUT: Values: 554.0 04:29:16 INFO - 2016-01-25 04:29:16,412 DEBUG : BROWSER_OUTPUT: 04:29:16 INFO - 2016-01-25 04:29:16,412 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10443.30 Median:10443.30 stddev:0.00 (0.0%) 04:29:16 INFO - 2016-01-25 04:29:16,412 DEBUG : BROWSER_OUTPUT: Values: 10443.3 04:29:16 INFO - 2016-01-25 04:29:16,412 DEBUG : BROWSER_OUTPUT: 04:29:16 INFO - 2016-01-25 04:29:16,412 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24166.67 Median:24166.67 stddev:0.00 (0.0%) 04:29:16 INFO - 2016-01-25 04:29:16,412 DEBUG : BROWSER_OUTPUT: Values: 24166.7 04:29:16 INFO - 2016-01-25 04:29:16,412 DEBUG : BROWSER_OUTPUT: 04:29:16 INFO - 2016-01-25 04:29:16,412 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:534.15 Median:534.15 stddev:0.00 (0.0%) 04:29:16 INFO - 2016-01-25 04:29:16,412 DEBUG : BROWSER_OUTPUT: Values: 534.1 04:29:16 INFO - 2016-01-25 04:29:16,412 DEBUG : BROWSER_OUTPUT: 04:29:16 INFO - 2016-01-25 04:29:16,412 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4878.05 Median:4878.05 stddev:0.00 (0.0%) 04:29:16 INFO - 2016-01-25 04:29:16,412 DEBUG : BROWSER_OUTPUT: Values: 4878.0 04:29:16 INFO - 2016-01-25 04:29:16,412 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:29:16 INFO - 2016-01-25 04:29:16,412 DEBUG : BROWSER_OUTPUT: 04:29:17 INFO - 2016-01-25 04:29:17,086 INFO : Browser exited with error code: 0 04:29:17 INFO - 2016-01-25 04:29:17,098 INFO : Completed test v8_7 (00:00:39) 04:29:17 INFO - 2016-01-25 04:29:17,422 INFO : Completed test suite (00:20:06) 04:29:17 INFO - 2016-01-25 04:29:17,422 DEBUG : Working with test: dromaeo_css 04:29:17 INFO - 2016-01-25 04:29:17,422 DEBUG : Generating results file: dromaeo_css 04:29:17 INFO - 2016-01-25 04:29:17,423 DEBUG : Working with test: kraken 04:29:17 INFO - 2016-01-25 04:29:17,423 DEBUG : Generating results file: kraken 04:29:17 INFO - 2016-01-25 04:29:17,423 INFO : javascript benchmark 04:29:17 INFO - 2016-01-25 04:29:17,424 DEBUG : Working with test: v8_7 04:29:17 INFO - 2016-01-25 04:29:17,424 DEBUG : Generating results file: v8_7 04:29:17 INFO - 2016-01-25 04:29:17,424 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:29:17 INFO - 2016-01-25 04:29:17,471 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 04:29:17 INFO - 2016-01-25 04:29:17,471 DEBUG : process_Request line: dromaeo_css 7181.50 graph.html#tests=[[72,53,35]] 04:29:17 INFO - 2016-01-25 04:29:17,471 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:29:17 INFO - 2016-01-25 04:29:17,498 DEBUG : process_Request line: kraken 1455.30 graph.html#tests=[[232,53,35]] 04:29:17 INFO - 2016-01-25 04:29:17,498 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:29:17 INFO - 2016-01-25 04:29:17,531 DEBUG : process_Request line: v8_7 23246.27 graph.html#tests=[[230,53,35]] 04:29:17 INFO - 2016-01-25 04:29:17,532 INFO : javascript benchmark 04:29:17 INFO - 2016-01-25 04:29:17,536 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3278.7540934429926, 3287.6712328767117, 3346.6151392589845, 3350.145712843225, 3377.729781617471, 5507.256520369759, 5512.779488820447, 5514.11774116141, 5517.586181036423, 5532.3914369419335, 5532.806351777688, 5540.252065971093, 5551.472610102034, 5551.472610102034, 5555.083411237141, 4888.120138375091, 5027.748612569375, 5055.317532133152, 5134.306868572732, 5138.7173705446185, 5019.54824065834, 5025.522575355335, 5112.744362781865, 5119.923201151985, 5145.871353216162, 5107.7446127693465, 5167.664101833388, 5168.948310516903, 5172.586193104543, 5172.767225474844, 5095.108356037678, 5097.776533631902, 5139.717315547625, 5151.253068305112, 5183.870403239912, 4932.334134891779, 5006.0, 5025.547700706918, 5093.083245015896, 5132.820351287724, 5400.648957817729, 5400.810971615974, 5410.756515956791, 5412.675239485604, 5434.483724046209, 5786.07422812348, 6001.969990150065, 6006.579539432241, 6011.218541589609, 6011.549133814981, 5880.294364676223, 5942.881142377171, 6044.274687037584, 6051.1225872248715, 6081.452669259788, 5688.4311568843195, 5698.857528561778, 5705.62913410627, 5710.628809127394, 5715.399883012307, 6016.759329626853, 6101.084837274356, 6146.907796383058, 6162.5378096642935, 6164.660943648053, 5917.171595976567, 5993.640381577119, 6001.219841420588, 6007.0, 6038.154658347835, 6022.126791615191, 6026.246719160105, 6026.728797204137, 6028.819135425856, 6033.18551995475, 5782.074868021181, 5905.881882362414, 5998.550108741774, 6009.278886533644, 6032.306284777307, 5949.970250148808, 6106.603070800384, 6111.113888486145, 6111.786087486917, 6112.052631842072, 4640.814367425332, 4648.930266046012, 4657.604103651228, 4667.276572131325, 4691.976540117277, 4032.8185231664647, 4049.0687141957515, 4100.36444351126, 4118.279301122351, 4158.313878210122, 5683.2895888014, 5683.658980461103, 5683.8010669626365, 5683.886322273532, 5684.658920464785, 6030.427109424598, 6033.577649564489, 6036.8188954331445, 6039.66781826995, 6045.969770151121, 5464.672119672832, 5511.090670039399, 5567.109262517978, 5585.357683866408, 5605.271314729141, 5168.9224661630105, 5189.091908915924, 5191.377034755778, 5194.68831870089, 5220.034293655686, 6018.097285407136, 6146.0473626587955, 6148.262208535004, 6148.723307451175, 6164.321924588292, 5990.580659353804, 6025.246844144394, 6101.267847858286, 6148.44663980244, 6150.600210986271, 6096.820737350046, 6099.683347046721, 6102.121413343663, 6107.4197951194565, 6107.5724699272405, 5598.552115830642, 5690.2887139107615, 5901.114832775118, 5941.049432090845, 5941.22764040672, 5970.283565972111, 6063.545234107548, 6071.514278857592, 6072.392760723892, 6094.664793436404, 5905.763769449174, 5921.348651648402, 5930.377310382348, 5934.109883517507, 5936.851578710567, 5651.15232715096, 5735.168400581809, 5753.827385178452, 5899.823005309848, 5900.43945825146, 5801.332846722681, 5834.679092649945, 5835.854103647443, 5839.7372118255635, 5852.736626851717, 5929.407059294209, 5929.466348028698, 5935.643861368331, 5940.227770389822, 5949.0, 5606.523445507178, 5679.574031947538, 5714.228579141763, 5797.4782269595935, 5806.65160090396], "unit": "ms", "name": "dojo.html", "value": 5525.720130470471}, {"lowerIsBetter": false, "replicates": [601.8074216250799, 627.1909237084162, 630.5334052800929, 637.799093285615, 643.8808820368232, 40923.181536369295, 40953.385699214465, 40968.18063638725, 41025.58974410259, 41100.38349424761, 46664.766676166655, 47157.292640610336, 47331.76334118324, 47380.52619473804, 47384.28923566149, 8168.060673022619, 8282.047564530096, 9269.72190834276, 9425.81148377032, 10603.893961060407, 10867.456627168649, 10983.505742241578, 10987.066099381562, 10990.890091099107, 10999.0, 11017.724556886102, 11080.556777728882, 11083.113350931946, 11109.944450277737, 11126.666200014013, 10921.945390273038, 11020.393878336688, 11046.171537134707, 11057.723556911062, 11068.667939961773, 10869.619563315246, 10932.945335273353, 11019.228653994223, 11020.559177632886, 11034.117270618332, 45779.542204578196, 46106.308405373944, 46222.30666540004, 46264.30603540949, 46297.30554041692, 3420.7605467617277, 3576.141725985745, 3701.9629803701887, 3761.3041587306434, 3785.886423407302, 30912.0, 34034.319313613836, 34395.484067739, 34451.31097378038, 35197.12007199815, 3414.1805966567845, 3425.9486107708403, 3437.2438063625964, 3446.400143724764, 3535.9469607955903, 315292.0, 320187.0, 322420.0, 322923.0, 323526.382368089, 66595.66702166459, 67553.3244667547, 74017.0, 81889.59055204685, 83988.58005709933, 77195.61402193065, 77580.22419775843, 77901.22098779053, 77943.61028194823, 77979.61010194913, 18904.62190756177, 19224.231030758612, 19255.32606358771, 19314.71027934582, 19319.51701207481, 14118.364673589713, 14379.928100359431, 14403.78394324086, 14406.279686015658, 14536.781948270784, 23922.162724304566, 24125.638115428283, 24198.0, 24212.273631791075, 24310.75689243085, 9356.90643093574, 9498.715038548717, 9517.714468565953, 9549.331546791658, 9586.758719770205, 1014.9188064954934, 1040.8490768838628, 1096.3915027160003, 1113.7661091170944, 1208.468273959455, 30548.84725576358, 30816.229594260323, 31005.379892402027, 31246.375072498424, 31346.0, 1062.4740753327153, 1121.8036843552509, 1156.9595064172713, 1207.8570503174021, 1218.6648671615376, 15112.0, 16073.437429689904, 16097.839021609634, 16238.594035148979, 17640.470785876445, 449301.0, 455559.8888022221, 456862.0, 456903.0, 456932.0, 64162.67918660377, 64757.0, 64770.0, 64862.67568662127, 64881.35118648848, 1379.5861241627472, 1415.2332190567415, 1478.3790807860723, 1483.3399137383976, 1509.532045066055, 31574.36851262916, 31832.5225121628, 32178.678213218504, 32232.19419514531, 32584.83707581447, 52324.47675523196, 52711.472885270654, 52804.73597631987, 52824.20763688625, 52847.0, 323069.0, 323834.0, 324796.0, 325528.0, 325737.0, 37503.624963750015, 37631.81184094062, 37924.24151516899, 49527.25709114294, 50488.495115048376, 48927.75536122297, 49187.0, 49324.2601360987, 50047.499525004285, 50319.74840125776, 41462.58537414708, 42626.57373426226, 42701.0, 42823.7858810704, 42902.570974291106, 35822.28355432929, 36055.0, 36122.63877361193, 36543.086422838576, 36604.26791464209, 41550.792246038574, 41718.374224386054, 42804.357934631626, 42900.49848255296, 42907.0, 36586.07311415134, 37454.0, 39549.209015818946, 41106.0, 41985.37021944612, 28038.158855234375, 28970.7102928968, 28979.42041159123, 30486.56107511438, 30571.54142687906], "unit": "ms", "name": "ext.html", "value": 21485.440444961427}, {"lowerIsBetter": false, "replicates": [381.23982367658147, 383.3636163967814, 386.12349965578136, 389.96685281751047, 391.11998004489897, 12497.875021249785, 15354.923225383858, 17253.913730431344, 19046.90476547617, 19056.23775049, 19882.105305261262, 20168.798312016876, 20315.593688126228, 20658.793412065876, 20697.0, 5880.3825598312205, 5989.610675306091, 5990.311114221855, 5991.041433370661, 5991.670458124801, 4484.66365022623, 4590.632749380042, 5931.792387266447, 6512.934870651304, 6749.696263668122, 6489.805305840832, 6616.27221005689, 6641.169853768279, 6670.0, 6674.833129171785, 6563.245226798907, 6598.670066496656, 6601.801945941629, 6606.471482281454, 6613.669316534154, 5765.7981970631245, 5880.088586269135, 5888.558358123158, 5907.202527658754, 5918.674472903988, 23604.173853915032, 23748.525029499488, 23918.402039948967, 23942.16202432924, 24358.26925192247, 2030.857839951204, 2092.3199960013058, 2100.6428907085833, 2269.773022697717, 2353.188150088217, 10330.9483452583, 10382.948085259526, 10552.788944221073, 10675.145988320994, 10771.515281812337, 1686.991565042167, 1693.7628731977534, 1700.45585412668, 1710.1534740303505, 1713.3660545598084, 70706.0, 70760.2923970764, 71188.0, 71848.6407567964, 72252.63873680598, 7800.297973182441, 7832.373410127176, 7837.608119593998, 7869.527828330319, 7910.129885712567, 9556.904430955601, 9567.808643827084, 9570.33007689469, 9582.233421326277, 9601.0, 6266.060090986389, 6275.497960163176, 6321.589096708699, 6322.0, 6388.648624325707, 6618.7021584028835, 6749.2238392584495, 6763.323667633197, 6796.286389929085, 6807.591544507345, 3622.5290712207243, 3667.4132138857653, 3672.13704779382, 3703.703703703697, 3706.5181526401393, 1233.5374234662002, 1263.317808383481, 1263.595649392204, 1267.689416093063, 1314.7830607949581, 442.7830363122047, 497.6914313125885, 507.71567921963083, 511.3761211322181, 552.7015411677729, 10330.328528645614, 11173.83239251412, 11175.608853690082, 11209.94395028036, 11469.25449845774, 469.624300559551, 481.7687509995222, 487.3250547990987, 493.6149803153474, 506.8428787075944, 6054.969725151434, 6092.45167934888, 6199.070139479114, 6269.7492100316385, 6324.652144132025, 627377.0, 632876.0, 636312.0, 646399.0, 650939.0, 89304.5534772335, 90184.0, 90879.54560227289, 91163.0, 92151.53924230336, 501.8670052436107, 504.271327931136, 505.72438021277753, 506.4631490620028, 507.2619338861947, 10776.0, 10845.349279043283, 10919.83620245681, 10936.453177340942, 10941.070009049, 38752.0, 39275.2144957105, 39489.2102157961, 40258.0, 40468.190636186526, 52954.205686913956, 53329.733351334544, 54224.0, 54239.18641220464, 54866.451335487734, 7415.184329723618, 7435.330820226206, 7555.13115991668, 7701.6919323228685, 7718.53688778675, 13304.401301941629, 13637.659058523615, 13714.588562343146, 13746.243956582484, 13868.72262554723, 11785.116116291483, 11903.166778325434, 12039.939800300943, 12071.758564828478, 12162.756744864877, 10124.443155626512, 11622.88377116218, 11712.648620541397, 11726.472308745957, 11735.0, 12071.275723456622, 12271.386430678609, 12341.814872776737, 12358.567450139562, 12369.196002259825, 7513.4740568159705, 7546.434017448603, 7631.503952243086, 7647.541147531166, 7661.923380766121, 11709.707257318294, 11831.290122592673, 11865.525378984745, 11869.584564540544, 12201.08491863096], "unit": "ms", "name": "jquery.html", "value": 7896.114553961933}, {"lowerIsBetter": false, "replicates": [1527.3356090100806, 1568.1845440371007, 1628.1614968291324, 1775.7869055713309, 1884.7738271407434, 7316.96341518293, 7493.0, 7875.291223789858, 7958.28375446209, 7968.083670377909, 7770.883436748453, 7956.443048986574, 8040.879386809188, 8048.114707382183, 8049.315808156313, 2325.534893021394, 2348.5655153796515, 2354.234873666057, 2355.528894221154, 2356.1871154451687, 2171.4896999205175, 2210.3810932938723, 2372.146027430124, 2418.3470462974988, 2499.2252401755422, 2349.119080344871, 2410.276916924924, 2416.395901024744, 2418.407490164912, 2419.5402873454077, 2436.9634455483183, 2459.766322199388, 2464.4331803685163, 2464.544059349026, 2466.8149888758417, 2426.6845310109748, 2479.8636075015866, 2482.4042229864704, 2485.565026120422, 2486.6021436570063, 8108.310793582553, 8137.877931831027, 8179.918200818035, 8186.795330116735, 8191.467554608991, 4937.925931111036, 4958.181899986498, 4966.354373931402, 4982.676126051795, 4999.175136102539, 3149.7795154339206, 3192.5530425740417, 3265.4938484534937, 3282.96717032829, 3293.736501079908, 1034.7982143482025, 1036.4040676610903, 1036.4506811389974, 1056.1392465140887, 1059.5285098131335, 10581.259311848175, 10600.416977066257, 10606.628767993161, 10615.416152111631, 10622.78754424915, 4514.0069184779295, 4522.547745225517, 4575.794089265991, 4602.861914142581, 4614.169449499055, 9116.361854670242, 9118.224950879117, 9154.908450915538, 9157.221636160868, 9170.220531254918, 4983.252512123138, 4992.251162325608, 4994.40067191932, 4995.200767877195, 4998.125328067574, 4495.100979804052, 4525.185466616041, 4528.117017181618, 4544.977275113603, 4545.2954792007295, 3464.255185135208, 3814.6185381461632, 3855.3445914194654, 3874.4575759393706, 3880.670143037817, 1247.8876901078947, 1252.2298786246574, 1292.9094963352475, 1294.6763309172707, 1297.5588299978053, 1171.0280467212194, 1384.806127142201, 1408.8379836318954, 1429.8570142985827, 1431.3701971132668, 7794.2985131338455, 7859.174786647434, 7905.723299684483, 7917.802054948673, 7921.445498815143, 1185.3184418959133, 1194.8267501212276, 1196.9222000569935, 1206.927584344942, 1217.6773155113901, 6266.937330626726, 6276.623402595859, 6353.14232578596, 6377.521685873486, 6380.936190638127, 9330.766730831783, 9587.616495340248, 9602.135807777333, 9609.519524023772, 9609.807803843883, 9420.24638028956, 9440.339176257734, 9441.669541566012, 9476.810463790685, 9502.04979502058, 7451.925480745232, 7569.432292578079, 7573.507721998052, 7575.090989081235, 7577.0, 7434.405247580073, 7518.135414427411, 7540.208278130936, 7562.810929726801, 7571.545707257582, 8615.267702245379, 8744.475331480131, 8827.24968377695, 8837.293016558788, 8940.776480588038, 8907.777305567413, 9090.772730681785, 9097.727068187965, 9101.317401194805, 9173.220276276325, 7078.009078729085, 7132.251113632994, 7155.0, 7174.1032370953635, 7176.318249766264, 6951.930480695129, 7277.454190935595, 7926.643301051351, 7973.880391794011, 8038.236367545074, 7219.963900180465, 7288.234735352924, 7316.670749816165, 7354.338109570164, 7354.595497247703, 7066.152061752623, 7072.575645461289, 7147.749828755968, 7212.963935180501, 7220.4945653805835, 7421.035265415461, 7466.589337586268, 7469.701211951461, 7484.476086673881, 7495.175530691728, 6720.428763555153, 6811.352921472452, 6825.897611535732, 6849.863002739818, 6867.656617169221, 6859.142607174103, 6883.621400823003, 6895.138107736533, 6899.344562266577, 6903.965480172567], "unit": "ms", "name": "mootools.html", "value": 4720.221600634148}, {"lowerIsBetter": false, "replicates": [359.4679873786795, 363.9745217834749, 365.3660898341377, 368.02840501077145, 373.02640109314683, 5843.152742852284, 5895.528357731382, 5913.379095195007, 5918.230630018103, 5922.052471604538, 5772.480476757091, 5813.941860581393, 5859.6777177255235, 5861.648301101937, 5879.441453061963, 4611.907761844761, 4618.1456430560365, 4619.815207391717, 4621.491635920046, 4626.560476754703, 4618.861434156964, 4626.259798432252, 4627.745473998929, 4632.351470794091, 4634.0, 4514.97742511287, 4595.0, 4624.699394539361, 4673.579377855992, 4677.976610116962, 4631.351610774477, 4641.698289611165, 4650.627949764011, 4666.90666186676, 4670.2060649689465, 3901.941470877939, 4117.238310912491, 4129.669626429908, 4130.607592278759, 4136.9793151034055, 5551.861203469905, 5595.608307418483, 5659.0, 5668.659880407147, 5668.858278543028, 5317.2821669074565, 5323.653962492425, 5326.520613144836, 5330.9733451332495, 5333.946660533384, 6211.968940155315, 6217.129601855744, 6219.34696856828, 6222.688865556704, 6226.2839773426185, 4379.146066517031, 4426.734395936254, 4453.376527286183, 4456.465224173087, 4508.346289787963, 6381.61710297379, 6438.967805160991, 6443.226812782496, 6443.871122577569, 6447.355264473562, 4440.245158323093, 4447.533009034069, 4447.888802779957, 4448.266036104006, 4451.06527629195, 4532.637389008872, 4532.9773351133035, 4534.455865296186, 4536.977315113403, 4540.704854184468, 5122.359705036871, 5267.841964741064, 5277.445868183862, 5286.920696189561, 5292.153255479105, 6348.968255158787, 6349.777757778455, 6352.6823658816875, 6355.046742988497, 6359.841003974845, 1641.2040160522138, 1675.2126500544725, 1675.31312162013, 1675.4136052381568, 1677.3290683726364, 1126.6563698072166, 1127.8026345389524, 1128.4527004402858, 1145.7364806094645, 1155.179822326141, 6151.231096112986, 6153.600015998945, 6157.661328626879, 6160.383961603804, 6164.6917654117115, 6538.313477084933, 6548.770793022221, 6553.0, 6554.737810487527, 6562.048502967043, 5980.970095149496, 6125.142480052797, 6144.17053697754, 6146.938530614726, 6149.477294429934, 3583.605803361628, 3591.964080359163, 3609.0, 3615.692666123409, 3618.0, 6459.838504037437, 6546.149000629887, 6591.835204119935, 6682.498812589075, 6688.097106890507, 6669.1330127083165, 6676.86646267072, 6679.265280819106, 6691.0, 6693.263740988487, 6633.4693224541925, 6656.567323124078, 6656.733730650816, 6658.800235992928, 6666.300038495985, 6389.297177310399, 6498.805035848932, 6501.44737697301, 6503.674816259074, 6504.0, 6508.251551071688, 6508.674566271762, 6509.316521765147, 6513.837154071186, 6515.0, 6739.696713647995, 6742.69657865407, 6751.459883209233, 6753.15585551806, 6753.932460675527, 4514.841980530666, 4599.356090147449, 4603.3785438965315, 4603.58567728906, 4604.631629469702, 6554.80335589933, 6599.703013364506, 6601.702923368364, 6604.504662150454, 6606.933930660632, 6406.87186256263, 6416.743330266924, 6420.903686444613, 6430.582012169194, 6431.196100487439, 6252.062190671436, 6331.335209803088, 6336.651484168415, 6337.683115844097, 6406.167198264196, 6234.127222188988, 6236.34518375564, 6236.937630623635, 6243.0, 6249.25008998923, 6368.42684158428, 6375.203099612549, 6375.330590287953, 6377.617342959437, 6378.362163783585, 6116.113163591343, 6209.59637623553, 6210.192674952227, 6216.844578885564, 6218.626882387071], "unit": "ms", "name": "prototype.html", "value": 4810.415663844794}, {"lowerIsBetter": false, "replicates": [801.483043436983, 860.6944534690181, 875.6322344615261, 929.660673854043, 945.5225111318783, 15302.0, 15645.295961681722, 15681.372745090212, 15688.450904218354, 15693.607659808511, 12960.54638087667, 13029.413676384562, 13047.15193512421, 13048.347582620878, 13048.869511304883, 751.1924680967954, 761.0980987529767, 899.7030979776658, 901.166421060518, 915.8168366326728, 907.541691445819, 907.8002839375326, 907.9818403631923, 910.7859652981545, 915.6474757218452, 808.0303635637259, 950.5437390052779, 957.248559880494, 959.4243453927658, 959.4627008875052, 813.780279324582, 931.9673811416602, 949.8290307744603, 950.396498223626, 951.4338968313842, 702.6802804723839, 705.8270723672733, 706.3819158236543, 707.9150501939748, 708.4155571653406, 14534.781978270334, 14647.12117272967, 14666.046706964013, 14681.412743490248, 14697.77953330701, 12294.446749896186, 12981.286029268387, 13004.869951300461, 13103.148295360867, 13113.409896554678, 9304.488253146073, 9335.579898904565, 9441.339106262565, 9536.427814331162, 9577.712668619952, 3346.3474622448634, 3394.4568868980846, 3448.137965508623, 3459.636738142484, 3459.8616055357757, 50180.74909625465, 50190.7490462549, 50295.49704502945, 51144.23283650748, 52553.211701824504, 9613.807723845484, 9725.756856078513, 9783.510824458748, 9785.26610504215, 9799.804003919882, 20522.58954820895, 20558.79441205569, 20652.0, 20681.793182067988, 20758.896205519177, 7248.238934911864, 7288.234735352818, 7365.7790266292095, 7386.0, 7559.962200189074, 4159.126583417456, 4206.398451267057, 4207.453031105937, 4222.915541689149, 4256.723312984646, 3264.183954011497, 3304.1078908694517, 3304.9173770655443, 3306.04124803809, 3316.3533111043116, 515.38926372249, 517.981870634526, 520.9921851172236, 521.0464849325725, 523.1368242400071, 525.3879230696273, 539.4147350125158, 573.87948530809, 613.4172536090732, 631.0471188505298, 7972.123066462685, 8101.432899697083, 8341.791455213668, 8504.14958504157, 8631.827363452696, 549.9202615620712, 579.4408395897979, 603.3001718007179, 635.8664680417072, 637.877335888839, 3808.200277941608, 3834.9233015339537, 3866.2654095721723, 3903.6486716195677, 3973.7615743055508, 63531.36468635347, 63726.362736372044, 64277.0, 64336.03495947565, 65111.0, 56000.719996399755, 56587.0, 56622.43377566254, 57135.0, 59885.700571497735, 53818.73090634522, 53921.0, 54006.459935400926, 55103.724481378136, 55569.0, 8102.554359510284, 8166.510009399455, 8219.671213151407, 8355.707550235713, 8406.15938406179, 39651.80174099111, 40348.79825600853, 41091.0, 41173.588264118174, 41400.1719965605, 49328.26007609961, 49371.75314123406, 52655.05004504297, 52961.0, 53677.463225367246, 8331.208535189147, 8372.28835548985, 8413.116622754522, 8513.106123856905, 8667.566621668766, 12529.686757831127, 12554.686132846751, 12639.747205056032, 12731.55439559611, 12966.80549791735, 10899.02548837374, 10911.345319280868, 10914.563417463212, 10969.396683182502, 11009.83485247738, 11616.535338586362, 11621.76756464883, 11836.585719499777, 11861.822072668745, 11916.940415297868, 9444.0555944405, 9980.101790838859, 10413.895861041596, 10684.946575267073, 10689.625863095065, 9491.145796878038, 9929.602815887572, 9995.550200241152, 10030.197584193102, 10399.428031458343, 8522.872156917776, 8731.694390696295, 8784.956075219583, 9088.818223635622, 9091.090890910857], "unit": "ms", "name": "yui.html", "value": 6444.058317230567}], "name": "dromaeo_css", "value": 7181.501905027556}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 109.0, 103.0, 110.0, 112.0, 110.0, 97.0, 109.0, 108.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 107.3}, {"lowerIsBetter": true, "replicates": [144.0, 120.0, 142.0, 157.0, 125.0, 148.0, 141.0, 121.0, 154.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 138.1}, {"lowerIsBetter": true, "replicates": [161.0, 158.0, 160.0, 160.0, 159.0, 158.0, 158.0, 159.0, 159.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 159.3}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 71.0, 149.0, 72.0, 71.0, 70.0, 71.0, 177.0, 77.0], "unit": "ms", "name": "audio-fft", "value": 90.0}, {"lowerIsBetter": true, "replicates": [89.0, 89.0, 143.0, 89.0, 94.0, 89.0, 130.0, 89.0, 90.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 103.2}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [53.0, 56.0, 57.0, 55.0, 55.0, 55.0, 57.0, 63.0, 55.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 55.9}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 63.0, 64.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.2}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 78.0, 77.0, 78.0, 76.0, 76.0, 77.0, 78.0, 78.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 77.2}, {"lowerIsBetter": true, "replicates": [108.0, 114.0, 121.0, 108.0, 113.0, 113.0, 120.0, 106.0, 119.0, 106.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 112.8}, {"lowerIsBetter": true, "replicates": [138.0, 129.0, 139.0, 136.0, 135.0, 134.0, 138.0, 134.0, 138.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 135.8}, {"lowerIsBetter": true, "replicates": [66.0, 63.0, 61.0, 63.0, 61.0, 62.0, 61.0, 65.0, 61.0, 60.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 62.3}], "name": "kraken", "value": 1455.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.47882949158085], "unit": "score", "name": "Richards", "value": 215.94233399999993}, {"lowerIsBetter": false, "replicates": [170.24174327545114], "unit": "score", "name": "DeltaBlue", "value": 388.3771319999999}, {"lowerIsBetter": false, "replicates": [279.3296089385475], "unit": "score", "name": "Encrypt", "value": 952.9279799999998}, {"lowerIsBetter": false, "replicates": [5055.555555555556], "unit": "score", "name": "Decrypt", "value": 52.65118681318681}, {"lowerIsBetter": false, "replicates": [942.5070688030161], "unit": "score", "name": "RayTrace", "value": 785.1283289999999}, {"lowerIsBetter": false, "replicates": [554.016620498615], "unit": "score", "name": "Earley", "value": 1202.9657150000005}, {"lowerIsBetter": false, "replicates": [10443.298969072164], "unit": "score", "name": "Boyer", "value": 63.81728627838104}, {"lowerIsBetter": false, "replicates": [24166.666666666668], "unit": "score", "name": "RegExp", "value": 37.69593103448274}, {"lowerIsBetter": false, "replicates": [534.1450502911594], "unit": "score", "name": "Splay", "value": 152.5634281466799}, {"lowerIsBetter": false, "replicates": [4878.048780487805], "unit": "score", "name": "NavierStokes", "value": 304.2200000000002}], "name": "v8_7", "value": 23246.265327218214}]} 04:29:17 INFO - RETURN: dromaeo_css: 7181.50 04:29:17 INFO - RETURN: kraken: 1455.30 04:29:17 INFO - RETURN: v8_7: 23246.27 04:29:17 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23246.27"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1455.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7181.50"}}} 04:29:17 INFO - Return code: 0 04:29:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:29:17 INFO - # TBPL SUCCESS # 04:29:17 INFO - Running post-action listener: _resource_record_post_action 04:29:17 INFO - Running post-run listener: _resource_record_post_run 04:29:18 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 315392; Write bytes: 498851840; Read time: 52; Write time: 576372 04:29:18 INFO - install - Wall time: 14s; CPU: 15.0%; Read bytes: 0; Write bytes: 238051328; Read time: 0; Write time: 336924 04:29:18 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 315392; Write bytes: 260800512; Read time: 52; Write time: 239448 04:29:18 INFO - Running post-run listener: _upload_blobber_files 04:29:18 INFO - Blob upload gear active. 04:29:18 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:29:18 INFO - Copying logs to upload dir... 04:29:18 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1252.247771 ========= master_lag: 0.35 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-01-25 04:29:18.927053) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 04:29:18.934680) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009968 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 04:29:18.958412) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:29:18.958784) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1453723704.65683-1602093973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:29:19.008386) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 04:29:19.008753) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 04:29:19.009092) ========= ========= Total master_lag: 0.57 =========