builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-053 starttime: 1453723721.19 results: success (0) buildid: 20160118120031 builduid: 818fd5d38f994d05b8cc299dc07eda1c revision: f84fcce02b11 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:41.193318) ========= 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:41.193734) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:41.194019) ========= 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=920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006039 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:41.216697) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:41.217002) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:41.234515) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:41.234868) ========= 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=920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.83 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:42.069088) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:42.069423) ========= 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:42.069781) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:42.070051) ========= 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=920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 04:08:42-- 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% 225M=0s 2016-01-25 04:08:42 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.183139 ========= master_lag: 0.26 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:42.508897) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:42.512135) ========= 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=920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016572 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:42.540229) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-25 04:08:42.540592) ========= 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=920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 04:08:42,817 Setting DEBUG logging. 2016-01-25 04:08:42,817 attempt 1/10 2016-01-25 04:08:42,817 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:43,840 unpacking tar archive at: mozilla-beta-f84fcce02b11/testing/mozharness/ program finished with exit code 0 elapsedTime=1.321560 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-25 04:08:43.877998) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:43.878367) ========= 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=920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False f84fcce02b11 program finished with exit code 0 elapsedTime=0.004644 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:43.928284) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:43.928619) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:43.938670) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2016-01-25 04:08:43.939071) ========= /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=920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:08:44 INFO - MultiFileLogger online at 20160125 04:08:44 in /builds/slave/test-pgo 04:08:44 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:44 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:08:44 INFO - {'append_to_log': False, 04:08:44 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:08:44 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:08:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:08:44 INFO - 'branch': 'Mozilla-Beta', 04:08:44 INFO - 'buildbot_json_path': 'buildprops.json', 04:08:44 INFO - 'config_files': ('talos/linux_config.py',), 04:08:44 INFO - 'default_actions': ('clobber', 04:08:44 INFO - 'read-buildbot-config', 04:08:44 INFO - 'download-and-extract', 04:08:44 INFO - 'populate-webroot', 04:08:44 INFO - 'create-virtualenv', 04:08:44 INFO - 'install', 04:08:44 INFO - 'run-tests'), 04:08:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:08:44 INFO - 'download_minidump_stackwalk': True, 04:08:44 INFO - 'download_symbols': 'ondemand', 04:08:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:08:44 INFO - 'tooltool.py': '/tools/tooltool.py', 04:08:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:08:44 INFO - '/tools/misc-python/virtualenv.py')}, 04:08:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:08:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:08:44 INFO - 'installer_path': 'installer.exe', 04:08:44 INFO - 'log_level': 'info', 04:08:44 INFO - 'log_name': 'talos', 04:08:44 INFO - 'log_to_console': True, 04:08:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:08:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:08:44 INFO - 'opt_config_files': (), 04:08:44 INFO - 'pip_index': False, 04:08:44 INFO - 'sps_profile': False, 04:08:44 INFO - 'sps_profile_interval': 0, 04:08:44 INFO - 'suite': 'dromaeojs', 04:08:44 INFO - 'system_bits': '32', 04:08:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:08:44 INFO - 'title': 'talos-linux64-ix-053', 04:08:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:08:44 INFO - 'use_talos_json': True, 04:08:44 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:08:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:08:44 INFO - 'work_dir': 'build'} 04:08:44 INFO - ##### 04:08:44 INFO - ##### Running clobber step. 04:08:44 INFO - ##### 04:08:44 INFO - Running pre-action listener: _resource_record_pre_action 04:08:44 INFO - Running main action method: clobber 04:08:44 INFO - rmtree: /builds/slave/test-pgo/build 04:08:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:08:44 INFO - Running post-action listener: _resource_record_post_action 04:08:44 INFO - ##### 04:08:44 INFO - ##### Running read-buildbot-config step. 04:08:44 INFO - ##### 04:08:44 INFO - Running pre-action listener: _resource_record_pre_action 04:08:44 INFO - Running main action method: read_buildbot_config 04:08:44 INFO - Using buildbot properties: 04:08:44 INFO - { 04:08:44 INFO - "properties": { 04:08:44 INFO - "buildnumber": 85, 04:08:44 INFO - "product": "firefox", 04:08:44 INFO - "script_repo_revision": "production", 04:08:44 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 04:08:44 INFO - "repository": "", 04:08:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 04:08:44 INFO - "buildid": "20160118120031", 04:08:44 INFO - "slavename": "talos-linux64-ix-053", 04:08:44 INFO - "pgo_build": "True", 04:08:44 INFO - "basedir": "/builds/slave/test-pgo", 04:08:44 INFO - "project": "", 04:08:44 INFO - "platform": "ubuntu64_hw", 04:08:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:08:44 INFO - "slavebuilddir": "test", 04:08:44 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 04:08:44 INFO - "branch": "mozilla-beta", 04:08:44 INFO - "repo_path": "releases/mozilla-beta", 04:08:44 INFO - "stage_platform": "linux64-pgo", 04:08:44 INFO - "builduid": "818fd5d38f994d05b8cc299dc07eda1c", 04:08:44 INFO - "revision": "f84fcce02b11" 04:08:44 INFO - }, 04:08:44 INFO - "sourcestamp": { 04:08:44 INFO - "repository": "", 04:08:44 INFO - "hasPatch": false, 04:08:44 INFO - "project": "", 04:08:44 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 04:08:44 INFO - "changes": [ 04:08:44 INFO - { 04:08:44 INFO - "category": null, 04:08:44 INFO - "files": [ 04:08:44 INFO - { 04:08:44 INFO - "url": null, 04:08:44 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:44 INFO - } 04:08:44 INFO - ], 04:08:44 INFO - "repository": "", 04:08:44 INFO - "rev": "f84fcce02b11", 04:08:44 INFO - "who": "sendchange", 04:08:44 INFO - "when": 1453155801, 04:08:44 INFO - "number": 7475630, 04:08:44 INFO - "comments": "Bug 1233982 - Do not fetch autofill icons from the network. r=adw a=ritu CLOSED TREE", 04:08:44 INFO - "project": "", 04:08:44 INFO - "at": "Mon 18 Jan 2016 14:23:21", 04:08:44 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 04:08:44 INFO - "revlink": "", 04:08:44 INFO - "properties": [ 04:08:44 INFO - [ 04:08:44 INFO - "buildid", 04:08:44 INFO - "20160118120031", 04:08:44 INFO - "Change" 04:08:44 INFO - ], 04:08:44 INFO - [ 04:08:44 INFO - "builduid", 04:08:44 INFO - "818fd5d38f994d05b8cc299dc07eda1c", 04:08:44 INFO - "Change" 04:08:44 INFO - ], 04:08:44 INFO - [ 04:08:44 INFO - "pgo_build", 04:08:44 INFO - "True", 04:08:44 INFO - "Change" 04:08:44 INFO - ] 04:08:44 INFO - ], 04:08:44 INFO - "revision": "f84fcce02b11" 04:08:44 INFO - } 04:08:44 INFO - ], 04:08:44 INFO - "revision": "f84fcce02b11" 04:08:44 INFO - } 04:08:44 INFO - } 04:08:44 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:44 INFO - Running post-action listener: _resource_record_post_action 04:08:44 INFO - ##### 04:08:44 INFO - ##### Running download-and-extract step. 04:08:44 INFO - ##### 04:08:44 INFO - Running pre-action listener: _resource_record_pre_action 04:08:44 INFO - Running main action method: download_and_extract 04:08:44 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:44 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/test_packages.json 04:08:44 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:44 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:44 INFO - Downloaded 1270 bytes. 04:08:44 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:08:44 INFO - Using the following test package requirements: 04:08:44 INFO - {u'common': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 04:08:44 INFO - u'cppunittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:44 INFO - u'firefox-44.0.en-US.linux-x86_64.cppunittest.tests.zip'], 04:08:44 INFO - u'jittest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:44 INFO - u'jsshell-linux-x86_64.zip'], 04:08:44 INFO - u'mochitest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:44 INFO - u'firefox-44.0.en-US.linux-x86_64.mochitest.tests.zip'], 04:08:44 INFO - u'mozbase': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 04:08:44 INFO - u'reftest': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:44 INFO - u'firefox-44.0.en-US.linux-x86_64.reftest.tests.zip'], 04:08:44 INFO - u'talos': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:44 INFO - u'firefox-44.0.en-US.linux-x86_64.talos.tests.zip'], 04:08:44 INFO - u'web-platform': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:44 INFO - u'firefox-44.0.en-US.linux-x86_64.web-platform.tests.zip'], 04:08:44 INFO - u'webapprt': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'], 04:08:44 INFO - u'xpcshell': [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip', 04:08:44 INFO - u'firefox-44.0.en-US.linux-x86_64.xpcshell.tests.zip']} 04:08:44 INFO - Downloading packages: [u'firefox-44.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:44 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:44 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:44 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:45 INFO - Downloaded 22573307 bytes. 04:08:45 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:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 04:08:45 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:46 INFO - Return code: 0 04:08:46 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:46 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:46 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:46 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:46 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:46 WARNING - Socket error when accessing http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.common.tests.zip: [Errno 104] Connection reset by peer 04:08:46 INFO - retry: attempt #1 caught exception: [Errno 104] Connection reset by peer 04:08:46 INFO - retry: Failed, sleeping 30 seconds before retrying 04:09:16 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 #2 04:09:17 INFO - Downloaded 22573307 bytes. 04:09:17 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:09:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.common.tests.zip 04:09:17 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:09:18 INFO - Return code: 0 04:09:18 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:18 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:09:18 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:09:18 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:09:18 WARNING - Socket error when accessing http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1453147231/firefox-44.0.en-US.linux-x86_64.talos.tests.zip: [Errno 104] Connection reset by peer 04:09:18 INFO - retry: attempt #1 caught exception: [Errno 104] Connection reset by peer 04:09:18 INFO - retry: Failed, sleeping 30 seconds before retrying 04:09:48 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 #2 04:09:49 INFO - Downloaded 11131970 bytes. 04:09:49 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:09:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0.en-US.linux-x86_64.talos.tests.zip 04:09:49 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:09:49 INFO - Return code: 0 04:09: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:09:49 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:09:49 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:09:49 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:09:50 INFO - Downloaded 56626174 bytes. 04:09:50 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:09:50 INFO - mkdir: /builds/slave/test-pgo/properties 04:09:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:09:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:09:50 INFO - Contents: 04:09:50 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:09:50 INFO - Running post-action listener: _resource_record_post_action 04:09:50 INFO - Running post-action listener: set_extra_try_arguments 04:09:50 INFO - ##### 04:09:50 INFO - ##### Running populate-webroot step. 04:09:50 INFO - ##### 04:09:50 INFO - Running pre-action listener: _resource_record_pre_action 04:09:50 INFO - Running main action method: populate_webroot 04:09:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:09:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:09:50 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:09:50 INFO - '../fennec_ids.txt'], 04:09:50 INFO - 'tests': ['tcheck2']}, 04:09:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:09:50 INFO - '--tppagecycles', 04:09:50 INFO - '7'], 04:09:50 INFO - 'tests': ['tsvgm']}}, 04:09:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:09:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:09:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:09:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:09:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:09:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:09:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:09:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:50 INFO - 'talos_options': ['--e10s'], 04:09:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:09:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:50 INFO - 'tests': ['damp', 'tps']}, 04:09:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:50 INFO - 'talos_options': ['--e10s'], 04:09:50 INFO - 'tests': ['damp', 'tps']}, 04:09:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:09:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:09:50 INFO - 'other': {'tests': ['a11yr', 04:09:50 INFO - 'ts_paint', 04:09:50 INFO - 'tpaint', 04:09:50 INFO - 'sessionrestore', 04:09:50 INFO - 'sessionrestore_no_auto_restore']}, 04:09:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:09:50 INFO - 'tests': ['a11yr', 04:09:50 INFO - 'ts_paint', 04:09:50 INFO - 'tpaint', 04:09:50 INFO - 'sessionrestore', 04:09:50 INFO - 'sessionrestore_no_auto_restore']}, 04:09:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:09:50 INFO - 'tests': ['a11yr', 04:09:50 INFO - 'ts_paint', 04:09:50 INFO - 'tpaint', 04:09:50 INFO - 'sessionrestore', 04:09:50 INFO - 'sessionrestore_no_auto_restore']}, 04:09:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:09:50 INFO - 'tests': ['a11yr', 04:09:50 INFO - 'ts_paint', 04:09:50 INFO - 'tpaint', 04:09:50 INFO - 'sessionrestore', 04:09:50 INFO - 'sessionrestore_no_auto_restore']}, 04:09:50 INFO - 'other_l64': {'tests': ['a11yr', 04:09:50 INFO - 'ts_paint', 04:09:50 INFO - 'tpaint', 04:09:50 INFO - 'sessionrestore', 04:09:50 INFO - 'sessionrestore_no_auto_restore']}, 04:09:50 INFO - 'other_nol64': {'tests': ['a11yr', 04:09:50 INFO - 'ts_paint', 04:09:50 INFO - 'tpaint', 04:09:50 INFO - 'sessionrestore', 04:09:50 INFO - 'sessionrestore_no_auto_restore']}, 04:09:50 INFO - 'svgr': {'tests': ['tsvgx', 04:09:50 INFO - 'tsvgr_opacity', 04:09:50 INFO - 'tart', 04:09:50 INFO - 'tscrollx', 04:09:50 INFO - 'cart']}, 04:09:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:09:50 INFO - 'tests': ['tsvgx', 04:09:50 INFO - 'tsvgr_opacity', 04:09:50 INFO - 'tart', 04:09:50 INFO - 'tscrollx', 04:09:50 INFO - 'cart']}, 04:09:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:50 INFO - 'tests': ['tp5o']}, 04:09:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:50 INFO - 'talos_options': ['--e10s'], 04:09:50 INFO - 'tests': ['tp5o']}, 04:09:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:50 INFO - 'talos_options': ['--xperf_path', 04:09:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:09:50 INFO - 'tests': ['tp5n']}, 04:09:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:50 INFO - 'talos_options': ['--e10s', 04:09:50 INFO - '--xperf_path', 04:09:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:09:50 INFO - 'tests': ['tp5n']}}, 04:09:50 INFO - 'talos.zip': {'path': '', 04:09:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:09:50 INFO - Running post-action listener: _resource_record_post_action 04:09:50 INFO - ##### 04:09:50 INFO - ##### Running create-virtualenv step. 04:09:50 INFO - ##### 04:09:50 INFO - Running pre-action listener: _resource_record_pre_action 04:09:50 INFO - Running main action method: create_virtualenv 04:09:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:09:50 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:09:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:09:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:09:50 INFO - Using real prefix '/usr' 04:09:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:09:51 INFO - Installing distribute.............................................................................................................................................................................................done. 04:09:53 INFO - Installing pip.................done. 04:09:53 INFO - Return code: 0 04:09:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:09:53 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:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:53 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:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:53 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 0x7ffd35749f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271e350>, '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 0x271f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271f6e0>, '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': '920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290', '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:09:53 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:09:53 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:09:53 INFO - Using env: {'DISPLAY': ':0', 04:09:53 INFO - 'HOME': '/home/cltbld', 04:09:53 INFO - 'LANG': 'en_US.UTF-8', 04:09:53 INFO - 'LANGUAGE': 'en_US:en', 04:09:53 INFO - 'LOGNAME': 'cltbld', 04:09:53 INFO - 'MAIL': '/var/mail/cltbld', 04:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:53 INFO - 'MOZ_NO_REMOTE': '1', 04:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:53 INFO - 'NO_EM_RESTART': '1', 04:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:09:53 INFO - 'PWD': '/builds/slave/test-pgo', 04:09:53 INFO - 'SHELL': '/bin/bash', 04:09:53 INFO - 'SHLVL': '1', 04:09:53 INFO - 'TERM': 'linux', 04:09:53 INFO - 'TMOUT': '86400', 04:09:53 INFO - 'USER': 'cltbld', 04:09:53 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290', 04:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:53 INFO - '_': '/tools/buildbot/bin/python'} 04:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:53 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:09:53 INFO - Cleaning up... 04:09:53 INFO - Return code: 0 04:09:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:09:53 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:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:53 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:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:53 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 0x7ffd35749f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271e350>, '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 0x271f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271f6e0>, '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': '920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290', '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:09:53 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:09:53 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:09:53 INFO - Using env: {'DISPLAY': ':0', 04:09:53 INFO - 'HOME': '/home/cltbld', 04:09:53 INFO - 'LANG': 'en_US.UTF-8', 04:09:53 INFO - 'LANGUAGE': 'en_US:en', 04:09:53 INFO - 'LOGNAME': 'cltbld', 04:09:53 INFO - 'MAIL': '/var/mail/cltbld', 04:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:53 INFO - 'MOZ_NO_REMOTE': '1', 04:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:53 INFO - 'NO_EM_RESTART': '1', 04:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:09:53 INFO - 'PWD': '/builds/slave/test-pgo', 04:09:53 INFO - 'SHELL': '/bin/bash', 04:09:53 INFO - 'SHLVL': '1', 04:09:53 INFO - 'TERM': 'linux', 04:09:53 INFO - 'TMOUT': '86400', 04:09:53 INFO - 'USER': 'cltbld', 04:09:53 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290', 04:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:53 INFO - '_': '/tools/buildbot/bin/python'} 04:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:53 INFO - Downloading/unpacking psutil>=0.7.1 04:09:53 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:09:53 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:09:53 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:09:53 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:09:53 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:09:53 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:09:55 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:09:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:09:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:09:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:55 INFO - Installing collected packages: psutil 04:09:55 INFO - Running setup.py install for psutil 04:09:55 INFO - building 'psutil._psutil_linux' extension 04:09:55 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:09:55 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:09:55 INFO - building 'psutil._psutil_posix' extension 04:09:55 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:09:56 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:09:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:56 INFO - Successfully installed psutil 04:09:56 INFO - Cleaning up... 04:09:56 INFO - Return code: 0 04:09:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:56 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 0x7ffd35749f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271e350>, '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 0x271f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271f6e0>, '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': '920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290', '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:09:56 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:09:56 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:09:56 INFO - Using env: {'DISPLAY': ':0', 04:09:56 INFO - 'HOME': '/home/cltbld', 04:09:56 INFO - 'LANG': 'en_US.UTF-8', 04:09:56 INFO - 'LANGUAGE': 'en_US:en', 04:09:56 INFO - 'LOGNAME': 'cltbld', 04:09:56 INFO - 'MAIL': '/var/mail/cltbld', 04:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:56 INFO - 'MOZ_NO_REMOTE': '1', 04:09:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:56 INFO - 'NO_EM_RESTART': '1', 04:09:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:09:56 INFO - 'PWD': '/builds/slave/test-pgo', 04:09:56 INFO - 'SHELL': '/bin/bash', 04:09:56 INFO - 'SHLVL': '1', 04:09:56 INFO - 'TERM': 'linux', 04:09:56 INFO - 'TMOUT': '86400', 04:09:56 INFO - 'USER': 'cltbld', 04:09:56 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290', 04:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:56 INFO - '_': '/tools/buildbot/bin/python'} 04:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:09:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:09:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:09:58 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:09:58 INFO - Installing collected packages: mozsystemmonitor 04:09:58 INFO - Running setup.py install for mozsystemmonitor 04:09:58 INFO - Successfully installed mozsystemmonitor 04:09:58 INFO - Cleaning up... 04:09:58 INFO - Return code: 0 04:09:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:58 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 0x7ffd35749f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271e350>, '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 0x271f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271f6e0>, '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': '920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290', '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:09:58 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:09:58 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:09:58 INFO - Using env: {'DISPLAY': ':0', 04:09:58 INFO - 'HOME': '/home/cltbld', 04:09:58 INFO - 'LANG': 'en_US.UTF-8', 04:09:58 INFO - 'LANGUAGE': 'en_US:en', 04:09:58 INFO - 'LOGNAME': 'cltbld', 04:09:58 INFO - 'MAIL': '/var/mail/cltbld', 04:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:58 INFO - 'MOZ_NO_REMOTE': '1', 04:09:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:58 INFO - 'NO_EM_RESTART': '1', 04:09:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:09:58 INFO - 'PWD': '/builds/slave/test-pgo', 04:09:58 INFO - 'SHELL': '/bin/bash', 04:09:58 INFO - 'SHLVL': '1', 04:09:58 INFO - 'TERM': 'linux', 04:09:58 INFO - 'TMOUT': '86400', 04:09:58 INFO - 'USER': 'cltbld', 04:09:58 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290', 04:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:58 INFO - '_': '/tools/buildbot/bin/python'} 04:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:58 INFO - Downloading/unpacking blobuploader==1.2.4 04:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:00 INFO - Downloading blobuploader-1.2.4.tar.gz 04:10:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:10:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:10:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:10:00 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:10:00 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:10:00 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:10:00 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:10:00 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:10:00 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:10:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:10:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:10:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:10:00 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:10:00 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:10:00 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:10:00 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:10:00 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:10:00 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:10:01 INFO - Downloading docopt-0.6.1.tar.gz 04:10:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:10:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:10:01 INFO - Installing collected packages: blobuploader, requests, docopt 04:10:01 INFO - Running setup.py install for blobuploader 04:10:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:10:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:10:01 INFO - Running setup.py install for requests 04:10:01 INFO - Running setup.py install for docopt 04:10:01 INFO - Successfully installed blobuploader requests docopt 04:10:01 INFO - Cleaning up... 04:10:01 INFO - Return code: 0 04:10:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:01 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 0x7ffd35749f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271e350>, '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 0x271f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271f6e0>, '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': '920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290', '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:10:01 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:10:01 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:10:01 INFO - Using env: {'DISPLAY': ':0', 04:10:01 INFO - 'HOME': '/home/cltbld', 04:10:01 INFO - 'LANG': 'en_US.UTF-8', 04:10:01 INFO - 'LANGUAGE': 'en_US:en', 04:10:01 INFO - 'LOGNAME': 'cltbld', 04:10:01 INFO - 'MAIL': '/var/mail/cltbld', 04:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:01 INFO - 'MOZ_NO_REMOTE': '1', 04:10:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:01 INFO - 'NO_EM_RESTART': '1', 04:10:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:10:01 INFO - 'PWD': '/builds/slave/test-pgo', 04:10:01 INFO - 'SHELL': '/bin/bash', 04:10:01 INFO - 'SHLVL': '1', 04:10:01 INFO - 'TERM': 'linux', 04:10:01 INFO - 'TMOUT': '86400', 04:10:01 INFO - 'USER': 'cltbld', 04:10:01 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290', 04:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:01 INFO - '_': '/tools/buildbot/bin/python'} 04:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:10:01 INFO - Running setup.py (path:/tmp/pip-dv1an6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:10:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:10:01 INFO - Running setup.py (path:/tmp/pip-uIeEts-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:10:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:10:02 INFO - Running setup.py (path:/tmp/pip-VfFvsg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:10:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:10:02 INFO - Running setup.py (path:/tmp/pip-DmGlkf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:10:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:10:02 INFO - Running setup.py (path:/tmp/pip-V5XP_l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:10:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:10:02 INFO - Running setup.py (path:/tmp/pip-E9_ykZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:10:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:10:02 INFO - Running setup.py (path:/tmp/pip-bgZqD8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:10:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:10:02 INFO - Running setup.py (path:/tmp/pip-s5GtwH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:10:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:10:02 INFO - Running setup.py (path:/tmp/pip-4cwWAt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:10:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:10:02 INFO - Running setup.py (path:/tmp/pip-7nX_xB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:10:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:10:02 INFO - Running setup.py (path:/tmp/pip-VUDKnF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:10:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:10:02 INFO - Running setup.py (path:/tmp/pip-Z0zqha-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:10:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:10:02 INFO - Running setup.py (path:/tmp/pip-75YbXj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:10:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:10:02 INFO - Running setup.py (path:/tmp/pip-kWPBq7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:10:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:10:02 INFO - Running setup.py (path:/tmp/pip-5GG_wz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:10:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:10:02 INFO - Running setup.py (path:/tmp/pip-nekmVQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:10:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:10:03 INFO - Running setup.py (path:/tmp/pip-Nb4mFi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:10:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:10:03 INFO - Running setup.py install for manifestparser 04:10:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:10:03 INFO - Running setup.py install for mozcrash 04:10:03 INFO - Running setup.py install for mozdebug 04:10:03 INFO - Running setup.py install for mozdevice 04:10:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:10:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:10:03 INFO - Running setup.py install for mozfile 04:10:03 INFO - Running setup.py install for mozhttpd 04:10:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:10:03 INFO - Running setup.py install for mozinfo 04:10:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:10:03 INFO - Running setup.py install for mozInstall 04:10:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:10:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:10:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:10:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:10:03 INFO - Running setup.py install for mozleak 04:10:03 INFO - Running setup.py install for mozlog 04:10:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:10:04 INFO - Running setup.py install for moznetwork 04:10:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:10:04 INFO - Running setup.py install for mozprocess 04:10:04 INFO - Running setup.py install for mozprofile 04:10:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:10:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:10:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:10:04 INFO - Running setup.py install for mozrunner 04:10:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:10:04 INFO - Running setup.py install for mozscreenshot 04:10:04 INFO - Running setup.py install for moztest 04:10:04 INFO - Running setup.py install for mozversion 04:10:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:10:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:10:04 INFO - Cleaning up... 04:10:04 INFO - Return code: 0 04:10:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:04 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 0x7ffd35749f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271e350>, '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 0x271f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271f6e0>, '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': '920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290', '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:10:04 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:10:04 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:10:04 INFO - Using env: {'DISPLAY': ':0', 04:10:04 INFO - 'HOME': '/home/cltbld', 04:10:04 INFO - 'LANG': 'en_US.UTF-8', 04:10:04 INFO - 'LANGUAGE': 'en_US:en', 04:10:04 INFO - 'LOGNAME': 'cltbld', 04:10:04 INFO - 'MAIL': '/var/mail/cltbld', 04:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:04 INFO - 'MOZ_NO_REMOTE': '1', 04:10:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:04 INFO - 'NO_EM_RESTART': '1', 04:10:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:10:04 INFO - 'PWD': '/builds/slave/test-pgo', 04:10:04 INFO - 'SHELL': '/bin/bash', 04:10:04 INFO - 'SHLVL': '1', 04:10:04 INFO - 'TERM': 'linux', 04:10:04 INFO - 'TMOUT': '86400', 04:10:04 INFO - 'USER': 'cltbld', 04:10:04 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290', 04:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:04 INFO - '_': '/tools/buildbot/bin/python'} 04:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:10:05 INFO - Running setup.py (path:/tmp/pip-Ta2d0q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:10:05 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:10:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:10:05 INFO - Running setup.py (path:/tmp/pip-6ZzdpB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:10:05 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:10:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:10:05 INFO - Running setup.py (path:/tmp/pip-bOjRh1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:10:05 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:10:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:10:05 INFO - Running setup.py (path:/tmp/pip-xGyKki-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:10:05 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:10:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:10:05 INFO - Running setup.py (path:/tmp/pip-0TZi09-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:10:05 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:10:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:10:05 INFO - Running setup.py (path:/tmp/pip-Y1qYNv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:10:05 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:10:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:10:05 INFO - Running setup.py (path:/tmp/pip-e1Zkve-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:10:05 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:10:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:10:05 INFO - Running setup.py (path:/tmp/pip-mecF8e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:10:05 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:10:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:10:05 INFO - Running setup.py (path:/tmp/pip-FPUO4A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:10:05 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:10:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:10:05 INFO - Running setup.py (path:/tmp/pip-xkqqL2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:10:05 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:10:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:10:05 INFO - Running setup.py (path:/tmp/pip-J9JSeI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:10:05 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:10:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:10:05 INFO - Running setup.py (path:/tmp/pip-_HERxz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:10:05 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:10:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:10:05 INFO - Running setup.py (path:/tmp/pip-3hEzIj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:10:06 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:10:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:10:06 INFO - Running setup.py (path:/tmp/pip-g2uMOI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:10:06 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:10:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:10:06 INFO - Running setup.py (path:/tmp/pip-0T9eZZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:10:06 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:10:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:10:06 INFO - Running setup.py (path:/tmp/pip-odT6md-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:10:06 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:10:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:10:06 INFO - Running setup.py (path:/tmp/pip-E9LoeL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:10:06 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:10:06 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:10:06 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:10:06 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:10:06 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:10:06 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:10:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:10:06 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:10:06 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:10:06 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:10:06 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:10:06 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:10:06 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:10:08 INFO - Downloading blessings-1.6.tar.gz 04:10:08 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:10:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:10:08 INFO - Installing collected packages: blessings 04:10:08 INFO - Running setup.py install for blessings 04:10:08 INFO - Successfully installed blessings 04:10:08 INFO - Cleaning up... 04:10:08 INFO - Return code: 0 04:10:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:10:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:10:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:10:08 INFO - Reading from file tmpfile_stdout 04:10:08 INFO - Current package versions: 04:10:08 INFO - argparse == 1.2.1 04:10:08 INFO - blessings == 1.6 04:10:08 INFO - blobuploader == 1.2.4 04:10:08 INFO - docopt == 0.6.1 04:10:08 INFO - manifestparser == 1.1 04:10:08 INFO - mozInstall == 1.12 04:10:08 INFO - mozcrash == 0.16 04:10:08 INFO - mozdebug == 0.1 04:10:08 INFO - mozdevice == 0.46 04:10:08 INFO - mozfile == 1.2 04:10:08 INFO - mozhttpd == 0.7 04:10:08 INFO - mozinfo == 0.8 04:10:08 INFO - mozleak == 0.1 04:10:08 INFO - mozlog == 3.0 04:10:08 INFO - moznetwork == 0.27 04:10:08 INFO - mozprocess == 0.22 04:10:08 INFO - mozprofile == 0.27 04:10:08 INFO - mozrunner == 6.11 04:10:08 INFO - mozscreenshot == 0.1 04:10:08 INFO - mozsystemmonitor == 0.0 04:10:08 INFO - moztest == 0.7 04:10:08 INFO - mozversion == 1.4 04:10:08 INFO - psutil == 3.1.1 04:10:08 INFO - requests == 1.2.3 04:10:08 INFO - wsgiref == 0.1.2 04:10:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:10:08 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:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:08 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:10:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:08 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 0x7ffd35749f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271e350>, '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 0x271f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271f6e0>, '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': '920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290', '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:10:08 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:10:08 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:10:08 INFO - Using env: {'DISPLAY': ':0', 04:10:08 INFO - 'HOME': '/home/cltbld', 04:10:08 INFO - 'LANG': 'en_US.UTF-8', 04:10:08 INFO - 'LANGUAGE': 'en_US:en', 04:10:08 INFO - 'LOGNAME': 'cltbld', 04:10:08 INFO - 'MAIL': '/var/mail/cltbld', 04:10:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:08 INFO - 'MOZ_NO_REMOTE': '1', 04:10:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:08 INFO - 'NO_EM_RESTART': '1', 04:10:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:10:08 INFO - 'PWD': '/builds/slave/test-pgo', 04:10:08 INFO - 'SHELL': '/bin/bash', 04:10:08 INFO - 'SHLVL': '1', 04:10:08 INFO - 'TERM': 'linux', 04:10:08 INFO - 'TMOUT': '86400', 04:10:08 INFO - 'USER': 'cltbld', 04:10:08 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290', 04:10:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:08 INFO - '_': '/tools/buildbot/bin/python'} 04:10:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:08 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:10:08 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:10:08 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:10:08 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:10:08 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:10:08 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:10:08 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:10:08 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:10:08 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:10:08 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:10:08 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:10:08 INFO - Cleaning up... 04:10:08 INFO - Return code: 0 04:10:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:10:08 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:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:08 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:10:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:08 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 0x7ffd35749f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271e350>, '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 0x271f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271f6e0>, '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': '920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290', '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:10:08 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:10:08 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:10:08 INFO - Using env: {'DISPLAY': ':0', 04:10:08 INFO - 'HOME': '/home/cltbld', 04:10:08 INFO - 'LANG': 'en_US.UTF-8', 04:10:08 INFO - 'LANGUAGE': 'en_US:en', 04:10:08 INFO - 'LOGNAME': 'cltbld', 04:10:08 INFO - 'MAIL': '/var/mail/cltbld', 04:10:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:08 INFO - 'MOZ_NO_REMOTE': '1', 04:10:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:08 INFO - 'NO_EM_RESTART': '1', 04:10:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:10:08 INFO - 'PWD': '/builds/slave/test-pgo', 04:10:08 INFO - 'SHELL': '/bin/bash', 04:10:08 INFO - 'SHLVL': '1', 04:10:08 INFO - 'TERM': 'linux', 04:10:08 INFO - 'TMOUT': '86400', 04:10:08 INFO - 'USER': 'cltbld', 04:10:08 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290', 04:10:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:08 INFO - '_': '/tools/buildbot/bin/python'} 04:10:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:08 INFO - Downloading/unpacking jsonschema 04:10:08 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:10:08 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:10:08 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:10:08 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:10:08 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:10:08 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:10:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:10:10 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:10:10 INFO - Downloading/unpacking functools32 (from jsonschema) 04:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:10 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:10:10 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:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:10 INFO - Downloading functools32-3.2.3-2.tar.gz 04:10:10 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:10:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:10:10 INFO - warning: no files found matching '*.txt' 04:10:10 INFO - no previously-included directories found matching 'build' 04:10:10 INFO - no previously-included directories found matching 'dist' 04:10:10 INFO - no previously-included directories found matching '.git*' 04:10:11 INFO - Installing collected packages: jsonschema, functools32 04:10:11 INFO - Running setup.py install for functools32 04:10:11 INFO - warning: no files found matching '*.txt' 04:10:11 INFO - no previously-included directories found matching 'build' 04:10:11 INFO - no previously-included directories found matching 'dist' 04:10:11 INFO - no previously-included directories found matching '.git*' 04:10:11 INFO - Successfully installed jsonschema functools32 04:10:11 INFO - Cleaning up... 04:10:11 INFO - Return code: 0 04:10:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:10:11 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:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:10:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:11 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:10:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:10:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:10:11 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 0x7ffd35749f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x268f600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271e350>, '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 0x271f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271f6e0>, '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': '920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290', '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:10:11 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:10:11 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:10:11 INFO - Using env: {'DISPLAY': ':0', 04:10:11 INFO - 'HOME': '/home/cltbld', 04:10:11 INFO - 'LANG': 'en_US.UTF-8', 04:10:11 INFO - 'LANGUAGE': 'en_US:en', 04:10:11 INFO - 'LOGNAME': 'cltbld', 04:10:11 INFO - 'MAIL': '/var/mail/cltbld', 04:10:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:11 INFO - 'MOZ_NO_REMOTE': '1', 04:10:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:11 INFO - 'NO_EM_RESTART': '1', 04:10:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:10:11 INFO - 'PWD': '/builds/slave/test-pgo', 04:10:11 INFO - 'SHELL': '/bin/bash', 04:10:11 INFO - 'SHLVL': '1', 04:10:11 INFO - 'TERM': 'linux', 04:10:11 INFO - 'TMOUT': '86400', 04:10:11 INFO - 'USER': 'cltbld', 04:10:11 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290', 04:10:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:11 INFO - '_': '/tools/buildbot/bin/python'} 04:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:10:11 INFO - Downloading/unpacking flake8 04:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:10:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:10:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:10:13 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:10:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:10:13 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:10:13 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:10:13 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:10:13 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:10:13 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:10:13 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:10:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:10:13 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:10:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:10:13 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:10:13 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:10:13 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:10:13 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:10:13 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:10:13 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:10:13 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:10:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:10:13 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:10:13 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:10:13 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:10:13 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:10:13 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:10:13 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:10:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.7.0.tar.gz 04:10:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:10:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:10:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:10:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:10:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:10:13 INFO - no previously-included directories found matching 'docs/_build' 04:10:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:10:13 INFO - Running setup.py install for pep8 04:10:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:10:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:10:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:10:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:10:13 INFO - no previously-included directories found matching 'docs/_build' 04:10:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:10:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:10:14 INFO - Cleaning up... 04:10:14 INFO - Return code: 0 04:10:14 INFO - Running post-action listener: _resource_record_post_action 04:10:14 INFO - Running post-action listener: _start_resource_monitoring 04:10:14 INFO - Starting resource monitoring. 04:10:14 INFO - ##### 04:10:14 INFO - ##### Running install step. 04:10:14 INFO - ##### 04:10:14 INFO - Running pre-action listener: _resource_record_pre_action 04:10:14 INFO - Running main action method: install 04:10:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:10:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:10:14 INFO - Reading from file tmpfile_stdout 04:10:14 INFO - Detecting whether we're running mozinstall >=1.0... 04:10:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:10:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:10:14 INFO - Reading from file tmpfile_stdout 04:10:14 INFO - Output received: 04:10:14 INFO - Usage: mozinstall [options] installer 04:10:14 INFO - Options: 04:10:14 INFO - -h, --help show this help message and exit 04:10:14 INFO - -d DEST, --destination=DEST 04:10:14 INFO - Directory to install application into. [default: 04:10:14 INFO - "/builds/slave/test-pgo"] 04:10:14 INFO - --app=APP Application being installed. [default: firefox] 04:10:14 INFO - mkdir: /builds/slave/test-pgo/build/application 04:10:14 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:10:14 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:10:28 INFO - Reading from file tmpfile_stdout 04:10:28 INFO - Output received: 04:10:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:10:28 INFO - Running post-action listener: _resource_record_post_action 04:10:28 INFO - ##### 04:10:28 INFO - ##### Running run-tests step. 04:10:28 INFO - ##### 04:10:28 INFO - Running pre-action listener: _resource_record_pre_action 04:10:28 INFO - Running main action method: run_tests 04:10:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:10:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:10:28 INFO - Python 2.7.3 04:10:28 INFO - Return code: 0 04:10:28 INFO - grabbing minidump binary from tooltool 04:10: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:10:28 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 0x271e350>, '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 0x271f250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x271f6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:10:28 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:10:28 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:10:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:10:28 INFO - Return code: 0 04:10:28 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:10:28 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:10:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:10:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:10:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:10:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:10:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:10:29 INFO - Return code: 0 04:10:29 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-053', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 04:10:29 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-053 --webServer localhost 04:10:29 INFO - Using env: {'DISPLAY': ':0', 04:10:29 INFO - 'HOME': '/home/cltbld', 04:10:29 INFO - 'LANG': 'en_US.UTF-8', 04:10:29 INFO - 'LANGUAGE': 'en_US:en', 04:10:29 INFO - 'LOGNAME': 'cltbld', 04:10:29 INFO - 'MAIL': '/var/mail/cltbld', 04:10:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:10:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:29 INFO - 'MOZ_NO_REMOTE': '1', 04:10:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:10:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:29 INFO - 'NO_EM_RESTART': '1', 04:10:29 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:10:29 INFO - 'PWD': '/builds/slave/test-pgo', 04:10:29 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:10:29 INFO - 'SHELL': '/bin/bash', 04:10:29 INFO - 'SHLVL': '1', 04:10:29 INFO - 'TERM': 'linux', 04:10:29 INFO - 'TMOUT': '86400', 04:10:29 INFO - 'USER': 'cltbld', 04:10:29 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290', 04:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:29 INFO - '_': '/tools/buildbot/bin/python'} 04:10:29 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-053', '--webServer', 'localhost'] with output_timeout 3600 04:10:29 INFO - mozversion INFO | application_buildid: 20160118120031 04:10:29 INFO - mozversion INFO | application_changeset: f84fcce02b11da4d97979f4151c10801ae8d9425 04:10:29 INFO - mozversion INFO | application_display_name: Nightly 04:10:29 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:10:29 INFO - mozversion INFO | application_name: Firefox 04:10:29 INFO - mozversion INFO | application_remotingname: firefox 04:10:29 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:10:29 INFO - mozversion INFO | application_vendor: Mozilla 04:10:29 INFO - mozversion INFO | application_version: 44.0 04:10:29 INFO - mozversion INFO | platform_buildid: 20160118120031 04:10:29 INFO - mozversion INFO | platform_changeset: f84fcce02b11da4d97979f4151c10801ae8d9425 04:10:29 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:10:29 INFO - mozversion INFO | platform_version: 44.0 04:10:29 INFO - 2016-01-25 04:10:29,922 DEBUG : using testdate: 1453723829 04:10:29 INFO - 2016-01-25 04:10:29,922 DEBUG : actual date: 1453723829 04:10:29 INFO - 2016-01-25 04:10:29,930 INFO : starting webserver on 'localhost:44402' 04:10:29 INFO - 2016-01-25 04:10:29,931 INFO : Starting test suite talos-linux64-ix-053 04:10:29 INFO - 2016-01-25 04:10:29,931 INFO : Starting test dromaeo_css 04:10:29 INFO - 2016-01-25 04:10:29,931 DEBUG : operating with platform_type : linux_ 04:10:29 INFO - 2016-01-25 04:10:29,932 INFO : Initialising browser for dromaeo_css test... 04:10:29 INFO - 2016-01-25 04:10:29,945 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt4svMW/profile http://localhost:44402/getInfo.html 04:10:33 INFO - 2016-01-25 04:10:33,641 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:10:33 INFO - 2016-01-25 04:10:33,641 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:10:33 INFO - 2016-01-25 04:10:33,641 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:10:33 INFO - 2016-01-25 04:10:33,642 DEBUG : BROWSER_OUTPUT: __metrics 04:10:33 INFO - 2016-01-25 04:10:33,859 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:10:35 INFO - 2016-01-25 04:10:35,034 INFO : Browser initialized. 04:10:35 INFO - 2016-01-25 04:10:35,035 INFO : Running cycle 1/1 for dromaeo_css test... 04:10:35 INFO - 2016-01-25 04:10:35,035 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt4svMW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:10:46 INFO - 2016-01-25 04:10:46,564 DEBUG : BROWSER_OUTPUT: RSS: Main: 128352256 04:10:46 INFO - 2016-01-25 04:10:46,564 DEBUG : BROWSER_OUTPUT: 04:11:37 INFO - 2016-01-25 04:11:37,378 DEBUG : BROWSER_OUTPUT: 1453723897375 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:13:45 INFO - 2016-01-25 04:13:45,578 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44402/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44402/tests/dromaeo/cssquery-ext.html) 04:13:46 INFO - 2016-01-25 04:13:46,527 DEBUG : BROWSER_OUTPUT: RSS: Main: 214093824 04:13:46 INFO - 2016-01-25 04:13:46,527 DEBUG : BROWSER_OUTPUT: 04:16:48 INFO - 2016-01-25 04:16:48,585 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44402/tests/dromaeo/cssquery-ext.html (next: http://localhost:44402/tests/dromaeo/cssquery-jquery.html) 04:16:49 INFO - 2016-01-25 04:16:49,151 DEBUG : BROWSER_OUTPUT: RSS: Main: 208879616 04:16:49 INFO - 2016-01-25 04:16:49,152 DEBUG : BROWSER_OUTPUT: 04:19:50 INFO - 2016-01-25 04:19:50,861 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44402/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44402/tests/dromaeo/cssquery-mootools.html) 04:19:51 INFO - 2016-01-25 04:19:51,423 DEBUG : BROWSER_OUTPUT: RSS: Main: 214290432 04:19:51 INFO - 2016-01-25 04:19:51,423 DEBUG : BROWSER_OUTPUT: 04:22:53 INFO - 2016-01-25 04:22:53,087 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44402/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44402/tests/dromaeo/cssquery-prototype.html) 04:22:53 INFO - 2016-01-25 04:22:53,661 DEBUG : BROWSER_OUTPUT: RSS: Main: 190136320 04:22:53 INFO - 2016-01-25 04:22:53,661 DEBUG : BROWSER_OUTPUT: 04:25:55 INFO - 2016-01-25 04:25:55,913 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44402/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44402/tests/dromaeo/cssquery-yui.html) 04:25:56 INFO - 2016-01-25 04:25:56,495 DEBUG : BROWSER_OUTPUT: RSS: Main: 194404352 04:25:56 INFO - 2016-01-25 04:25:56,495 DEBUG : BROWSER_OUTPUT: 04:28:58 INFO - 2016-01-25 04:28:58,461 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44402/tests/dromaeo/cssquery-yui.html (next: http://localhost:44402/tests/dromaeo/cssquery-dojo.html) 04:28:58 INFO - 2016-01-25 04:28:58,712 DEBUG : BROWSER_OUTPUT: RSS: Main: 236359680 04:28:58 INFO - 2016-01-25 04:28:58,712 DEBUG : BROWSER_OUTPUT: 04:28:58 INFO - 2016-01-25 04:28:58,712 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:28:58 INFO - 2016-01-25 04:28:58,712 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:28:58 INFO - 2016-01-25 04:28:58,712 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:28:58 INFO - 2016-01-25 04:28:58,713 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:28:58 INFO - 2016-01-25 04:28:58,716 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3342.1644588852787;3386.1873150443903;3410.931781364373;3423.6062852771925;3437.2094418283796;5617.550595952324;5637.859053523659;5649.8305050848485;5657.038303488406;5665.461781130791;5688.402717714643;5710.400407957167;5718.027935251007;5720.8855822883515;5728.742206600703;5018.974905125488;5123.615728820344;5186.636935414523;5240.213967904807;5266.289050978126;5207.062728708831;5222.63441559091;5231.032259032072;5231.084560201968;5238.319018527586;5010.273510340999;5031;5117.437081920985;5144.974275128638;5241.528262456378;5178.378594568657;5243.05624987504;5253.579713622901;5253.842384728464;5274.894502109974;4963.205887058053;5163.1480805667015;5179.93811268689;5211.400688920785;5217.739113044333;5337.572994160458;5410.188471729232;5420.051490989061;5424.294841670558;5427.0773968425465;6004.249468816398;6049.062395328731;6055.2430946131735;6058.757649694007;6088.573799834014;5992.700364981777;6122.540809439265;6151.138840562325;6152.87694246117;6153.600015998945;5666.46168613981;5762.135679648002;5763.423657634287;5764.8847023059725;5788.479036886658;6217.6891155442045;6232;6241.375862413813;6242.812715618538;6246.781362652286;5888.116782482576;5984.581079324493;5987.371326010793;6057.061155520902;6059.818205453844;6078.6048906820915;6082.939170608326;6089.543284253698;6091.664958427329;6102.664353460514;6019.939800602026;6042.637441753509;6044.153818465418;6044.516438684895;6050.45545900871;5852.356240813507;5930.911036334458;5944.375840536682;6034.125051867454;6039.818805435844;4623.260278355447;4668.299755036704;4674;4674.859754207379;4678.017616300547;4177.91644167121;4178.979105104516;4179.164167166578;4195.97902010488;4203.894902627459;5531.170324451365;5613.46672066153;5626.2967129108865;5750.654960702372;5765.135229715576;6069.393060693896;6074.091773443687;6098.451139397475;6127.632342059491;6136.8772624547255;5743.93737158627;5744.023516002289;5754.88490230193;5757.942420575824;5771.797987070517;5176.9741151294;5259.05337039329;5285.7621407036;5310.2831117798605;5399.5950303726595;6303.3066362700065;6329.2721337045905;6335.778247761306;6338.556301058881;6362.045693145972;6177.6911154441195;6195.752169913333;6204.751809927552;6212.347703491249;6215.129881816459;6029.487493563096;6090.512758979359;6130.141780150871;6217.782377616762;6218.129461875251;6021.397860213943;6032.366601506954;6061.936307765941;6070.18052562916;6091.360407157184;5931.525477961839;6155.692215389302;6158.107074474266;6160.137580738789;6174.44430001302;5835.854103647443;5883.499902508334;5958.463738263577;5969.253843269591;5970.104484327212;5917.201177840936;5981.671008094597;6005.489533389711;6020.759169633341;6031;5688.54491640676;5784.797532086357;5920.37836027211;5939.821805345847;5951.285845698544;5797.826065218051;5862.589618726648;5871.500922421642;5876.3536011039605;5923.022701254245;5849.970750146222;5860.0037993542055;5865.237519122657;5868.061110222344;5870.119482077723 04:28:58 INFO - 2016-01-25 04:28:58,716 DEBUG : BROWSER_OUTPUT: |1;ext.html;590.6338070396355;617.7961272779985;629.0564153769346;632.3676323676324;643.9034144878268;36528.08679783004;45661.08677826441;45713.54286457135;45849.08301833961;46103.30845037327;48907.51092489074;49222.50777492224;49464;49514.50485495144;49526;8274.751757447257;8338.24955753982;9128.452292862434;9261.44431334122;9322.06779322069;11009.669709908716;11153.665390038312;11174.1060715143;11175.776484470347;11187.832182517268;10747.462626868664;10750.78498430031;10777.5688972441;10850.72873178173;10852.07757340627;10721.731956701067;10849.620263290746;10863.945680271627;10868.565257389695;10884.292520986111;10648.520816563274;10769.4615269237;10782.622608208754;10800.837987430195;10805.891941080567;43571;44136;44215.33676994847;44220.778896105636;44222.55777442217;3615.258871931248;3685.4103343464917;3695.2794205130012;3759.2105657811894;4118.423420721101;32723.345533089207;32828.507572386436;33049;33106.83446582752;33829.66170338314;3466.618671946084;3542.6988705960025;3574.285142971416;3581.3553560359123;3678.503402040744;331160;331396;333160;335190;335332;60754;62522.68738656369;76076.61961690156;76743.2325676736;77324;73203.63398183082;73428;73434;73492;73679.52640947151;17936;18232.90883545574;18318.450446486626;18335.991520466236;18382.908085459487;14681.339339729739;14755.336009879582;14774.630634234016;14791.556253312203;14846;23198.768012319662;23307.88346058293;23340.883295583415;23345.599264044213;23430.17994370223;8533.701320453878;8702.173293537104;8767.167119123673;8800.735977920673;8866.86699699505;939.628846605587;977.9168770654431;993.5677980078689;1132.2696860524916;1187.5071845184152;30964.69035309663;31486.97330971477;31496.212594685316;31496.527552086736;32686.509702354484;1131.4060118437885;1138.8405623212757;1151.3379806611233;1216.4404373987888;1290.8386451693539;14858.702825943421;16821.831781682027;17611.295548177928;17846.929184248987;17999.19003644839;479767;481039;484425;484973;485971;61842.69078654668;62379;62396.37603623905;62410;62499;1403.6420712718395;1423.8504956979368;1474.2997076388845;1507.17105591924;1514.3034204266162;31445.842770786;31847.68152318447;32538;35133.297334053685;36236.81881590575;57036.42963570311;57720;57731.134032988695;57732.134017990604;57798.42201578098;358184;358843;360974;361247;361430;46087.308690370344;47495.287570685774;47790;48051;48132.7593362031;51029.234561480866;51056.74471627618;51175.74412127915;51955.48044519506;52264.21603676024;42678.78660606677;43466.565334346255;43603;44299.557004429545;44348.801835273654;43472.78263608662;43724;44209;44373.33439998338;44676.55323446854;42200.78899605482;42385.78807105945;42926.14147717091;43039;43101.78449107734;37740;38674.06608802758;38681;38905.80547097247;39125;28871;28970.651651309436;29149.125526234246;29554.408911821214;29571.112866614036 04:28:58 INFO - 2016-01-25 04:28:58,720 DEBUG : BROWSER_OUTPUT: |2;jquery.html;381.4145286984476;386.10231212431086;386.14276306599356;386.2911557292369;387.4459522882279;12156.574519891805;15699.136547489883;17354.21906014229;18774.812251877476;18783.2486700532;18732.719009214874;18777.81222187778;18859.62280754384;19157.329493467732;19443.902780486078;5832.941670583304;5916.704164791765;5929.110633404981;5944.554158438113;5972.193753843219;4571.7942692578745;4619.745913974747;4621.8613441596635;5886.499647529965;6477.611343319392;6400.359964003585;6544.247411547662;6605.735770569171;6610.8677826443445;6620.735170593171;6546.509011824132;6560.442362399202;6575.276719560845;6592.571482853623;6596.208454985408;4486.775661216926;4570.085982803419;5870.11948207768;5880.029795083806;5889.057750759858;14845.777313340308;14986.400543978229;15033.248337583187;15056.247187640574;15073.924630376778;2074.6161960037443;2076.2110398048644;2096.9580608387746;2123.50097727034;2179.204590324536;10525.368477891274;10736.838947415796;10778.407187604678;10923;10959;1562.453141400512;1587.547548948544;1643.0880861122073;1646.7694522766822;1657.5524608355797;67236.66381668109;68028;68127;68294.65852670754;68335.31664683389;7708.460407771402;7785.571793551409;7901.486403383762;7971.641276142472;7973.122956474783;9551.713448596414;9565;9574.234061275081;9574.617015319309;9637.277204209713;6221.96889015552;6491.772787952399;6547.312532184147;6561.507886908501;6587.934120658828;6824.18109826824;6828.283030281848;6854.108965834509;6855.760048398282;6877.6217308048535;3643.9432564556514;3674.724395670282;3679.9264014719556;3699.4265888786745;3703.5370578677666;1225.7977433723336;1246;1268.315109840694;1273.5924504158766;1309.6660351610278;516.5325380530626;522.6785526901004;536.3751229817298;562.1792183412264;575.7437940116691;11441;12821.29482878432;12898.80651790224;13312.400941957636;13516.864831351757;540.8755986123214;544.5398638150756;549.2941570082425;555.7638003848348;576.3803910795912;5898.970505147533;6939.30606939302;7283;7307.744228952068;7364.484486086029;623888;634280;639754;645490;663154;74013.62993185;74828;85523.57238213894;86994.56502717572;87031;592.6829146406652;603.6287683074966;605.0198678141439;607.1499900139752;607.4441885674646;12247.448864800926;12317.260964342167;12439;12497.750044999231;12526.561570344995;39342.60657393504;39895.202095957335;39996.600034000454;40532.1893562133;40669.59330406776;51901.480985189664;52358;52744;53112.73443632757;53344.73327633337;7579.355754760907;7584.734534291273;7707.537547747153;7707.768766937001;7794.961025194838;13324;13355.465781368637;13389.19664820114;13688.836448901557;13812.792808108088;11543.88456115428;11635.941820290844;11890;11972.880271197526;11992.160548761503;11553;11890.940545297219;11969.820452693042;11994.460249288628;12106.031517478405;10357.689269321932;10367.792644146924;10495.685129446128;11832.70418239551;11966.162368634112;7515.8872616911885;7528.473006889465;7599.924000759922;7613.6573854175585;7613.695452182073;11699.2980421175;11707.648770536898;11715.355655439032;11764.70588235301;11918.52325906954 04:28:58 INFO - 2016-01-25 04:28:58,720 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1509.8339182689901;1518.5444366689997;1715.459630216481;1797.330963519174;1828.7714035745532;7161.713531458736;7292.489525733187;7799.298063174313;7944.642491087908;7978.9601051994805;7866.528008319505;7954.522728636286;8120.390970677193;8126.390520710956;8131.796705082376;2311.271949335958;2342.601757701186;2345.7888790008897;2346.0498498108295;2346.9765302347014;2132.3389749177804;2170.5224850532936;2389.653500242464;2405.675233843435;2430.878456077198;2356.2931120663816;2358.6697862299293;2359.1860808021206;2359.49270906755;2364.9054037838464;2416.2751174647624;2443.169322430382;2444.144549407702;2445.58425067738;2446.204983380391;2350.670906073151;2391.3901955001365;2391.6532102845163;2400.3399065257017;2405.410674384769;8303.294219991309;8315.750527484186;8322.29260512851;8322.66709331626;8403.747887563382;4979.526944940261;5048.671836330626;5049.444561098313;5049.823256186052;5051.444341122474;3164.936701265962;3176.8093914365213;3203.823789691566;3243.3189030303665;3248.691374319436;1012.0790081026304;1017.7659138398136;1042.3276986343765;1044.8641676581997;1048.4652827058178;11127.054200392977;11131.165162612837;11136;11140.832887506695;11143.498542565523;4584.839530616412;4625.930611040837;4631.722096674211;4690.390249267642;4710.26990816424;9659.178969787507;9698.515074246401;9703.563339649732;9710.17463515609;9715.22278217755;5148.510891465305;5150.587952963829;5150.613703972217;5151.97424012885;5155.74221288934;4693.0613877224005;4700.506446823034;4704.858854234379;4706.7411292378565;4709.293605959134;3455.7926524408617;3952;3987.501562304712;3994.2410941920944;4024.335984562573;1165.4172913543227;1257.4530079415301;1330.2484096485455;1333.9333033348294;1338.953136640213;1362.8296462942133;1428.9142651440948;1434.1968497641353;1439.5465428390232;1459;7761.107472640719;7782.571958542335;7965.8805117923275;7976.322012628992;7977.282044616012;1141.783061218366;1192.6899006258436;1196.347990345264;1197.6826141072622;1199.160587588674;6263.248410190807;6270;6325.019621958604;6349.714262858182;6382.329855365213;9871.40771553709;10111.544980475895;10161;10172.287939844287;10176;9843.901560984299;10051.798964020678;10062.044105809937;10070.093691567794;10077.59689612422;7816.804579885548;7848.725294614661;7860.803479912934;7875.409344299201;7877.7242796500705;7485.962570187332;7511.098668159856;7517.586532740752;7564.4704870658525;7595.5822429766895;8696.869546956927;8731.34514911397;8743.475391476532;8744.431611945203;9109.134632209929;8871.600777965135;8964;9217.124373184537;9236.584353703965;9239;7463.776086717407;7514.849703006019;7559.3196612305155;7577.355924746458;7582.54504729718;6890.2420733718245;7239.312265334996;8013;8016.959915200387;8074.071481779671;7342.412606991321;7382.630868456663;7432.554046757212;7448.664810083451;7489.925100749141;7148.857022859618;7226.277372262732;7240.275972402717;7291.161516425679;7302.087239095114;7586.468947173866;7607.239276072349;7638.350740187147;7640.083190017233;7648;6897.206821215625;6924.584524928319;6978.057962175244;6997.090378250795;7003.649817509002;7222.205557388788;7268.67290971897;7269.636518173965;7272.272772722686;7274.16347120088 04:28:58 INFO - 2016-01-25 04:28:58,720 DEBUG : BROWSER_OUTPUT: |4;prototype.html;350.95262139611145;360.2920261685787;361.4943759242754;367.26546906187616;371.44839912729594;5849.122631605262;5973.731182096805;6006.159137720711;6011.398860113992;6013.428724271193;5844.211031510745;5914.142449344853;5923.911141332873;5939.584229103964;5965.403459654032;4616.3537104805355;4629.305604159386;4629.444466663988;4629.513901040393;4636.02643444877;4629.675922685414;4633.2123538998285;4640.837570685027;4641.373414589021;4641.791119399635;4519.864404067883;4602.194615942197;4625.537446255381;4666.626669866419;4676.69601475903;4605.148047611203;4646.9767651161865;4649.023705021933;4670.299455081731;4671.8364857229835;3946.2304850554156;4107.527634322061;4110.506739191316;4117.835286588533;4123.587641235882;5599.496045355938;5612.522935550483;5711.62874413166;5725.513331366838;5746.310442746897;5360.812371566976;5385.461453854622;5394.973025134888;5395.29861118056;5396.595255355864;6295.496360291166;6296.779612713533;6301.7164227609865;6301.87396252077;6315.147455093595;4489.124620698965;4568.200564901129;4569.47451043131;4586.197415452316;4621.4685311189305;6541.738330466776;6600.537962342638;6602;6604.570702904296;6605.240397354318;4695.131400690883;4728.503507131771;4729.7398643074275;4730.668853180245;4738;4699.412573428322;4777.880552986203;4785.904281914342;4786.545278198635;4788.994311194619;5449.209864569615;5456.61803673739;5457.645253058538;5459.044667183306;5463.836084917459;6438.6136831790245;6445.16212892321;6447.709853056624;6452.838679032968;6454.967725161344;1701.3364787732794;1728.2136627834304;1729.4292883348464;1729.8962062276303;1731.1776905969564;1164.3130552973616;1170.2393444261297;1179.2393905930626;1185.4309931233056;1203.7773011992808;6206.875862482725;6210.192674952227;6214.130021796952;6216.285127210338;6216.875662486816;6600.669966501656;6606.570572912745;6607.273199948002;6609.636469994197;6614.86770264592;6093.908591371133;6201;6202.379762023762;6213.65824879636;6215.036669316263;3616.023673608111;3647.1611529348397;3649.233660931234;3650.5254316938626;3651.068977410743;6536.444402225769;6627.86744265112;6655.234648015444;6725.730970761213;6762.289959554176;6702.262751097375;6726.764563240263;6737.730490780314;6737.966310168418;6747.662616869137;6692.799216023527;6697.7655782047395;6705.4635629150525;6716.126903502513;6720.966395167993;6411.102445657705;6546.574472659262;6549.7380104795275;6551.672416379067;6591.703373348307;6559.704813283509;6576.375244351779;6577.572457790228;6580.934190658032;6592.406683398517;6756.662166891734;6800.863982720417;6809.182898052265;6810;6818.659067046727;4620.722756634613;4772.594329482033;4772.761361931959;4773.04539092176;4780.569748722632;6614.470842332698;6623.635700036544;6623.635700036544;6624.0395142705;6630.701618427279;6391.041343798467;6414.069959855701;6429.132067170872;6449.516286278642;6455;6311;6366.904496432465;6437.291897891135;6437.581557198767;6439.227292724903;6317.4630156437215;6327.082573026977;6327.90508142369;6331;6331.90502142459;6404.751073540615;6449.484041276781;6464.482841372773;6466.7736629219635;6473.158489396348;6160.876782464416;6285.654289014148;6330.556861019684;6332.0818481320875;6340.270868849957 04:28:58 INFO - 2016-01-25 04:28:58,721 DEBUG : BROWSER_OUTPUT: |5;yui.html;728.4136270302406;776.8485145396646;802.4823988527396;814.8655471847145;817.750586071248;14335.283235838218;14681.559553213394;14686.192259425741;14690.926545367258;14706.41174353026;13987.090839095477;14090.577282681536;14104.858951410482;14109.78835317471;14118.92940535296;768.4735955870233;782.2920257167273;906.315731622624;922.8108237811233;923.7736754495124;912.8402529557334;913.5295322908707;914.9817003659923;921.4609453469728;921.8617207418873;808.9635966381527;816.0330008939396;965.652365148546;970.7815741458151;979;943.6414162618196;956.8708224389758;957.248559880494;958.4872093430016;958.5542722633938;713.7751608243439;715.2775696546473;719.1011235955057;719.363363423374;719.3705507680779;14027.859721402758;14068;14143.717125657533;14205.928970355082;14213.85786142146;12256.571020014257;12690.682732931658;13037.739245215138;13101;13137.080404371698;9264.39781414206;9509.524523773853;9512.524373781283;9517.762055948657;9534.856977145348;3339.448990916496;3373.1567108222944;3378.7972721636534;3382.797032178077;3385.7460690448315;51509.7424512875;51620.48379516232;51686.22470662943;54507.45492545103;54557.72721136448;9341.426916633103;9459.90540094604;9496.382735122195;9544.761380965392;9587.616495340108;21158.78841211599;21496.677549836764;21505.67741483879;21539.89230053871;21543.353699389045;7011;7091.078159839188;7162.247963963813;7246.565206087652;7302.890456643155;4133.648639865585;4147.19129769692;4234.9364759528635;4248;4256.3828244904935;3350.8492117854753;3389.5932488101585;3393.0329855990926;3393.830308484566;3394.0666316762595;501.25063030768507;519.8050730975884;523.5680563535099;526.2658591265164;527.923451099596;545.2475583694476;565.5645153231989;590.3181824992141;592.3188333416606;600.7640689641494;8423.157684231528;8637.784055398666;8647.308215342757;8781.560921953876;8956.596953137125;532.8880935003615;596.1266744219739;648.5136147889083;651.7847428961446;653.7875190563086;3852.5376954765607;3875.5155605549307;3876.8643097491454;4025.5370632377067;4028.295048366524;66413.66793166003;66521;66886.33113668801;67404;67668;53656;54018.45981540213;54469.182962255596;55123.448765512636;57254.14118788222;55192;55517.444825551225;55585.44414555884;56095.15857262144;56724.716376417855;7868.6065696713795;8015.599220039091;8103.959480202797;8258.06194045498;8261.09127995932;40682.59317406788;40749.1850163001;41739.58260417357;41936.58063419327;42224.78887605542;52760.208596871846;54326.728366357915;54854.725726371114;54896.45103549073;54980.900381992935;8540.658373664985;8594.226519613265;8680.869786953075;8687.261582765535;8694.30445564366;11564.47959841826;12054.397280136134;12285.1400401971;12323.075769317516;12700.936495317465;10533.841992370273;10617.787644247226;10691.465426728788;10778.407187604756;11024.889751102386;11493.942530287295;11644;11657.708557286136;11976.820347694966;12208.877911220774;10368.326058806153;10481.318714283547;10519.105876000625;10538.104261137889;10626.149908007186;9838.803223935338;9874;9887.4067555944;9941.204703623549;10105.5452504636;8462.449940753831;8511.659533618586;8636.913630863612;8821.382503224713;8831.823363532822 04:28:58 INFO - 2016-01-25 04:28:58,722 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:28:58 INFO - 2016-01-25 04:28:58,722 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:28:58 INFO - 2016-01-25 04:28:58,722 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,707 04:28:58 INFO - 2016-01-25 04:28:58,722 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:28:58 INFO - 2016-01-25 04:28:58,722 DEBUG : BROWSER_OUTPUT: __startTimestamp1453724938711__endTimestamp 04:28:58 INFO - 2016-01-25 04:28:58,722 DEBUG : BROWSER_OUTPUT: 04:28:58 INFO - 2016-01-25 04:28:58,722 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:28:58 INFO - 2016-01-25 04:28:58,722 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:28:58 INFO - 2016-01-25 04:28:58,722 DEBUG : BROWSER_OUTPUT: 04:28:58 INFO - 2016-01-25 04:28:58,722 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5644.95 Median:5862.59 stddev:624.90 (10.7%) stddev-sans-first:600.14 04:28:58 INFO - 2016-01-25 04:28:58,723 DEBUG : BROWSER_OUTPUT: Values: 3342.2 3386.2 3410.9 3423.6 3437.2 5617.6 5637.9 5649.8 5657.0 5665.5 5688.4 5710.4 5718.0 5720.9 5728.7 5019.0 5123.6 5186.6 5240.2 5266.3 5207.1 5222.6 5231.0 5231.1 5238.3 5010.3 5031.0 5117.4 5145.0 5241.5 5178.4 5243.1 5253.6 5253.8 5274.9 4963.2 5163.1 5179.9 5211.4 5217.7 5337.6 5410.2 5420.1 5424.3 5427.1 6004.2 6049.1 6055.2 6058.8 6088.6 5992.7 6122.5 6151.1 6152.9 6153.6 5666.5 5762.1 5763.4 5764.9 5788.5 6217.7 6232.0 6241.4 6242.8 6246.8 5888.1 5984.6 5987.4 6057.1 6059.8 6078.6 6082.9 6089.5 6091.7 6102.7 6019.9 6042.6 6044.2 6044.5 6050.5 5852.4 5930.9 5944.4 6034.1 6039.8 4623.3 4668.3 4674.0 4674.9 4678.0 4177.9 4179.0 4179.2 4196.0 4203.9 5531.2 5613.5 5626.3 5750.7 5765.1 6069.4 6074.1 6098.5 6127.6 6136.9 5743.9 5744.0 5754.9 5757.9 5771.8 5177.0 5259.1 5285.8 5310.3 5399.6 6303.3 6329.3 6335.8 6338.6 6362.0 6177.7 6195.8 6204.8 6212.3 6215.1 6029.5 6090.5 6130.1 6217.8 6218.1 6021.4 6032.4 6061.9 6070.2 6091.4 5931.5 6155.7 6158.1 6160.1 6174.4 5835.9 5883.5 5958.5 5969.3 5970.1 5917.2 5981.7 6005.5 6020.8 6031.0 5688.5 5784.8 5920.4 5939.8 5951.3 5797.8 5862.6 5871.5 5876.4 5923.0 5850.0 5860.0 5865.2 5868.1 5870.1 04:28:58 INFO - 2016-01-25 04:28:58,723 DEBUG : BROWSER_OUTPUT: 04:28:58 INFO - 2016-01-25 04:28:58,723 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:58881.14 Median:3727.24 stddev:104592.41 (2806.2%) stddev-sans-first:104794.25 04:28:58 INFO - 2016-01-25 04:28:58,723 DEBUG : BROWSER_OUTPUT: Values: 590.6 617.8 629.1 632.4 643.9 36528.1 45661.1 45713.5 45849.1 46103.3 48907.5 49222.5 49464.0 49514.5 49526.0 8274.8 8338.2 9128.5 9261.4 9322.1 11009.7 11153.7 11174.1 11175.8 11187.8 10747.5 10750.8 10777.6 10850.7 10852.1 10721.7 10849.6 10863.9 10868.6 10884.3 10648.5 10769.5 10782.6 10800.8 10805.9 43571.0 44136.0 44215.3 44220.8 44222.6 3615.3 3685.4 3695.3 3759.2 4118.4 32723.3 32828.5 33049.0 33106.8 33829.7 3466.6 3542.7 3574.3 3581.4 3678.5 331160.0 331396.0 333160.0 335190.0 335332.0 60754.0 62522.7 76076.6 76743.2 77324.0 73203.6 73428.0 73434.0 73492.0 73679.5 17936.0 18232.9 18318.5 18336.0 18382.9 14681.3 14755.3 14774.6 14791.6 14846.0 23198.8 23307.9 23340.9 23345.6 23430.2 8533.7 8702.2 8767.2 8800.7 8866.9 939.6 977.9 993.6 1132.3 1187.5 30964.7 31487.0 31496.2 31496.5 32686.5 1131.4 1138.8 1151.3 1216.4 1290.8 14858.7 16821.8 17611.3 17846.9 17999.2 479767.0 481039.0 484425.0 484973.0 485971.0 61842.7 62379.0 62396.4 62410.0 62499.0 1403.6 1423.9 1474.3 1507.2 1514.3 31445.8 31847.7 32538.0 35133.3 36236.8 57036.4 57720.0 57731.1 57732.1 57798.4 358184.0 358843.0 360974.0 361247.0 361430.0 46087.3 47495.3 47790.0 48051.0 48132.8 51029.2 51056.7 51175.7 51955.5 52264.2 42678.8 43466.6 43603.0 44299.6 44348.8 43472.8 43724.0 44209.0 44373.3 44676.6 42200.8 42385.8 42926.1 43039.0 43101.8 37740.0 38674.1 38681.0 38905.8 39125.0 28871.0 28970.7 29149.1 29554.4 29571.1 04:28:58 INFO - 2016-01-25 04:28:58,724 DEBUG : BROWSER_OUTPUT: 04:28:58 INFO - 2016-01-25 04:28:58,724 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31213.05 Median:26209.01 stddev:105004.46 (400.6%) stddev-sans-first:105273.50 04:28:58 INFO - 2016-01-25 04:28:58,724 DEBUG : BROWSER_OUTPUT: Values: 381.4 386.1 386.1 386.3 387.4 12156.6 15699.1 17354.2 18774.8 18783.2 18732.7 18777.8 18859.6 19157.3 19443.9 5832.9 5916.7 5929.1 5944.6 5972.2 4571.8 4619.7 4621.9 5886.5 6477.6 6400.4 6544.2 6605.7 6610.9 6620.7 6546.5 6560.4 6575.3 6592.6 6596.2 4486.8 4570.1 5870.1 5880.0 5889.1 14845.8 14986.4 15033.2 15056.2 15073.9 2074.6 2076.2 2097.0 2123.5 2179.2 10525.4 10736.8 10778.4 10923.0 10959.0 1562.5 1587.5 1643.1 1646.8 1657.6 67236.7 68028.0 68127.0 68294.7 68335.3 7708.5 7785.6 7901.5 7971.6 7973.1 9551.7 9565.0 9574.2 9574.6 9637.3 6222.0 6491.8 6547.3 6561.5 6587.9 6824.2 6828.3 6854.1 6855.8 6877.6 3643.9 3674.7 3679.9 3699.4 3703.5 1225.8 1246.0 1268.3 1273.6 1309.7 516.5 522.7 536.4 562.2 575.7 11441.0 12821.3 12898.8 13312.4 13516.9 540.9 544.5 549.3 555.8 576.4 5899.0 6939.3 7283.0 7307.7 7364.5 623888.0 634280.0 639754.0 645490.0 663154.0 74013.6 74828.0 85523.6 86994.6 87031.0 592.7 603.6 605.0 607.1 607.4 12247.4 12317.3 12439.0 12497.8 12526.6 39342.6 39895.2 39996.6 40532.2 40669.6 51901.5 52358.0 52744.0 53112.7 53344.7 7579.4 7584.7 7707.5 7707.8 7795.0 13324.0 13355.5 13389.2 13688.8 13812.8 11543.9 11635.9 11890.0 11972.9 11992.2 11553.0 11890.9 11969.8 11994.5 12106.0 10357.7 10367.8 10495.7 11832.7 11966.2 7515.9 7528.5 7599.9 7613.7 7613.7 11699.3 11707.6 11715.4 11764.7 11918.5 04:28:58 INFO - 2016-01-25 04:28:58,725 DEBUG : BROWSER_OUTPUT: 04:28:58 INFO - 2016-01-25 04:28:58,725 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5811.93 Median:5151.29 stddev:2982.98 (57.9%) stddev-sans-first:2973.82 04:28:58 INFO - 2016-01-25 04:28:58,725 DEBUG : BROWSER_OUTPUT: Values: 1509.8 1518.5 1715.5 1797.3 1828.8 7161.7 7292.5 7799.3 7944.6 7979.0 7866.5 7954.5 8120.4 8126.4 8131.8 2311.3 2342.6 2345.8 2346.0 2347.0 2132.3 2170.5 2389.7 2405.7 2430.9 2356.3 2358.7 2359.2 2359.5 2364.9 2416.3 2443.2 2444.1 2445.6 2446.2 2350.7 2391.4 2391.7 2400.3 2405.4 8303.3 8315.8 8322.3 8322.7 8403.7 4979.5 5048.7 5049.4 5049.8 5051.4 3164.9 3176.8 3203.8 3243.3 3248.7 1012.1 1017.8 1042.3 1044.9 1048.5 11127.1 11131.2 11136.0 11140.8 11143.5 4584.8 4625.9 4631.7 4690.4 4710.3 9659.2 9698.5 9703.6 9710.2 9715.2 5148.5 5150.6 5150.6 5152.0 5155.7 4693.1 4700.5 4704.9 4706.7 4709.3 3455.8 3952.0 3987.5 3994.2 4024.3 1165.4 1257.5 1330.2 1333.9 1339.0 1362.8 1428.9 1434.2 1439.5 1459.0 7761.1 7782.6 7965.9 7976.3 7977.3 1141.8 1192.7 1196.3 1197.7 1199.2 6263.2 6270.0 6325.0 6349.7 6382.3 9871.4 10111.5 10161.0 10172.3 10176.0 9843.9 10051.8 10062.0 10070.1 10077.6 7816.8 7848.7 7860.8 7875.4 7877.7 7486.0 7511.1 7517.6 7564.5 7595.6 8696.9 8731.3 8743.5 8744.4 9109.1 8871.6 8964.0 9217.1 9236.6 9239.0 7463.8 7514.8 7559.3 7577.4 7582.5 6890.2 7239.3 8013.0 8017.0 8074.1 7342.4 7382.6 7432.6 7448.7 7489.9 7148.9 7226.3 7240.3 7291.2 7302.1 7586.5 7607.2 7638.4 7640.1 7648.0 6897.2 6924.6 6978.1 6997.1 7003.6 7222.2 7268.7 7269.6 7272.3 7274.2 04:28:58 INFO - 2016-01-25 04:28:58,725 DEBUG : BROWSER_OUTPUT: 04:28:58 INFO - 2016-01-25 04:28:58,725 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5377.99 Median:6127.39 stddev:1573.38 (25.7%) stddev-sans-first:1531.88 04:28:58 INFO - 2016-01-25 04:28:58,725 DEBUG : BROWSER_OUTPUT: Values: 351.0 360.3 361.5 367.3 371.4 5849.1 5973.7 6006.2 6011.4 6013.4 5844.2 5914.1 5923.9 5939.6 5965.4 4616.4 4629.3 4629.4 4629.5 4636.0 4629.7 4633.2 4640.8 4641.4 4641.8 4519.9 4602.2 4625.5 4666.6 4676.7 4605.1 4647.0 4649.0 4670.3 4671.8 3946.2 4107.5 4110.5 4117.8 4123.6 5599.5 5612.5 5711.6 5725.5 5746.3 5360.8 5385.5 5395.0 5395.3 5396.6 6295.5 6296.8 6301.7 6301.9 6315.1 4489.1 4568.2 4569.5 4586.2 4621.5 6541.7 6600.5 6602.0 6604.6 6605.2 4695.1 4728.5 4729.7 4730.7 4738.0 4699.4 4777.9 4785.9 4786.5 4789.0 5449.2 5456.6 5457.6 5459.0 5463.8 6438.6 6445.2 6447.7 6452.8 6455.0 1701.3 1728.2 1729.4 1729.9 1731.2 1164.3 1170.2 1179.2 1185.4 1203.8 6206.9 6210.2 6214.1 6216.3 6216.9 6600.7 6606.6 6607.3 6609.6 6614.9 6093.9 6201.0 6202.4 6213.7 6215.0 3616.0 3647.2 3649.2 3650.5 3651.1 6536.4 6627.9 6655.2 6725.7 6762.3 6702.3 6726.8 6737.7 6738.0 6747.7 6692.8 6697.8 6705.5 6716.1 6721.0 6411.1 6546.6 6549.7 6551.7 6591.7 6559.7 6576.4 6577.6 6580.9 6592.4 6756.7 6800.9 6809.2 6810.0 6818.7 4620.7 4772.6 4772.8 4773.0 4780.6 6614.5 6623.6 6623.6 6624.0 6630.7 6391.0 6414.1 6429.1 6449.5 6455.0 6311.0 6366.9 6437.3 6437.6 6439.2 6317.5 6327.1 6327.9 6331.0 6331.9 6404.8 6449.5 6464.5 6466.8 6473.2 6160.9 6285.7 6330.6 6332.1 6340.3 04:28:58 INFO - 2016-01-25 04:28:58,725 DEBUG : BROWSER_OUTPUT: 04:28:58 INFO - 2016-01-25 04:28:58,725 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:15015.01 Median:55052.17 stddev:18609.63 (33.8%) stddev-sans-first:18630.91 04:28:58 INFO - 2016-01-25 04:28:58,727 DEBUG : BROWSER_OUTPUT: Values: 728.4 776.8 802.5 814.9 817.8 14335.3 14681.6 14686.2 14690.9 14706.4 13987.1 14090.6 14104.9 14109.8 14118.9 768.5 782.3 906.3 922.8 923.8 912.8 913.5 915.0 921.5 921.9 809.0 816.0 965.7 970.8 979.0 943.6 956.9 957.2 958.5 958.6 713.8 715.3 719.1 719.4 719.4 14027.9 14068.0 14143.7 14205.9 14213.9 12256.6 12690.7 13037.7 13101.0 13137.1 9264.4 9509.5 9512.5 9517.8 9534.9 3339.4 3373.2 3378.8 3382.8 3385.7 51509.7 51620.5 51686.2 54507.5 54557.7 9341.4 9459.9 9496.4 9544.8 9587.6 21158.8 21496.7 21505.7 21539.9 21543.4 7011.0 7091.1 7162.2 7246.6 7302.9 4133.6 4147.2 4234.9 4248.0 4256.4 3350.8 3389.6 3393.0 3393.8 3394.1 501.3 519.8 523.6 526.3 527.9 545.2 565.6 590.3 592.3 600.8 8423.2 8637.8 8647.3 8781.6 8956.6 532.9 596.1 648.5 651.8 653.8 3852.5 3875.5 3876.9 4025.5 4028.3 66413.7 66521.0 66886.3 67404.0 67668.0 53656.0 54018.5 54469.2 55123.4 57254.1 55192.0 55517.4 55585.4 56095.2 56724.7 7868.6 8015.6 8104.0 8258.1 8261.1 40682.6 40749.2 41739.6 41936.6 42224.8 52760.2 54326.7 54854.7 54896.5 54980.9 8540.7 8594.2 8680.9 8687.3 8694.3 11564.5 12054.4 12285.1 12323.1 12700.9 10533.8 10617.8 10691.5 10778.4 11024.9 11493.9 11644.0 11657.7 11976.8 12208.9 10368.3 10481.3 10519.1 10538.1 10626.1 9838.8 9874.0 9887.4 9941.2 10105.5 8462.4 8511.7 8636.9 8821.4 8831.8 04:28:58 INFO - 2016-01-25 04:28:58,727 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:28:58 INFO - 2016-01-25 04:28:58,727 DEBUG : BROWSER_OUTPUT: 04:28:59 INFO - 2016-01-25 04:28:59,314 INFO : Browser exited with error code: 0 04:28:59 INFO - 2016-01-25 04:28:59,338 INFO : Completed test dromaeo_css (00:18:29) 04:28:59 INFO - 2016-01-25 04:28:59,338 INFO : Starting test kraken 04:28:59 INFO - 2016-01-25 04:28:59,338 DEBUG : operating with platform_type : linux_ 04:28:59 INFO - 2016-01-25 04:28:59,338 INFO : Initialising browser for kraken test... 04:28:59 INFO - 2016-01-25 04:28:59,344 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpA_21RY/profile http://localhost:44402/getInfo.html 04:29:02 INFO - 2016-01-25 04:29:02,968 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:29:02 INFO - 2016-01-25 04:29:02,969 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:29:02 INFO - 2016-01-25 04:29:02,969 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:29:02 INFO - 2016-01-25 04:29:02,969 DEBUG : BROWSER_OUTPUT: __metrics 04:29:03 INFO - 2016-01-25 04:29:03,106 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:29:04 INFO - 2016-01-25 04:29:04,315 INFO : Browser initialized. 04:29:04 INFO - 2016-01-25 04:29:04,315 INFO : Running cycle 1/1 for kraken test... 04:29:04 INFO - 2016-01-25 04:29:04,316 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpA_21RY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:29:15 INFO - 2016-01-25 04:29:15,900 DEBUG : BROWSER_OUTPUT: RSS: Main: 128319488 04:29:15 INFO - 2016-01-25 04:29:15,901 DEBUG : BROWSER_OUTPUT: 04:29:18 INFO - 2016-01-25 04:29:18,339 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44402/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44402/tests/kraken/driver.html?testName=audio-beat-detection) 04:29:18 INFO - 2016-01-25 04:29:18,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 160174080 04:29:18 INFO - 2016-01-25 04:29:18,913 DEBUG : BROWSER_OUTPUT: 04:29:21 INFO - 2016-01-25 04:29:21,450 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44402/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44402/tests/kraken/driver.html?testName=audio-dft) 04:29:22 INFO - 2016-01-25 04:29:22,012 DEBUG : BROWSER_OUTPUT: RSS: Main: 160223232 04:29:22 INFO - 2016-01-25 04:29:22,012 DEBUG : BROWSER_OUTPUT: 04:29:24 INFO - 2016-01-25 04:29:24,798 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44402/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44402/tests/kraken/driver.html?testName=audio-fft) 04:29:25 INFO - 2016-01-25 04:29:25,360 DEBUG : BROWSER_OUTPUT: RSS: Main: 156991488 04:29:25 INFO - 2016-01-25 04:29:25,360 DEBUG : BROWSER_OUTPUT: 04:29:27 INFO - 2016-01-25 04:29:27,333 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44402/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44402/tests/kraken/driver.html?testName=audio-oscillator) 04:29:27 INFO - 2016-01-25 04:29:27,896 DEBUG : BROWSER_OUTPUT: RSS: Main: 155930624 04:29:27 INFO - 2016-01-25 04:29:27,896 DEBUG : BROWSER_OUTPUT: 04:29:30 INFO - 2016-01-25 04:29:30,035 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44402/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44402/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:29:30 INFO - 2016-01-25 04:29:30,589 DEBUG : BROWSER_OUTPUT: RSS: Main: 155783168 04:29:30 INFO - 2016-01-25 04:29:30,589 DEBUG : BROWSER_OUTPUT: 04:29:33 INFO - 2016-01-25 04:29:33,472 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44402/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44402/tests/kraken/driver.html?testName=imaging-darkroom) 04:29:34 INFO - 2016-01-25 04:29:34,039 DEBUG : BROWSER_OUTPUT: RSS: Main: 156221440 04:29:34 INFO - 2016-01-25 04:29:34,039 DEBUG : BROWSER_OUTPUT: 04:29:37 INFO - 2016-01-25 04:29:37,345 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44402/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44402/tests/kraken/driver.html?testName=imaging-desaturate) 04:29:37 INFO - 2016-01-25 04:29:37,918 DEBUG : BROWSER_OUTPUT: RSS: Main: 156831744 04:29:37 INFO - 2016-01-25 04:29:37,919 DEBUG : BROWSER_OUTPUT: 04:29:40 INFO - 2016-01-25 04:29:40,627 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44402/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44402/tests/kraken/driver.html?testName=json-parse-financial) 04:29:41 INFO - 2016-01-25 04:29:41,197 DEBUG : BROWSER_OUTPUT: RSS: Main: 156676096 04:29:41 INFO - 2016-01-25 04:29:41,197 DEBUG : BROWSER_OUTPUT: 04:29:42 INFO - 2016-01-25 04:29:42,706 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44402/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44402/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:29:43 INFO - 2016-01-25 04:29:43,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 159928320 04:29:43 INFO - 2016-01-25 04:29:43,267 DEBUG : BROWSER_OUTPUT: 04:29:44 INFO - 2016-01-25 04:29:44,997 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44402/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44402/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:29:45 INFO - 2016-01-25 04:29:45,591 DEBUG : BROWSER_OUTPUT: RSS: Main: 161054720 04:29:45 INFO - 2016-01-25 04:29:45,591 DEBUG : BROWSER_OUTPUT: 04:29:47 INFO - 2016-01-25 04:29:47,534 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44402/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44402/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:29:48 INFO - 2016-01-25 04:29:48,106 DEBUG : BROWSER_OUTPUT: RSS: Main: 167641088 04:29:48 INFO - 2016-01-25 04:29:48,107 DEBUG : BROWSER_OUTPUT: 04:29:50 INFO - 2016-01-25 04:29:50,353 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44402/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44402/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:29:50 INFO - 2016-01-25 04:29:50,935 DEBUG : BROWSER_OUTPUT: RSS: Main: 172449792 04:29:50 INFO - 2016-01-25 04:29:50,935 DEBUG : BROWSER_OUTPUT: 04:29:53 INFO - 2016-01-25 04:29:53,349 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44402/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44402/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:29:53 INFO - 2016-01-25 04:29:53,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 168824832 04:29:53 INFO - 2016-01-25 04:29:53,915 DEBUG : BROWSER_OUTPUT: 04:29:55 INFO - 2016-01-25 04:29:55,530 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44402/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44402/tests/kraken/driver.html?testName=ai-astar) 04:29:55 INFO - 2016-01-25 04:29:55,788 DEBUG : BROWSER_OUTPUT: RSS: Main: 228347904 04:29:55 INFO - 2016-01-25 04:29:55,789 DEBUG : BROWSER_OUTPUT: 04:29:55 INFO - 2016-01-25 04:29:55,789 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:29:55 INFO - 2016-01-25 04:29:55,789 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:29:55 INFO - 2016-01-25 04:29:55,789 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:29:55 INFO - 2016-01-25 04:29:55,789 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:29:55 INFO - 2016-01-25 04:29:55,789 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;105;109;110;110;100;109;100;108 04:29:55 INFO - 2016-01-25 04:29:55,789 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;121;145;164;122;153;162;122;163;124 04:29:55 INFO - 2016-01-25 04:29:55,790 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;161;159;159;158;159;161;159;162 04:29:55 INFO - 2016-01-25 04:29:55,790 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;70;70;138;72;70;70;71;172;70 04:29:55 INFO - 2016-01-25 04:29:55,790 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;88;130;88;88;89;141;88;89;135 04:29:55 INFO - 2016-01-25 04:29:55,790 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;110;110 04:29:55 INFO - 2016-01-25 04:29:55,790 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;144;145;145;145;145;144;145;145;146 04:29:55 INFO - 2016-01-25 04:29:55,790 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;96;96;96;95;96 04:29:55 INFO - 2016-01-25 04:29:55,790 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;53;57;55;62;56;54;55;61;53;55 04:29:55 INFO - 2016-01-25 04:29:55,790 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;62;62;64;64;62;62;63;62;62 04:29:55 INFO - 2016-01-25 04:29:55,790 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;77;79;78;78;79;86;76;77;85 04:29:55 INFO - 2016-01-25 04:29:55,791 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;106;107;106;107;114;113;110;109;110;109 04:29:55 INFO - 2016-01-25 04:29:55,791 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;147;137;139;139;136;134;134;134;133 04:29:55 INFO - 2016-01-25 04:29:55,791 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;62;71;62;61;62;61;61;63;65;63 04:29:55 INFO - 2016-01-25 04:29:55,791 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:29:55 INFO - 2016-01-25 04:29:55,791 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:29:55 INFO - 2016-01-25 04:29:55,791 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,877 04:29:55 INFO - 2016-01-25 04:29:55,791 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:29:55 INFO - 2016-01-25 04:29:55,791 DEBUG : BROWSER_OUTPUT: __startTimestamp1453724995782__endTimestamp 04:29:55 INFO - 2016-01-25 04:29:55,791 DEBUG : BROWSER_OUTPUT: 04:29:55 INFO - 2016-01-25 04:29:55,791 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:29:55 INFO - 2016-01-25 04:29:55,791 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:29:55 INFO - 2016-01-25 04:29:55,791 DEBUG : BROWSER_OUTPUT: 04:29:55 INFO - 2016-01-25 04:29:55,792 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.90 Median:109.00 stddev:3.93 (3.6%) stddev-sans-first:4.15 04:29:55 INFO - 2016-01-25 04:29:55,792 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 105.0 109.0 110.0 110.0 100.0 109.0 100.0 108.0 04:29:55 INFO - 2016-01-25 04:29:55,792 DEBUG : BROWSER_OUTPUT: 04:29:55 INFO - 2016-01-25 04:29:55,792 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.50 Median:151.00 stddev:18.46 (12.2%) stddev-sans-first:19.43 04:29:55 INFO - 2016-01-25 04:29:55,792 DEBUG : BROWSER_OUTPUT: Values: 149.0 121.0 145.0 164.0 122.0 153.0 162.0 122.0 163.0 124.0 04:29:55 INFO - 2016-01-25 04:29:55,792 DEBUG : BROWSER_OUTPUT: 04:29:55 INFO - 2016-01-25 04:29:55,792 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.90 Median:160.50 stddev:1.29 (0.8%) stddev-sans-first:1.30 04:29:55 INFO - 2016-01-25 04:29:55,792 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 161.0 159.0 159.0 158.0 159.0 161.0 159.0 162.0 04:29:55 INFO - 2016-01-25 04:29:55,792 DEBUG : BROWSER_OUTPUT: 04:29:55 INFO - 2016-01-25 04:29:55,792 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.30 Median:70.00 stddev:36.58 (52.3%) stddev-sans-first:38.25 04:29:55 INFO - 2016-01-25 04:29:55,792 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 70.0 138.0 72.0 70.0 70.0 71.0 172.0 70.0 04:29:55 INFO - 2016-01-25 04:29:55,793 DEBUG : BROWSER_OUTPUT: 04:29:55 INFO - 2016-01-25 04:29:55,793 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.60 Median:88.00 stddev:22.75 (25.8%) stddev-sans-first:23.66 04:29:55 INFO - 2016-01-25 04:29:55,793 DEBUG : BROWSER_OUTPUT: Values: 90.0 88.0 130.0 88.0 88.0 89.0 141.0 88.0 89.0 135.0 04:29:55 INFO - 2016-01-25 04:29:55,793 DEBUG : BROWSER_OUTPUT: 04:29:55 INFO - 2016-01-25 04:29:55,794 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:29:55 INFO - 2016-01-25 04:29:55,794 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 110.0 04:29:55 INFO - 2016-01-25 04:29:55,794 DEBUG : BROWSER_OUTPUT: 04:29:55 INFO - 2016-01-25 04:29:55,794 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 04:29:55 INFO - 2016-01-25 04:29:55,794 DEBUG : BROWSER_OUTPUT: Values: 146.0 144.0 145.0 145.0 145.0 145.0 144.0 145.0 145.0 146.0 04:29:55 INFO - 2016-01-25 04:29:55,794 DEBUG : BROWSER_OUTPUT: 04:29:55 INFO - 2016-01-25 04:29:55,794 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:29:55 INFO - 2016-01-25 04:29:55,794 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 04:29:55 INFO - 2016-01-25 04:29:55,794 DEBUG : BROWSER_OUTPUT: 04:29:55 INFO - 2016-01-25 04:29:55,794 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.10 Median:55.50 stddev:3.11 (5.6%) stddev-sans-first:3.09 04:29:55 INFO - 2016-01-25 04:29:55,794 DEBUG : BROWSER_OUTPUT: Values: 53.0 57.0 55.0 62.0 56.0 54.0 55.0 61.0 53.0 55.0 04:29:55 INFO - 2016-01-25 04:29:55,795 DEBUG : BROWSER_OUTPUT: 04:29:55 INFO - 2016-01-25 04:29:55,795 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:62.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 04:29:55 INFO - 2016-01-25 04:29:55,796 DEBUG : BROWSER_OUTPUT: Values: 63.0 62.0 62.0 64.0 64.0 62.0 62.0 63.0 62.0 62.0 04:29:55 INFO - 2016-01-25 04:29:55,796 DEBUG : BROWSER_OUTPUT: 04:29:55 INFO - 2016-01-25 04:29:55,796 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:78.50 stddev:3.46 (4.4%) stddev-sans-first:3.57 04:29:55 INFO - 2016-01-25 04:29:55,796 DEBUG : BROWSER_OUTPUT: Values: 77.0 77.0 79.0 78.0 78.0 79.0 86.0 76.0 77.0 85.0 04:29:55 INFO - 2016-01-25 04:29:55,796 DEBUG : BROWSER_OUTPUT: 04:29:55 INFO - 2016-01-25 04:29:55,796 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:109.10 Median:109.50 stddev:2.77 (2.5%) stddev-sans-first:2.70 04:29:55 INFO - 2016-01-25 04:29:55,796 DEBUG : BROWSER_OUTPUT: Values: 106.0 107.0 106.0 107.0 114.0 113.0 110.0 109.0 110.0 109.0 04:29:55 INFO - 2016-01-25 04:29:55,796 DEBUG : BROWSER_OUTPUT: 04:29:55 INFO - 2016-01-25 04:29:55,796 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.20 Median:138.00 stddev:4.16 (3.0%) stddev-sans-first:4.36 04:29:55 INFO - 2016-01-25 04:29:55,796 DEBUG : BROWSER_OUTPUT: Values: 139.0 147.0 137.0 139.0 139.0 136.0 134.0 134.0 134.0 133.0 04:29:55 INFO - 2016-01-25 04:29:55,796 DEBUG : BROWSER_OUTPUT: 04:29:55 INFO - 2016-01-25 04:29:55,796 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:62.50 stddev:3.03 (4.9%) stddev-sans-first:3.19 04:29:55 INFO - 2016-01-25 04:29:55,797 DEBUG : BROWSER_OUTPUT: Values: 62.0 71.0 62.0 61.0 62.0 61.0 61.0 63.0 65.0 63.0 04:29:55 INFO - 2016-01-25 04:29:55,797 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:29:55 INFO - 2016-01-25 04:29:55,797 DEBUG : BROWSER_OUTPUT: 04:29:56 INFO - 2016-01-25 04:29:56,431 INFO : Browser exited with error code: 0 04:29:56 INFO - 2016-01-25 04:29:56,479 INFO : Completed test kraken (00:00:57) 04:29:56 INFO - 2016-01-25 04:29:56,479 INFO : Starting test v8_7 04:29:56 INFO - 2016-01-25 04:29:56,479 DEBUG : operating with platform_type : linux_ 04:29:56 INFO - 2016-01-25 04:29:56,479 INFO : Initialising browser for v8_7 test... 04:29:56 INFO - 2016-01-25 04:29:56,485 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOVV1Om/profile http://localhost:44402/getInfo.html 04:30:00 INFO - 2016-01-25 04:30:00,047 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:30:00 INFO - 2016-01-25 04:30:00,047 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:30:00 INFO - 2016-01-25 04:30:00,047 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:30:00 INFO - 2016-01-25 04:30:00,047 DEBUG : BROWSER_OUTPUT: __metrics 04:30:00 INFO - 2016-01-25 04:30:00,129 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:30:01 INFO - 2016-01-25 04:30:01,594 INFO : Browser initialized. 04:30:01 INFO - 2016-01-25 04:30:01,595 INFO : Running cycle 1/1 for v8_7 test... 04:30:01 INFO - 2016-01-25 04:30:01,595 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOVV1Om/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:30:13 INFO - 2016-01-25 04:30:13,133 DEBUG : BROWSER_OUTPUT: RSS: Main: 128512000 04:30:13 INFO - 2016-01-25 04:30:13,133 DEBUG : BROWSER_OUTPUT: 04:30:34 INFO - 2016-01-25 04:30:34,536 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44402/tests/v8_7/run.html (next: http://localhost:44402/tests/v8_7/run.html) 04:30:34 INFO - 2016-01-25 04:30:34,782 DEBUG : BROWSER_OUTPUT: RSS: Main: 425988096 04:30:34 INFO - 2016-01-25 04:30:34,782 DEBUG : BROWSER_OUTPUT: 04:30:34 INFO - 2016-01-25 04:30:34,783 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:30:34 INFO - 2016-01-25 04:30:34,783 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:30:34 INFO - 2016-01-25 04:30:34,783 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:30:34 INFO - 2016-01-25 04:30:34,783 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:30:34 INFO - 2016-01-25 04:30:34,783 DEBUG : BROWSER_OUTPUT: |0;Richards;163.826998689384 04:30:34 INFO - 2016-01-25 04:30:34,784 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.63615409944023 04:30:34 INFO - 2016-01-25 04:30:34,784 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.4076557697681 04:30:34 INFO - 2016-01-25 04:30:34,784 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4995.024875621891 04:30:34 INFO - 2016-01-25 04:30:34,785 DEBUG : BROWSER_OUTPUT: |4;RayTrace;956.9377990430622 04:30:34 INFO - 2016-01-25 04:30:34,785 DEBUG : BROWSER_OUTPUT: |5;Earley;551.5719801434087 04:30:34 INFO - 2016-01-25 04:30:34,785 DEBUG : BROWSER_OUTPUT: |6;Boyer;10447.916666666666 04:30:34 INFO - 2016-01-25 04:30:34,786 DEBUG : BROWSER_OUTPUT: |7;RegExp;23418.60465116279 04:30:34 INFO - 2016-01-25 04:30:34,786 DEBUG : BROWSER_OUTPUT: |8;Splay;535.6186395286556 04:30:34 INFO - 2016-01-25 04:30:34,786 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4817.307692307692 04:30:34 INFO - 2016-01-25 04:30:34,786 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:30:34 INFO - 2016-01-25 04:30:34,786 DEBUG : BROWSER_OUTPUT: __startTimestamp1453725034782__endTimestamp 04:30:34 INFO - 2016-01-25 04:30:34,786 DEBUG : BROWSER_OUTPUT: 04:30:34 INFO - 2016-01-25 04:30:34,786 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:30:34 INFO - 2016-01-25 04:30:34,787 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:30:34 INFO - 2016-01-25 04:30:34,787 DEBUG : BROWSER_OUTPUT: 04:30:34 INFO - 2016-01-25 04:30:34,787 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.83 Median:163.83 stddev:0.00 (0.0%) 04:30:34 INFO - 2016-01-25 04:30:34,787 DEBUG : BROWSER_OUTPUT: Values: 163.8 04:30:34 INFO - 2016-01-25 04:30:34,787 DEBUG : BROWSER_OUTPUT: 04:30:34 INFO - 2016-01-25 04:30:34,787 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.64 Median:164.64 stddev:0.00 (0.0%) 04:30:34 INFO - 2016-01-25 04:30:34,787 DEBUG : BROWSER_OUTPUT: Values: 164.6 04:30:34 INFO - 2016-01-25 04:30:34,787 DEBUG : BROWSER_OUTPUT: 04:30:34 INFO - 2016-01-25 04:30:34,788 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 04:30:34 INFO - 2016-01-25 04:30:34,788 DEBUG : BROWSER_OUTPUT: Values: 279.4 04:30:34 INFO - 2016-01-25 04:30:34,788 DEBUG : BROWSER_OUTPUT: 04:30:34 INFO - 2016-01-25 04:30:34,788 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4995.02 Median:4995.02 stddev:0.00 (0.0%) 04:30:34 INFO - 2016-01-25 04:30:34,788 DEBUG : BROWSER_OUTPUT: Values: 4995.0 04:30:34 INFO - 2016-01-25 04:30:34,788 DEBUG : BROWSER_OUTPUT: 04:30:34 INFO - 2016-01-25 04:30:34,788 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:956.94 Median:956.94 stddev:0.00 (0.0%) 04:30:34 INFO - 2016-01-25 04:30:34,789 DEBUG : BROWSER_OUTPUT: Values: 956.9 04:30:34 INFO - 2016-01-25 04:30:34,789 DEBUG : BROWSER_OUTPUT: 04:30:34 INFO - 2016-01-25 04:30:34,789 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:551.57 Median:551.57 stddev:0.00 (0.0%) 04:30:34 INFO - 2016-01-25 04:30:34,789 DEBUG : BROWSER_OUTPUT: Values: 551.6 04:30:34 INFO - 2016-01-25 04:30:34,789 DEBUG : BROWSER_OUTPUT: 04:30:34 INFO - 2016-01-25 04:30:34,789 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10447.92 Median:10447.92 stddev:0.00 (0.0%) 04:30:34 INFO - 2016-01-25 04:30:34,789 DEBUG : BROWSER_OUTPUT: Values: 10447.9 04:30:34 INFO - 2016-01-25 04:30:34,789 DEBUG : BROWSER_OUTPUT: 04:30:34 INFO - 2016-01-25 04:30:34,790 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23418.60 Median:23418.60 stddev:0.00 (0.0%) 04:30:34 INFO - 2016-01-25 04:30:34,790 DEBUG : BROWSER_OUTPUT: Values: 23418.6 04:30:34 INFO - 2016-01-25 04:30:34,790 DEBUG : BROWSER_OUTPUT: 04:30:34 INFO - 2016-01-25 04:30:34,790 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:535.62 Median:535.62 stddev:0.00 (0.0%) 04:30:34 INFO - 2016-01-25 04:30:34,790 DEBUG : BROWSER_OUTPUT: Values: 535.6 04:30:34 INFO - 2016-01-25 04:30:34,790 DEBUG : BROWSER_OUTPUT: 04:30:34 INFO - 2016-01-25 04:30:34,790 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 04:30:34 INFO - 2016-01-25 04:30:34,790 DEBUG : BROWSER_OUTPUT: Values: 4817.3 04:30:34 INFO - 2016-01-25 04:30:34,790 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:30:34 INFO - 2016-01-25 04:30:34,790 DEBUG : BROWSER_OUTPUT: 04:30:35 INFO - 2016-01-25 04:30:35,491 INFO : Browser exited with error code: 0 04:30:35 INFO - 2016-01-25 04:30:35,505 INFO : Completed test v8_7 (00:00:39) 04:30:35 INFO - 2016-01-25 04:30:35,819 INFO : Completed test suite (00:20:05) 04:30:35 INFO - 2016-01-25 04:30:35,819 DEBUG : Working with test: dromaeo_css 04:30:35 INFO - 2016-01-25 04:30:35,819 DEBUG : Generating results file: dromaeo_css 04:30:35 INFO - 2016-01-25 04:30:35,820 DEBUG : Working with test: kraken 04:30:35 INFO - 2016-01-25 04:30:35,820 DEBUG : Generating results file: kraken 04:30:35 INFO - 2016-01-25 04:30:35,821 INFO : javascript benchmark 04:30:35 INFO - 2016-01-25 04:30:35,821 DEBUG : Working with test: v8_7 04:30:35 INFO - 2016-01-25 04:30:35,821 DEBUG : Generating results file: v8_7 04:30:35 INFO - 2016-01-25 04:30:35,821 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:30:35 INFO - 2016-01-25 04:30:35,969 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 04:30:35 INFO - 2016-01-25 04:30:35,969 DEBUG : process_Request line: dromaeo_css 7244.58 graph.html#tests=[[72,53,35]] 04:30:35 INFO - 2016-01-25 04:30:35,969 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:30:35 INFO - 2016-01-25 04:30:35,999 DEBUG : process_Request line: kraken 1456.60 graph.html#tests=[[232,53,35]] 04:30:35 INFO - 2016-01-25 04:30:35,999 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:30:36 INFO - 2016-01-25 04:30:36,035 DEBUG : process_Request line: v8_7 23415.03 graph.html#tests=[[230,53,35]] 04:30:36 INFO - 2016-01-25 04:30:36,037 INFO : javascript benchmark 04:30:36 INFO - 2016-01-25 04:30:36,040 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3342.1644588852787, 3386.1873150443903, 3410.931781364373, 3423.6062852771925, 3437.2094418283796, 5617.550595952324, 5637.859053523659, 5649.8305050848485, 5657.038303488406, 5665.461781130791, 5688.402717714643, 5710.400407957167, 5718.027935251007, 5720.8855822883515, 5728.742206600703, 5018.974905125488, 5123.615728820344, 5186.636935414523, 5240.213967904807, 5266.289050978126, 5207.062728708831, 5222.63441559091, 5231.032259032072, 5231.084560201968, 5238.319018527586, 5010.273510340999, 5031.0, 5117.437081920985, 5144.974275128638, 5241.528262456378, 5178.378594568657, 5243.05624987504, 5253.579713622901, 5253.842384728464, 5274.894502109974, 4963.205887058053, 5163.1480805667015, 5179.93811268689, 5211.400688920785, 5217.739113044333, 5337.572994160458, 5410.188471729232, 5420.051490989061, 5424.294841670558, 5427.0773968425465, 6004.249468816398, 6049.062395328731, 6055.2430946131735, 6058.757649694007, 6088.573799834014, 5992.700364981777, 6122.540809439265, 6151.138840562325, 6152.87694246117, 6153.600015998945, 5666.46168613981, 5762.135679648002, 5763.423657634287, 5764.8847023059725, 5788.479036886658, 6217.6891155442045, 6232.0, 6241.375862413813, 6242.812715618538, 6246.781362652286, 5888.116782482576, 5984.581079324493, 5987.371326010793, 6057.061155520902, 6059.818205453844, 6078.6048906820915, 6082.939170608326, 6089.543284253698, 6091.664958427329, 6102.664353460514, 6019.939800602026, 6042.637441753509, 6044.153818465418, 6044.516438684895, 6050.45545900871, 5852.356240813507, 5930.911036334458, 5944.375840536682, 6034.125051867454, 6039.818805435844, 4623.260278355447, 4668.299755036704, 4674.0, 4674.859754207379, 4678.017616300547, 4177.91644167121, 4178.979105104516, 4179.164167166578, 4195.97902010488, 4203.894902627459, 5531.170324451365, 5613.46672066153, 5626.2967129108865, 5750.654960702372, 5765.135229715576, 6069.393060693896, 6074.091773443687, 6098.451139397475, 6127.632342059491, 6136.8772624547255, 5743.93737158627, 5744.023516002289, 5754.88490230193, 5757.942420575824, 5771.797987070517, 5176.9741151294, 5259.05337039329, 5285.7621407036, 5310.2831117798605, 5399.5950303726595, 6303.3066362700065, 6329.2721337045905, 6335.778247761306, 6338.556301058881, 6362.045693145972, 6177.6911154441195, 6195.752169913333, 6204.751809927552, 6212.347703491249, 6215.129881816459, 6029.487493563096, 6090.512758979359, 6130.141780150871, 6217.782377616762, 6218.129461875251, 6021.397860213943, 6032.366601506954, 6061.936307765941, 6070.18052562916, 6091.360407157184, 5931.525477961839, 6155.692215389302, 6158.107074474266, 6160.137580738789, 6174.44430001302, 5835.854103647443, 5883.499902508334, 5958.463738263577, 5969.253843269591, 5970.104484327212, 5917.201177840936, 5981.671008094597, 6005.489533389711, 6020.759169633341, 6031.0, 5688.54491640676, 5784.797532086357, 5920.37836027211, 5939.821805345847, 5951.285845698544, 5797.826065218051, 5862.589618726648, 5871.500922421642, 5876.3536011039605, 5923.022701254245, 5849.970750146222, 5860.0037993542055, 5865.237519122657, 5868.061110222344, 5870.119482077723], "unit": "ms", "name": "dojo.html", "value": 5604.501982917099}, {"lowerIsBetter": false, "replicates": [590.6338070396355, 617.7961272779985, 629.0564153769346, 632.3676323676324, 643.9034144878268, 36528.08679783004, 45661.08677826441, 45713.54286457135, 45849.08301833961, 46103.30845037327, 48907.51092489074, 49222.50777492224, 49464.0, 49514.50485495144, 49526.0, 8274.751757447257, 8338.24955753982, 9128.452292862434, 9261.44431334122, 9322.06779322069, 11009.669709908716, 11153.665390038312, 11174.1060715143, 11175.776484470347, 11187.832182517268, 10747.462626868664, 10750.78498430031, 10777.5688972441, 10850.72873178173, 10852.07757340627, 10721.731956701067, 10849.620263290746, 10863.945680271627, 10868.565257389695, 10884.292520986111, 10648.520816563274, 10769.4615269237, 10782.622608208754, 10800.837987430195, 10805.891941080567, 43571.0, 44136.0, 44215.33676994847, 44220.778896105636, 44222.55777442217, 3615.258871931248, 3685.4103343464917, 3695.2794205130012, 3759.2105657811894, 4118.423420721101, 32723.345533089207, 32828.507572386436, 33049.0, 33106.83446582752, 33829.66170338314, 3466.618671946084, 3542.6988705960025, 3574.285142971416, 3581.3553560359123, 3678.503402040744, 331160.0, 331396.0, 333160.0, 335190.0, 335332.0, 60754.0, 62522.68738656369, 76076.61961690156, 76743.2325676736, 77324.0, 73203.63398183082, 73428.0, 73434.0, 73492.0, 73679.52640947151, 17936.0, 18232.90883545574, 18318.450446486626, 18335.991520466236, 18382.908085459487, 14681.339339729739, 14755.336009879582, 14774.630634234016, 14791.556253312203, 14846.0, 23198.768012319662, 23307.88346058293, 23340.883295583415, 23345.599264044213, 23430.17994370223, 8533.701320453878, 8702.173293537104, 8767.167119123673, 8800.735977920673, 8866.86699699505, 939.628846605587, 977.9168770654431, 993.5677980078689, 1132.2696860524916, 1187.5071845184152, 30964.69035309663, 31486.97330971477, 31496.212594685316, 31496.527552086736, 32686.509702354484, 1131.4060118437885, 1138.8405623212757, 1151.3379806611233, 1216.4404373987888, 1290.8386451693539, 14858.702825943421, 16821.831781682027, 17611.295548177928, 17846.929184248987, 17999.19003644839, 479767.0, 481039.0, 484425.0, 484973.0, 485971.0, 61842.69078654668, 62379.0, 62396.37603623905, 62410.0, 62499.0, 1403.6420712718395, 1423.8504956979368, 1474.2997076388845, 1507.17105591924, 1514.3034204266162, 31445.842770786, 31847.68152318447, 32538.0, 35133.297334053685, 36236.81881590575, 57036.42963570311, 57720.0, 57731.134032988695, 57732.134017990604, 57798.42201578098, 358184.0, 358843.0, 360974.0, 361247.0, 361430.0, 46087.308690370344, 47495.287570685774, 47790.0, 48051.0, 48132.7593362031, 51029.234561480866, 51056.74471627618, 51175.74412127915, 51955.48044519506, 52264.21603676024, 42678.78660606677, 43466.565334346255, 43603.0, 44299.557004429545, 44348.801835273654, 43472.78263608662, 43724.0, 44209.0, 44373.33439998338, 44676.55323446854, 42200.78899605482, 42385.78807105945, 42926.14147717091, 43039.0, 43101.78449107734, 37740.0, 38674.06608802758, 38681.0, 38905.80547097247, 39125.0, 28871.0, 28970.651651309436, 29149.125526234246, 29554.408911821214, 29571.112866614036], "unit": "ms", "name": "ext.html", "value": 21772.903979476487}, {"lowerIsBetter": false, "replicates": [381.4145286984476, 386.10231212431086, 386.14276306599356, 386.2911557292369, 387.4459522882279, 12156.574519891805, 15699.136547489883, 17354.21906014229, 18774.812251877476, 18783.2486700532, 18732.719009214874, 18777.81222187778, 18859.62280754384, 19157.329493467732, 19443.902780486078, 5832.941670583304, 5916.704164791765, 5929.110633404981, 5944.554158438113, 5972.193753843219, 4571.7942692578745, 4619.745913974747, 4621.8613441596635, 5886.499647529965, 6477.611343319392, 6400.359964003585, 6544.247411547662, 6605.735770569171, 6610.8677826443445, 6620.735170593171, 6546.509011824132, 6560.442362399202, 6575.276719560845, 6592.571482853623, 6596.208454985408, 4486.775661216926, 4570.085982803419, 5870.11948207768, 5880.029795083806, 5889.057750759858, 14845.777313340308, 14986.400543978229, 15033.248337583187, 15056.247187640574, 15073.924630376778, 2074.6161960037443, 2076.2110398048644, 2096.9580608387746, 2123.50097727034, 2179.204590324536, 10525.368477891274, 10736.838947415796, 10778.407187604678, 10923.0, 10959.0, 1562.453141400512, 1587.547548948544, 1643.0880861122073, 1646.7694522766822, 1657.5524608355797, 67236.66381668109, 68028.0, 68127.0, 68294.65852670754, 68335.31664683389, 7708.460407771402, 7785.571793551409, 7901.486403383762, 7971.641276142472, 7973.122956474783, 9551.713448596414, 9565.0, 9574.234061275081, 9574.617015319309, 9637.277204209713, 6221.96889015552, 6491.772787952399, 6547.312532184147, 6561.507886908501, 6587.934120658828, 6824.18109826824, 6828.283030281848, 6854.108965834509, 6855.760048398282, 6877.6217308048535, 3643.9432564556514, 3674.724395670282, 3679.9264014719556, 3699.4265888786745, 3703.5370578677666, 1225.7977433723336, 1246.0, 1268.315109840694, 1273.5924504158766, 1309.6660351610278, 516.5325380530626, 522.6785526901004, 536.3751229817298, 562.1792183412264, 575.7437940116691, 11441.0, 12821.29482878432, 12898.80651790224, 13312.400941957636, 13516.864831351757, 540.8755986123214, 544.5398638150756, 549.2941570082425, 555.7638003848348, 576.3803910795912, 5898.970505147533, 6939.30606939302, 7283.0, 7307.744228952068, 7364.484486086029, 623888.0, 634280.0, 639754.0, 645490.0, 663154.0, 74013.62993185, 74828.0, 85523.57238213894, 86994.56502717572, 87031.0, 592.6829146406652, 603.6287683074966, 605.0198678141439, 607.1499900139752, 607.4441885674646, 12247.448864800926, 12317.260964342167, 12439.0, 12497.750044999231, 12526.561570344995, 39342.60657393504, 39895.202095957335, 39996.600034000454, 40532.1893562133, 40669.59330406776, 51901.480985189664, 52358.0, 52744.0, 53112.73443632757, 53344.73327633337, 7579.355754760907, 7584.734534291273, 7707.537547747153, 7707.768766937001, 7794.961025194838, 13324.0, 13355.465781368637, 13389.19664820114, 13688.836448901557, 13812.792808108088, 11543.88456115428, 11635.941820290844, 11890.0, 11972.880271197526, 11992.160548761503, 11553.0, 11890.940545297219, 11969.820452693042, 11994.460249288628, 12106.031517478405, 10357.689269321932, 10367.792644146924, 10495.685129446128, 11832.70418239551, 11966.162368634112, 7515.8872616911885, 7528.473006889465, 7599.924000759922, 7613.6573854175585, 7613.695452182073, 11699.2980421175, 11707.648770536898, 11715.355655439032, 11764.70588235301, 11918.52325906954], "unit": "ms", "name": "jquery.html", "value": 7846.323635108176}, {"lowerIsBetter": false, "replicates": [1509.8339182689901, 1518.5444366689997, 1715.459630216481, 1797.330963519174, 1828.7714035745532, 7161.713531458736, 7292.489525733187, 7799.298063174313, 7944.642491087908, 7978.9601051994805, 7866.528008319505, 7954.522728636286, 8120.390970677193, 8126.390520710956, 8131.796705082376, 2311.271949335958, 2342.601757701186, 2345.7888790008897, 2346.0498498108295, 2346.9765302347014, 2132.3389749177804, 2170.5224850532936, 2389.653500242464, 2405.675233843435, 2430.878456077198, 2356.2931120663816, 2358.6697862299293, 2359.1860808021206, 2359.49270906755, 2364.9054037838464, 2416.2751174647624, 2443.169322430382, 2444.144549407702, 2445.58425067738, 2446.204983380391, 2350.670906073151, 2391.3901955001365, 2391.6532102845163, 2400.3399065257017, 2405.410674384769, 8303.294219991309, 8315.750527484186, 8322.29260512851, 8322.66709331626, 8403.747887563382, 4979.526944940261, 5048.671836330626, 5049.444561098313, 5049.823256186052, 5051.444341122474, 3164.936701265962, 3176.8093914365213, 3203.823789691566, 3243.3189030303665, 3248.691374319436, 1012.0790081026304, 1017.7659138398136, 1042.3276986343765, 1044.8641676581997, 1048.4652827058178, 11127.054200392977, 11131.165162612837, 11136.0, 11140.832887506695, 11143.498542565523, 4584.839530616412, 4625.930611040837, 4631.722096674211, 4690.390249267642, 4710.26990816424, 9659.178969787507, 9698.515074246401, 9703.563339649732, 9710.17463515609, 9715.22278217755, 5148.510891465305, 5150.587952963829, 5150.613703972217, 5151.97424012885, 5155.74221288934, 4693.0613877224005, 4700.506446823034, 4704.858854234379, 4706.7411292378565, 4709.293605959134, 3455.7926524408617, 3952.0, 3987.501562304712, 3994.2410941920944, 4024.335984562573, 1165.4172913543227, 1257.4530079415301, 1330.2484096485455, 1333.9333033348294, 1338.953136640213, 1362.8296462942133, 1428.9142651440948, 1434.1968497641353, 1439.5465428390232, 1459.0, 7761.107472640719, 7782.571958542335, 7965.8805117923275, 7976.322012628992, 7977.282044616012, 1141.783061218366, 1192.6899006258436, 1196.347990345264, 1197.6826141072622, 1199.160587588674, 6263.248410190807, 6270.0, 6325.019621958604, 6349.714262858182, 6382.329855365213, 9871.40771553709, 10111.544980475895, 10161.0, 10172.287939844287, 10176.0, 9843.901560984299, 10051.798964020678, 10062.044105809937, 10070.093691567794, 10077.59689612422, 7816.804579885548, 7848.725294614661, 7860.803479912934, 7875.409344299201, 7877.7242796500705, 7485.962570187332, 7511.098668159856, 7517.586532740752, 7564.4704870658525, 7595.5822429766895, 8696.869546956927, 8731.34514911397, 8743.475391476532, 8744.431611945203, 9109.134632209929, 8871.600777965135, 8964.0, 9217.124373184537, 9236.584353703965, 9239.0, 7463.776086717407, 7514.849703006019, 7559.3196612305155, 7577.355924746458, 7582.54504729718, 6890.2420733718245, 7239.312265334996, 8013.0, 8016.959915200387, 8074.071481779671, 7342.412606991321, 7382.630868456663, 7432.554046757212, 7448.664810083451, 7489.925100749141, 7148.857022859618, 7226.277372262732, 7240.275972402717, 7291.161516425679, 7302.087239095114, 7586.468947173866, 7607.239276072349, 7638.350740187147, 7640.083190017233, 7648.0, 6897.206821215625, 6924.584524928319, 6978.057962175244, 6997.090378250795, 7003.649817509002, 7222.205557388788, 7268.67290971897, 7269.636518173965, 7272.272772722686, 7274.16347120088], "unit": "ms", "name": "mootools.html", "value": 4790.245330427697}, {"lowerIsBetter": false, "replicates": [350.95262139611145, 360.2920261685787, 361.4943759242754, 367.26546906187616, 371.44839912729594, 5849.122631605262, 5973.731182096805, 6006.159137720711, 6011.398860113992, 6013.428724271193, 5844.211031510745, 5914.142449344853, 5923.911141332873, 5939.584229103964, 5965.403459654032, 4616.3537104805355, 4629.305604159386, 4629.444466663988, 4629.513901040393, 4636.02643444877, 4629.675922685414, 4633.2123538998285, 4640.837570685027, 4641.373414589021, 4641.791119399635, 4519.864404067883, 4602.194615942197, 4625.537446255381, 4666.626669866419, 4676.69601475903, 4605.148047611203, 4646.9767651161865, 4649.023705021933, 4670.299455081731, 4671.8364857229835, 3946.2304850554156, 4107.527634322061, 4110.506739191316, 4117.835286588533, 4123.587641235882, 5599.496045355938, 5612.522935550483, 5711.62874413166, 5725.513331366838, 5746.310442746897, 5360.812371566976, 5385.461453854622, 5394.973025134888, 5395.29861118056, 5396.595255355864, 6295.496360291166, 6296.779612713533, 6301.7164227609865, 6301.87396252077, 6315.147455093595, 4489.124620698965, 4568.200564901129, 4569.47451043131, 4586.197415452316, 4621.4685311189305, 6541.738330466776, 6600.537962342638, 6602.0, 6604.570702904296, 6605.240397354318, 4695.131400690883, 4728.503507131771, 4729.7398643074275, 4730.668853180245, 4738.0, 4699.412573428322, 4777.880552986203, 4785.904281914342, 4786.545278198635, 4788.994311194619, 5449.209864569615, 5456.61803673739, 5457.645253058538, 5459.044667183306, 5463.836084917459, 6438.6136831790245, 6445.16212892321, 6447.709853056624, 6452.838679032968, 6454.967725161344, 1701.3364787732794, 1728.2136627834304, 1729.4292883348464, 1729.8962062276303, 1731.1776905969564, 1164.3130552973616, 1170.2393444261297, 1179.2393905930626, 1185.4309931233056, 1203.7773011992808, 6206.875862482725, 6210.192674952227, 6214.130021796952, 6216.285127210338, 6216.875662486816, 6600.669966501656, 6606.570572912745, 6607.273199948002, 6609.636469994197, 6614.86770264592, 6093.908591371133, 6201.0, 6202.379762023762, 6213.65824879636, 6215.036669316263, 3616.023673608111, 3647.1611529348397, 3649.233660931234, 3650.5254316938626, 3651.068977410743, 6536.444402225769, 6627.86744265112, 6655.234648015444, 6725.730970761213, 6762.289959554176, 6702.262751097375, 6726.764563240263, 6737.730490780314, 6737.966310168418, 6747.662616869137, 6692.799216023527, 6697.7655782047395, 6705.4635629150525, 6716.126903502513, 6720.966395167993, 6411.102445657705, 6546.574472659262, 6549.7380104795275, 6551.672416379067, 6591.703373348307, 6559.704813283509, 6576.375244351779, 6577.572457790228, 6580.934190658032, 6592.406683398517, 6756.662166891734, 6800.863982720417, 6809.182898052265, 6810.0, 6818.659067046727, 4620.722756634613, 4772.594329482033, 4772.761361931959, 4773.04539092176, 4780.569748722632, 6614.470842332698, 6623.635700036544, 6623.635700036544, 6624.0395142705, 6630.701618427279, 6391.041343798467, 6414.069959855701, 6429.132067170872, 6449.516286278642, 6455.0, 6311.0, 6366.904496432465, 6437.291897891135, 6437.581557198767, 6439.227292724903, 6317.4630156437215, 6327.082573026977, 6327.90508142369, 6331.0, 6331.90502142459, 6404.751073540615, 6449.484041276781, 6464.482841372773, 6466.7736629219635, 6473.158489396348, 6160.876782464416, 6285.654289014148, 6330.556861019684, 6332.0818481320875, 6340.270868849957], "unit": "ms", "name": "prototype.html", "value": 4880.447940779316}, {"lowerIsBetter": false, "replicates": [728.4136270302406, 776.8485145396646, 802.4823988527396, 814.8655471847145, 817.750586071248, 14335.283235838218, 14681.559553213394, 14686.192259425741, 14690.926545367258, 14706.41174353026, 13987.090839095477, 14090.577282681536, 14104.858951410482, 14109.78835317471, 14118.92940535296, 768.4735955870233, 782.2920257167273, 906.315731622624, 922.8108237811233, 923.7736754495124, 912.8402529557334, 913.5295322908707, 914.9817003659923, 921.4609453469728, 921.8617207418873, 808.9635966381527, 816.0330008939396, 965.652365148546, 970.7815741458151, 979.0, 943.6414162618196, 956.8708224389758, 957.248559880494, 958.4872093430016, 958.5542722633938, 713.7751608243439, 715.2775696546473, 719.1011235955057, 719.363363423374, 719.3705507680779, 14027.859721402758, 14068.0, 14143.717125657533, 14205.928970355082, 14213.85786142146, 12256.571020014257, 12690.682732931658, 13037.739245215138, 13101.0, 13137.080404371698, 9264.39781414206, 9509.524523773853, 9512.524373781283, 9517.762055948657, 9534.856977145348, 3339.448990916496, 3373.1567108222944, 3378.7972721636534, 3382.797032178077, 3385.7460690448315, 51509.7424512875, 51620.48379516232, 51686.22470662943, 54507.45492545103, 54557.72721136448, 9341.426916633103, 9459.90540094604, 9496.382735122195, 9544.761380965392, 9587.616495340108, 21158.78841211599, 21496.677549836764, 21505.67741483879, 21539.89230053871, 21543.353699389045, 7011.0, 7091.078159839188, 7162.247963963813, 7246.565206087652, 7302.890456643155, 4133.648639865585, 4147.19129769692, 4234.9364759528635, 4248.0, 4256.3828244904935, 3350.8492117854753, 3389.5932488101585, 3393.0329855990926, 3393.830308484566, 3394.0666316762595, 501.25063030768507, 519.8050730975884, 523.5680563535099, 526.2658591265164, 527.923451099596, 545.2475583694476, 565.5645153231989, 590.3181824992141, 592.3188333416606, 600.7640689641494, 8423.157684231528, 8637.784055398666, 8647.308215342757, 8781.560921953876, 8956.596953137125, 532.8880935003615, 596.1266744219739, 648.5136147889083, 651.7847428961446, 653.7875190563086, 3852.5376954765607, 3875.5155605549307, 3876.8643097491454, 4025.5370632377067, 4028.295048366524, 66413.66793166003, 66521.0, 66886.33113668801, 67404.0, 67668.0, 53656.0, 54018.45981540213, 54469.182962255596, 55123.448765512636, 57254.14118788222, 55192.0, 55517.444825551225, 55585.44414555884, 56095.15857262144, 56724.716376417855, 7868.6065696713795, 8015.599220039091, 8103.959480202797, 8258.06194045498, 8261.09127995932, 40682.59317406788, 40749.1850163001, 41739.58260417357, 41936.58063419327, 42224.78887605542, 52760.208596871846, 54326.728366357915, 54854.725726371114, 54896.45103549073, 54980.900381992935, 8540.658373664985, 8594.226519613265, 8680.869786953075, 8687.261582765535, 8694.30445564366, 11564.47959841826, 12054.397280136134, 12285.1400401971, 12323.075769317516, 12700.936495317465, 10533.841992370273, 10617.787644247226, 10691.465426728788, 10778.407187604756, 11024.889751102386, 11493.942530287295, 11644.0, 11657.708557286136, 11976.820347694966, 12208.877911220774, 10368.326058806153, 10481.318714283547, 10519.105876000625, 10538.104261137889, 10626.149908007186, 9838.803223935338, 9874.0, 9887.4067555944, 9941.204703623549, 10105.5452504636, 8462.449940753831, 8511.659533618586, 8636.913630863612, 8821.382503224713, 8831.823363532822], "unit": "ms", "name": "yui.html", "value": 6458.060319370373}], "name": "dromaeo_css", "value": 7244.579592649151}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 105.0, 109.0, 110.0, 110.0, 100.0, 109.0, 100.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 106.9}, {"lowerIsBetter": true, "replicates": [149.0, 121.0, 145.0, 164.0, 122.0, 153.0, 162.0, 122.0, 163.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.5}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 159.0, 159.0, 158.0, 159.0, 161.0, 159.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 159.9}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 138.0, 72.0, 70.0, 70.0, 71.0, 172.0, 70.0], "unit": "ms", "name": "audio-fft", "value": 87.3}, {"lowerIsBetter": true, "replicates": [90.0, 88.0, 130.0, 88.0, 88.0, 89.0, 141.0, 88.0, 89.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 102.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 144.0, 145.0, 145.0, 145.0, 145.0, 144.0, 145.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [53.0, 57.0, 55.0, 62.0, 56.0, 54.0, 55.0, 61.0, 53.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 56.1}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 62.0, 64.0, 64.0, 62.0, 62.0, 63.0, 62.0, 62.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 62.6}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 79.0, 78.0, 78.0, 79.0, 86.0, 76.0, 77.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 79.2}, {"lowerIsBetter": true, "replicates": [106.0, 107.0, 106.0, 107.0, 114.0, 113.0, 110.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 109.1}, {"lowerIsBetter": true, "replicates": [139.0, 147.0, 137.0, 139.0, 139.0, 136.0, 134.0, 134.0, 134.0, 133.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 137.2}, {"lowerIsBetter": true, "replicates": [62.0, 71.0, 62.0, 61.0, 62.0, 61.0, 61.0, 63.0, 65.0, 63.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.1}], "name": "kraken", "value": 1456.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.826998689384], "unit": "score", "name": "Richards", "value": 215.48340799999997}, {"lowerIsBetter": false, "replicates": [164.63615409944023], "unit": "score", "name": "DeltaBlue", "value": 401.60073199999994}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [4995.024875621891], "unit": "score", "name": "Decrypt", "value": 53.289224103585696}, {"lowerIsBetter": false, "replicates": [956.9377990430622], "unit": "score", "name": "RayTrace", "value": 773.2885049999996}, {"lowerIsBetter": false, "replicates": [551.5719801434087], "unit": "score", "name": "Earley", "value": 1208.2974190000004}, {"lowerIsBetter": false, "replicates": [10447.916666666666], "unit": "score", "name": "Boyer", "value": 63.78908075772688}, {"lowerIsBetter": false, "replicates": [23418.60465116279], "unit": "score", "name": "RegExp", "value": 38.90005461767626}, {"lowerIsBetter": false, "replicates": [535.6186395286556], "unit": "score", "name": "Splay", "value": 152.14369699999995}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 23415.025785104386}]} 04:30:36 INFO - RETURN: dromaeo_css: 7244.58 04:30:36 INFO - RETURN: kraken: 1456.60 04:30:36 INFO - RETURN: v8_7: 23415.03 04:30:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23415.03"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1456.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7244.58"}}} 04:30:36 INFO - Return code: 0 04:30:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:30:36 INFO - # TBPL SUCCESS # 04:30:36 INFO - Running post-action listener: _resource_record_post_action 04:30:36 INFO - Running post-run listener: _resource_record_post_run 04:30:37 INFO - Total resource usage - Wall time: 1221s; CPU: 13.0%; Read bytes: 323584; Write bytes: 359972864; Read time: 76; Write time: 371904 04:30:37 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 103071744; Read time: 0; Write time: 140564 04:30:37 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 323584; Write bytes: 256036864; Read time: 76; Write time: 231292 04:30:37 INFO - Running post-run listener: _upload_blobber_files 04:30:37 INFO - Blob upload gear active. 04:30:37 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:30:37 INFO - Copying logs to upload dir... 04:30:37 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1313.117857 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2016-01-25 04:30:37.068314) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 04:30:37.071727) ========= 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=920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290 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.010026 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.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 04:30:37.123911) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:30:37.124330) ========= 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=920470bf432669ad7e3a5387000001ca-1453723720.682184-2063027290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:30:37.175026) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 04:30:37.175474) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 04:30:37.175887) ========= ========= Total master_lag: 1.27 =========